builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1451357252.19 results: success (0) buildid: 20151228163003 builduid: 65497281186242a0af008984bb17a210 revision: f4234af54e19616c56ab60a323ab9e845e2dd96c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.192160) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.192632) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.192930) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006330 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.218481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.218790) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.234370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.234768) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.284670) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.284968) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.285334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.285605) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 18:47:33-- 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% 225M=0s 2015-12-28 18:47:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164018 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.462179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.462500) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022413 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.512572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:32.512924) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f4234af54e19616c56ab60a323ab9e845e2dd96c --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/mozilla-inbound --rev f4234af54e19616c56ab60a323ab9e845e2dd96c --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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 18:47:33,320 truncating revision to first 12 chars 2015-12-28 18:47:33,320 Setting DEBUG logging. 2015-12-28 18:47:33,321 attempt 1/10 2015-12-28 18:47:33,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f4234af54e19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 18:47:33,579 unpacking tar archive at: mozilla-inbound-f4234af54e19/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:33.084573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:33.084878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:33.092225) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:33.092604) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 18:47:33.093051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-28 18:47:33.093348) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:47:33 INFO - MultiFileLogger online at 20151228 18:47:33 in /builds/slave/test-pgo 18:47:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:47:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:47:33 INFO - {'append_to_log': False, 18:47:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:47:33 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:47:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:47:33 INFO - 'branch': 'Mozilla-Inbound', 18:47:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:47:33 INFO - 'config_files': ('talos/linux_config.py',), 18:47:33 INFO - 'default_actions': ('clobber', 18:47:33 INFO - 'read-buildbot-config', 18:47:33 INFO - 'download-and-extract', 18:47:33 INFO - 'populate-webroot', 18:47:33 INFO - 'create-virtualenv', 18:47:33 INFO - 'install', 18:47:33 INFO - 'run-tests'), 18:47:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:47:33 INFO - 'download_minidump_stackwalk': True, 18:47:33 INFO - 'download_symbols': 'ondemand', 18:47:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:47:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:47:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:47:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:47:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:47:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:47:33 INFO - 'installer_path': 'installer.exe', 18:47:33 INFO - 'log_level': 'info', 18:47:33 INFO - 'log_name': 'talos', 18:47:33 INFO - 'log_to_console': True, 18:47:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:47:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:47:33 INFO - 'opt_config_files': (), 18:47:33 INFO - 'pip_index': False, 18:47:33 INFO - 'sps_profile': False, 18:47:33 INFO - 'sps_profile_interval': 0, 18:47:33 INFO - 'suite': 'dromaeojs', 18:47:33 INFO - 'system_bits': '32', 18:47:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:47:33 INFO - 'title': 'talos-linux64-ix-044', 18:47:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:47:33 INFO - 'use_talos_json': True, 18:47:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:47:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:47:33 INFO - 'work_dir': 'build'} 18:47:33 INFO - ##### 18:47:33 INFO - ##### Running clobber step. 18:47:33 INFO - ##### 18:47:33 INFO - Running pre-action listener: _resource_record_pre_action 18:47:33 INFO - Running main action method: clobber 18:47:33 INFO - rmtree: /builds/slave/test-pgo/build 18:47:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:47:34 INFO - Running post-action listener: _resource_record_post_action 18:47:34 INFO - ##### 18:47:34 INFO - ##### Running read-buildbot-config step. 18:47:34 INFO - ##### 18:47:34 INFO - Running pre-action listener: _resource_record_pre_action 18:47:34 INFO - Running main action method: read_buildbot_config 18:47:34 INFO - Using buildbot properties: 18:47:34 INFO - { 18:47:34 INFO - "project": "", 18:47:34 INFO - "product": "firefox", 18:47:34 INFO - "script_repo_revision": "production", 18:47:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:47:34 INFO - "repository": "", 18:47:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:47:34 INFO - "buildid": "20151228163003", 18:47:34 INFO - "pgo_build": "True", 18:47:34 INFO - "basedir": "/builds/slave/test-pgo", 18:47:34 INFO - "buildnumber": 580, 18:47:34 INFO - "slavename": "talos-linux64-ix-044", 18:47:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:47:34 INFO - "platform": "ubuntu64_hw", 18:47:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:47:34 INFO - "branch": "mozilla-inbound", 18:47:34 INFO - "repo_path": "integration/mozilla-inbound", 18:47:34 INFO - "revision": "f4234af54e19616c56ab60a323ab9e845e2dd96c", 18:47:34 INFO - "stage_platform": "linux64-pgo", 18:47:34 INFO - "builduid": "65497281186242a0af008984bb17a210", 18:47:34 INFO - "slavebuilddir": "test" 18:47:34 INFO - } 18:47:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:47:34 INFO - Running post-action listener: _resource_record_post_action 18:47:34 INFO - ##### 18:47:34 INFO - ##### Running download-and-extract step. 18:47:34 INFO - ##### 18:47:34 INFO - Running pre-action listener: _resource_record_pre_action 18:47:34 INFO - Running main action method: download_and_extract 18:47:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:47:34 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')]} 18:47:34 INFO - https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/test_packages.json 18:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/test_packages.json 18:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:47:39 INFO - Downloaded 1302 bytes. 18:47:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:47:39 INFO - Using the following test package requirements: 18:47:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:47:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'jsshell-linux-x86_64.zip'], 18:47:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:47:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:47:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:47:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:47:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:47:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:47:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:47:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:39 INFO - https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:47 INFO - Downloaded 23192351 bytes. 18:47:47 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 18:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:47 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 18:47:48 INFO - Return code: 0 18:47:48 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 18:47:48 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')]} 18:47:48 INFO - https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:50 INFO - Downloaded 23192351 bytes. 18:47:50 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 18:47:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:47:50 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 18:47:51 INFO - Return code: 0 18:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:51 INFO - https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:47:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:53 INFO - Downloaded 11132270 bytes. 18:47:53 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 18:47:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:47:53 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 18:47:53 INFO - Return code: 0 18:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:53 INFO - https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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 18:47:56 INFO - Downloaded 54898344 bytes. 18:47:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:56 INFO - mkdir: /builds/slave/test-pgo/properties 18:47:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:47:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:47:56 INFO - Contents: 18:47:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:47:56 INFO - Running post-action listener: _resource_record_post_action 18:47:56 INFO - Running post-action listener: set_extra_try_arguments 18:47:56 INFO - ##### 18:47:56 INFO - ##### Running populate-webroot step. 18:47:56 INFO - ##### 18:47:56 INFO - Running pre-action listener: _resource_record_pre_action 18:47:56 INFO - Running main action method: populate_webroot 18:47:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:47:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:47:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:47:56 INFO - '--tppagecycles', 18:47:56 INFO - '7'], 18:47:56 INFO - 'tests': ['tsvgm']}}, 18:47:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:47:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:47:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:47:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:47:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'tests': ['damp', 'tps']}, 18:47:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['damp', 'tps']}, 18:47:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:47:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:47:56 INFO - 'other': {'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'other_l64': {'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'other_nol64': {'tests': ['a11yr', 18:47:56 INFO - 'ts_paint', 18:47:56 INFO - 'tpaint', 18:47:56 INFO - 'sessionrestore', 18:47:56 INFO - 'sessionrestore_no_auto_restore']}, 18:47:56 INFO - 'svgr': {'tests': ['tsvgx', 18:47:56 INFO - 'tsvgr_opacity', 18:47:56 INFO - 'tart', 18:47:56 INFO - 'tscrollx', 18:47:56 INFO - 'cart']}, 18:47:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['tsvgx', 18:47:56 INFO - 'tsvgr_opacity', 18:47:56 INFO - 'tart', 18:47:56 INFO - 'tscrollx', 18:47:56 INFO - 'cart']}, 18:47:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'tests': ['tp5o']}, 18:47:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'talos_options': ['--e10s'], 18:47:56 INFO - 'tests': ['tp5o']}, 18:47:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'talos_options': ['--xperf_path', 18:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:56 INFO - 'tests': ['tp5n']}, 18:47:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:47:56 INFO - 'talos_options': ['--e10s', 18:47:56 INFO - '--xperf_path', 18:47:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:47:56 INFO - 'tests': ['tp5n']}}, 18:47:56 INFO - 'talos.zip': {'path': '', 18:47:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:47:56 INFO - Running post-action listener: _resource_record_post_action 18:47:56 INFO - ##### 18:47:56 INFO - ##### Running create-virtualenv step. 18:47:56 INFO - ##### 18:47:56 INFO - Running pre-action listener: _resource_record_pre_action 18:47:56 INFO - Running main action method: create_virtualenv 18:47:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:47:56 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 18:47:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:47:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:47:56 INFO - Using real prefix '/usr' 18:47:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:47:56 INFO - Installing distribute.............................................................................................................................................................................................done. 18:47:58 INFO - Installing pip.................done. 18:47:58 INFO - Return code: 0 18:47:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:47: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')]} 18:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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')]} 18:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:47: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:47: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 pip>=1.5 18:47:58 INFO - Using env: {'DISPLAY': ':0', 18:47:58 INFO - 'HOME': '/home/cltbld', 18:47:58 INFO - 'LANG': 'en_US.UTF-8', 18:47:58 INFO - 'LANGUAGE': 'en_US:en', 18:47:58 INFO - 'LOGNAME': 'cltbld', 18:47:58 INFO - 'MAIL': '/var/mail/cltbld', 18:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:58 INFO - 'MOZ_NO_REMOTE': '1', 18:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:58 INFO - 'NO_EM_RESTART': '1', 18:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:58 INFO - 'SHELL': '/bin/bash', 18:47:58 INFO - 'SHLVL': '1', 18:47:58 INFO - 'TERM': 'linux', 18:47:58 INFO - 'TMOUT': '86400', 18:47:58 INFO - 'USER': 'cltbld', 18:47:58 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:58 INFO - '_': '/tools/buildbot/bin/python'} 18:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:59 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 18:47:59 INFO - Cleaning up... 18:47:59 INFO - Return code: 0 18:47:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:47:59 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')]} 18:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:59 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')]} 18:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:59 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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:47:59 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 18:47:59 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 18:47:59 INFO - Using env: {'DISPLAY': ':0', 18:47:59 INFO - 'HOME': '/home/cltbld', 18:47:59 INFO - 'LANG': 'en_US.UTF-8', 18:47:59 INFO - 'LANGUAGE': 'en_US:en', 18:47:59 INFO - 'LOGNAME': 'cltbld', 18:47:59 INFO - 'MAIL': '/var/mail/cltbld', 18:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:59 INFO - 'MOZ_NO_REMOTE': '1', 18:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:59 INFO - 'NO_EM_RESTART': '1', 18:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:59 INFO - 'SHELL': '/bin/bash', 18:47:59 INFO - 'SHLVL': '1', 18:47:59 INFO - 'TERM': 'linux', 18:47:59 INFO - 'TMOUT': '86400', 18:47:59 INFO - 'USER': 'cltbld', 18:47:59 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:59 INFO - '_': '/tools/buildbot/bin/python'} 18:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:59 INFO - Downloading/unpacking psutil>=0.7.1 18:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:48:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:01 INFO - Installing collected packages: psutil 18:48:01 INFO - Running setup.py install for psutil 18:48:01 INFO - building 'psutil._psutil_linux' extension 18:48:01 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 18:48:01 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 18:48:01 INFO - building 'psutil._psutil_posix' extension 18:48:01 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 18:48:01 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 18:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:48:01 INFO - Successfully installed psutil 18:48:01 INFO - Cleaning up... 18:48:01 INFO - Return code: 0 18:48:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48:01 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 18:48:01 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 18:48:01 INFO - Using env: {'DISPLAY': ':0', 18:48:01 INFO - 'HOME': '/home/cltbld', 18:48:01 INFO - 'LANG': 'en_US.UTF-8', 18:48:01 INFO - 'LANGUAGE': 'en_US:en', 18:48:01 INFO - 'LOGNAME': 'cltbld', 18:48:01 INFO - 'MAIL': '/var/mail/cltbld', 18:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:01 INFO - 'MOZ_NO_REMOTE': '1', 18:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:01 INFO - 'NO_EM_RESTART': '1', 18:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:01 INFO - 'SHELL': '/bin/bash', 18:48:01 INFO - 'SHLVL': '1', 18:48:01 INFO - 'TERM': 'linux', 18:48:01 INFO - 'TMOUT': '86400', 18:48:01 INFO - 'USER': 'cltbld', 18:48:01 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:01 INFO - '_': '/tools/buildbot/bin/python'} 18:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:01 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 18:48:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:48:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:48:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:48:03 INFO - Installing collected packages: mozsystemmonitor 18:48:03 INFO - Running setup.py install for mozsystemmonitor 18:48:03 INFO - Successfully installed mozsystemmonitor 18:48:03 INFO - Cleaning up... 18:48:03 INFO - Return code: 0 18:48:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:03 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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48:03 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 18:48:03 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 18:48:03 INFO - Using env: {'DISPLAY': ':0', 18:48:03 INFO - 'HOME': '/home/cltbld', 18:48:03 INFO - 'LANG': 'en_US.UTF-8', 18:48:03 INFO - 'LANGUAGE': 'en_US:en', 18:48:03 INFO - 'LOGNAME': 'cltbld', 18:48:03 INFO - 'MAIL': '/var/mail/cltbld', 18:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:03 INFO - 'MOZ_NO_REMOTE': '1', 18:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:03 INFO - 'NO_EM_RESTART': '1', 18:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:03 INFO - 'SHELL': '/bin/bash', 18:48:03 INFO - 'SHLVL': '1', 18:48:03 INFO - 'TERM': 'linux', 18:48:03 INFO - 'TMOUT': '86400', 18:48:03 INFO - 'USER': 'cltbld', 18:48:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:03 INFO - '_': '/tools/buildbot/bin/python'} 18:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:03 INFO - Downloading/unpacking blobuploader==1.2.4 18:48:03 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 18:48:03 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 18:48:03 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 18:48:03 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 18:48:03 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 18:48:03 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 18:48:05 INFO - Downloading blobuploader-1.2.4.tar.gz 18:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:48:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:48:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 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 18:48:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:48:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:48:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:48:06 INFO - Downloading docopt-0.6.1.tar.gz 18:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:48:06 INFO - Installing collected packages: blobuploader, requests, docopt 18:48:06 INFO - Running setup.py install for blobuploader 18:48:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:48:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:48:06 INFO - Running setup.py install for requests 18:48:06 INFO - Running setup.py install for docopt 18:48:06 INFO - Successfully installed blobuploader requests docopt 18:48:06 INFO - Cleaning up... 18:48:06 INFO - Return code: 0 18:48:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:06 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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48:06 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 18:48:06 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 18:48:06 INFO - Using env: {'DISPLAY': ':0', 18:48:06 INFO - 'HOME': '/home/cltbld', 18:48:06 INFO - 'LANG': 'en_US.UTF-8', 18:48:06 INFO - 'LANGUAGE': 'en_US:en', 18:48:06 INFO - 'LOGNAME': 'cltbld', 18:48:06 INFO - 'MAIL': '/var/mail/cltbld', 18:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:06 INFO - 'MOZ_NO_REMOTE': '1', 18:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:06 INFO - 'NO_EM_RESTART': '1', 18:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:06 INFO - 'SHELL': '/bin/bash', 18:48:06 INFO - 'SHLVL': '1', 18:48:06 INFO - 'TERM': 'linux', 18:48:06 INFO - 'TMOUT': '86400', 18:48:06 INFO - 'USER': 'cltbld', 18:48:06 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:06 INFO - '_': '/tools/buildbot/bin/python'} 18:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:07 INFO - Running setup.py (path:/tmp/pip-PhjgvE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:07 INFO - Running setup.py (path:/tmp/pip-6Gl8J4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:07 INFO - Running setup.py (path:/tmp/pip-kxc4wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:07 INFO - Running setup.py (path:/tmp/pip-X94xOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:07 INFO - Running setup.py (path:/tmp/pip-fCo_0R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:07 INFO - Running setup.py (path:/tmp/pip-q_q8FB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:07 INFO - Running setup.py (path:/tmp/pip-8fDdAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:07 INFO - Running setup.py (path:/tmp/pip-GE7qK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:07 INFO - Running setup.py (path:/tmp/pip-yBhFmY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:07 INFO - Running setup.py (path:/tmp/pip-BfdLel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:07 INFO - Running setup.py (path:/tmp/pip-FBW2RN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:07 INFO - Running setup.py (path:/tmp/pip-mAZwxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:07 INFO - Running setup.py (path:/tmp/pip-IfrLti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:08 INFO - Running setup.py (path:/tmp/pip-DOU22l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:08 INFO - Running setup.py (path:/tmp/pip-y7nrZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:08 INFO - Running setup.py (path:/tmp/pip-nmZ90a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:08 INFO - Running setup.py (path:/tmp/pip-c3s_MW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:48:08 INFO - Running setup.py install for manifestparser 18:48:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:48:08 INFO - Running setup.py install for mozcrash 18:48:08 INFO - Running setup.py install for mozdebug 18:48:08 INFO - Running setup.py install for mozdevice 18:48:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:48:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:48:08 INFO - Running setup.py install for mozfile 18:48:08 INFO - Running setup.py install for mozhttpd 18:48:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:48:08 INFO - Running setup.py install for mozinfo 18:48:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for mozInstall 18:48:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for mozleak 18:48:09 INFO - Running setup.py install for mozlog 18:48:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for moznetwork 18:48:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for mozprocess 18:48:09 INFO - Running setup.py install for mozprofile 18:48:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for mozrunner 18:48:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:48:09 INFO - Running setup.py install for mozscreenshot 18:48:09 INFO - Running setup.py install for moztest 18:48:09 INFO - Running setup.py install for mozversion 18:48:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:48:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:48:10 INFO - Cleaning up... 18:48:10 INFO - Return code: 0 18:48:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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/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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48: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/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 18:48: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/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 18:48:10 INFO - Using env: {'DISPLAY': ':0', 18:48:10 INFO - 'HOME': '/home/cltbld', 18:48:10 INFO - 'LANG': 'en_US.UTF-8', 18:48:10 INFO - 'LANGUAGE': 'en_US:en', 18:48:10 INFO - 'LOGNAME': 'cltbld', 18:48:10 INFO - 'MAIL': '/var/mail/cltbld', 18:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:10 INFO - 'MOZ_NO_REMOTE': '1', 18:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:10 INFO - 'NO_EM_RESTART': '1', 18:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:10 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:10 INFO - 'SHELL': '/bin/bash', 18:48:10 INFO - 'SHLVL': '1', 18:48:10 INFO - 'TERM': 'linux', 18:48:10 INFO - 'TMOUT': '86400', 18:48:10 INFO - 'USER': 'cltbld', 18:48:10 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:10 INFO - '_': '/tools/buildbot/bin/python'} 18:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:10 INFO - Running setup.py (path:/tmp/pip-L8OlB2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:10 INFO - Running setup.py (path:/tmp/pip-eV378I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:10 INFO - Running setup.py (path:/tmp/pip-1x0_SF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:10 INFO - Running setup.py (path:/tmp/pip-3P1jbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:10 INFO - Running setup.py (path:/tmp/pip-5K5pMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:10 INFO - Running setup.py (path:/tmp/pip-DkQifO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:10 INFO - Running setup.py (path:/tmp/pip-JlAgcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:10 INFO - Running setup.py (path:/tmp/pip-sImpy6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:10 INFO - Running setup.py (path:/tmp/pip-xUMCtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:48:10 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)) 18:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:10 INFO - Running setup.py (path:/tmp/pip-lImwF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:11 INFO - Running setup.py (path:/tmp/pip-3nNNUN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:11 INFO - Running setup.py (path:/tmp/pip-AhDagB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:11 INFO - Running setup.py (path:/tmp/pip-Mkxh1K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:11 INFO - Running setup.py (path:/tmp/pip-RZgaRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:11 INFO - Running setup.py (path:/tmp/pip-lInhuK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:11 INFO - Running setup.py (path:/tmp/pip-ycP99_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:48:11 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)) 18:48:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:11 INFO - Running setup.py (path:/tmp/pip-6v_S0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 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)) 18:48:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:13 INFO - Downloading blessings-1.5.1.tar.gz 18:48:13 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 18:48:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:48:13 INFO - Installing collected packages: blessings 18:48:13 INFO - Running setup.py install for blessings 18:48:13 INFO - Successfully installed blessings 18:48:13 INFO - Cleaning up... 18:48:13 INFO - Return code: 0 18:48:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:48:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:13 INFO - Reading from file tmpfile_stdout 18:48:13 INFO - Current package versions: 18:48:13 INFO - argparse == 1.2.1 18:48:13 INFO - blessings == 1.5.1 18:48:13 INFO - blobuploader == 1.2.4 18:48:13 INFO - docopt == 0.6.1 18:48:13 INFO - manifestparser == 1.1 18:48:13 INFO - mozInstall == 1.12 18:48:13 INFO - mozcrash == 0.16 18:48:13 INFO - mozdebug == 0.1 18:48:13 INFO - mozdevice == 0.47 18:48:13 INFO - mozfile == 1.2 18:48:13 INFO - mozhttpd == 0.7 18:48:13 INFO - mozinfo == 0.9 18:48:13 INFO - mozleak == 0.1 18:48:13 INFO - mozlog == 3.1 18:48:13 INFO - moznetwork == 0.27 18:48:13 INFO - mozprocess == 0.22 18:48:13 INFO - mozprofile == 0.28 18:48:13 INFO - mozrunner == 6.11 18:48:13 INFO - mozscreenshot == 0.1 18:48:13 INFO - mozsystemmonitor == 0.0 18:48:13 INFO - moztest == 0.7 18:48:13 INFO - mozversion == 1.4 18:48:13 INFO - psutil == 3.1.1 18:48:13 INFO - requests == 1.2.3 18:48:13 INFO - wsgiref == 0.1.2 18:48:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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', '-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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48:13 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 18:48:13 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 18:48:13 INFO - Using env: {'DISPLAY': ':0', 18:48:13 INFO - 'HOME': '/home/cltbld', 18:48:13 INFO - 'LANG': 'en_US.UTF-8', 18:48:13 INFO - 'LANGUAGE': 'en_US:en', 18:48:13 INFO - 'LOGNAME': 'cltbld', 18:48:13 INFO - 'MAIL': '/var/mail/cltbld', 18:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:13 INFO - 'MOZ_NO_REMOTE': '1', 18:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:13 INFO - 'NO_EM_RESTART': '1', 18:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:13 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:13 INFO - 'SHELL': '/bin/bash', 18:48:13 INFO - 'SHLVL': '1', 18:48:13 INFO - 'TERM': 'linux', 18:48:13 INFO - 'TMOUT': '86400', 18:48:13 INFO - 'USER': 'cltbld', 18:48:13 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:13 INFO - '_': '/tools/buildbot/bin/python'} 18:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 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)) 18:48:13 INFO - Cleaning up... 18:48:13 INFO - Return code: 0 18:48:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:48: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')]} 18:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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')]} 18:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48: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', 'jsonschema'] in /builds/slave/test-pgo/build 18:48: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 jsonschema 18:48:13 INFO - Using env: {'DISPLAY': ':0', 18:48:13 INFO - 'HOME': '/home/cltbld', 18:48:13 INFO - 'LANG': 'en_US.UTF-8', 18:48:13 INFO - 'LANGUAGE': 'en_US:en', 18:48:13 INFO - 'LOGNAME': 'cltbld', 18:48:13 INFO - 'MAIL': '/var/mail/cltbld', 18:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:13 INFO - 'MOZ_NO_REMOTE': '1', 18:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:13 INFO - 'NO_EM_RESTART': '1', 18:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:13 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:13 INFO - 'SHELL': '/bin/bash', 18:48:13 INFO - 'SHLVL': '1', 18:48:13 INFO - 'TERM': 'linux', 18:48:13 INFO - 'TMOUT': '86400', 18:48:13 INFO - 'USER': 'cltbld', 18:48:13 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:13 INFO - '_': '/tools/buildbot/bin/python'} 18:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:14 INFO - Downloading/unpacking jsonschema 18:48:14 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 18:48:14 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 18:48:14 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 18:48:14 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 18:48:14 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 18:48:14 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 18:48:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:48:15 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 18:48:15 INFO - Downloading/unpacking functools32 (from jsonschema) 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48: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 18:48:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:48:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:48:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:48:16 INFO - warning: no files found matching '*.txt' 18:48:16 INFO - no previously-included directories found matching 'build' 18:48:16 INFO - no previously-included directories found matching 'dist' 18:48:16 INFO - no previously-included directories found matching '.git*' 18:48:16 INFO - Installing collected packages: jsonschema, functools32 18:48:16 INFO - Running setup.py install for functools32 18:48:16 INFO - warning: no files found matching '*.txt' 18:48:16 INFO - no previously-included directories found matching 'build' 18:48:16 INFO - no previously-included directories found matching 'dist' 18:48:16 INFO - no previously-included directories found matching '.git*' 18:48:16 INFO - Successfully installed jsonschema functools32 18:48:16 INFO - Cleaning up... 18:48:16 INFO - Return code: 0 18:48:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:48:16 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')]} 18:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:16 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')]} 18:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:48:16 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 0x7f09b6b5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c75230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, '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': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', '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 18:48:16 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 18:48:16 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 18:48:16 INFO - Using env: {'DISPLAY': ':0', 18:48:16 INFO - 'HOME': '/home/cltbld', 18:48:16 INFO - 'LANG': 'en_US.UTF-8', 18:48:16 INFO - 'LANGUAGE': 'en_US:en', 18:48:16 INFO - 'LOGNAME': 'cltbld', 18:48:16 INFO - 'MAIL': '/var/mail/cltbld', 18:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:16 INFO - 'MOZ_NO_REMOTE': '1', 18:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:16 INFO - 'NO_EM_RESTART': '1', 18:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:16 INFO - 'SHELL': '/bin/bash', 18:48:16 INFO - 'SHLVL': '1', 18:48:16 INFO - 'TERM': 'linux', 18:48:16 INFO - 'TMOUT': '86400', 18:48:16 INFO - 'USER': 'cltbld', 18:48:16 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:16 INFO - '_': '/tools/buildbot/bin/python'} 18:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:48:16 INFO - Downloading/unpacking flake8 18:48:16 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 18:48:16 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 18:48:16 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 18:48:16 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 18:48:16 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 18:48:16 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 18:48:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:48:18 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 18:48:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:48:18 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 18:48:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 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 18:48:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:48:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:48:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:18 INFO - no previously-included directories found matching 'docs/_build' 18:48:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:48:18 INFO - Running setup.py install for pep8 18:48:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:48:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:48:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:48:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:48:18 INFO - no previously-included directories found matching 'docs/_build' 18:48:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:48:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:48:18 INFO - Cleaning up... 18:48:19 INFO - Return code: 0 18:48:19 INFO - Running post-action listener: _resource_record_post_action 18:48:19 INFO - Running post-action listener: _start_resource_monitoring 18:48:19 INFO - Starting resource monitoring. 18:48:19 INFO - ##### 18:48:19 INFO - ##### Running install step. 18:48:19 INFO - ##### 18:48:19 INFO - Running pre-action listener: _resource_record_pre_action 18:48:19 INFO - Running main action method: install 18:48:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:48:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:48:19 INFO - Reading from file tmpfile_stdout 18:48:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:48:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:48:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:48:19 INFO - Reading from file tmpfile_stdout 18:48:19 INFO - Output received: 18:48:19 INFO - Usage: mozinstall [options] installer 18:48:19 INFO - Options: 18:48:19 INFO - -h, --help show this help message and exit 18:48:19 INFO - -d DEST, --destination=DEST 18:48:19 INFO - Directory to install application into. [default: 18:48:19 INFO - "/builds/slave/test-pgo"] 18:48:19 INFO - --app=APP Application being installed. [default: firefox] 18:48:19 INFO - mkdir: /builds/slave/test-pgo/build/application 18:48:19 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'] 18:48:19 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 18:48:35 INFO - Reading from file tmpfile_stdout 18:48:35 INFO - Output received: 18:48:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:48:35 INFO - Running post-action listener: _resource_record_post_action 18:48:35 INFO - ##### 18:48:35 INFO - ##### Running run-tests step. 18:48:35 INFO - ##### 18:48:35 INFO - Running pre-action listener: _resource_record_pre_action 18:48:35 INFO - Running main action method: run_tests 18:48:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:48:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:48:35 INFO - Python 2.7.3 18:48:35 INFO - Return code: 0 18:48:35 INFO - grabbing minidump binary from tooltool 18:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:48:35 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 0x2d077f0>, '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 0x2c732d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c73760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:48:35 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 18:48:35 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 18:48:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:48:35 INFO - Return code: 0 18:48:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:48:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:48:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:48:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:48:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:48:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:48:36 INFO - Return code: 0 18:48:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 18:48:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 18:48:36 INFO - Using env: {'DISPLAY': ':0', 18:48:36 INFO - 'HOME': '/home/cltbld', 18:48:36 INFO - 'LANG': 'en_US.UTF-8', 18:48:36 INFO - 'LANGUAGE': 'en_US:en', 18:48:36 INFO - 'LOGNAME': 'cltbld', 18:48:36 INFO - 'MAIL': '/var/mail/cltbld', 18:48:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:48:36 INFO - 'MOZ_NO_REMOTE': '1', 18:48:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:48:36 INFO - 'NO_EM_RESTART': '1', 18:48:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:48:36 INFO - 'PWD': '/builds/slave/test-pgo', 18:48:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:48:36 INFO - 'SHELL': '/bin/bash', 18:48:36 INFO - 'SHLVL': '1', 18:48:36 INFO - 'TERM': 'linux', 18:48:36 INFO - 'TMOUT': '86400', 18:48:36 INFO - 'USER': 'cltbld', 18:48:36 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093', 18:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:48:36 INFO - '_': '/tools/buildbot/bin/python'} 18:48:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 18:48:36 INFO - mozversion application_buildid: 20151228163003 18:48:36 INFO - mozversion application_changeset: f4234af54e19616c56ab60a323ab9e845e2dd96c 18:48:36 INFO - mozversion application_display_name: Nightly 18:48:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:48:36 INFO - mozversion application_name: Firefox 18:48:36 INFO - mozversion application_remotingname: firefox 18:48:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:36 INFO - mozversion application_vendor: Mozilla 18:48:36 INFO - mozversion application_version: 46.0a1 18:48:36 INFO - mozversion platform_buildid: 20151228163003 18:48:36 INFO - mozversion platform_changeset: f4234af54e19616c56ab60a323ab9e845e2dd96c 18:48:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:48:36 INFO - mozversion platform_version: 46.0a1 18:48:36 INFO - using testdate: 1451357316 18:48:36 INFO - actual date: 1451357316 18:48:36 INFO - starting webserver on 'localhost:36218' 18:48:36 INFO - SUITE-START | Running 3 tests 18:48:36 INFO - TEST-START | dromaeo_css 18:48:36 INFO - operating with platform_type : linux_ 18:48:36 INFO - Initialising browser for dromaeo_css test... 18:48:36 INFO - TEST-INFO | started process 1832 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptLKgzL/profile http://localhost:36218/getInfo.html) 18:48:41 INFO - PROCESS | 1832 | __metrics Screen width/height:1600/1200 18:48:41 INFO - PROCESS | 1832 | colorDepth:24 18:48:41 INFO - PROCESS | 1832 | Browser inner width/height: 1024/697 18:48:41 INFO - PROCESS | 1832 | __metrics 18:48:41 INFO - PROCESS | 1832 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:48:41 INFO - PROCESS | 1832 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:48:42 INFO - TEST-INFO | 1832: exit 0 18:48:42 INFO - Browser initialized. 18:48:42 INFO - Running cycle 1/1 for dromaeo_css test... 18:48:42 INFO - TEST-INFO | started process 1927 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptLKgzL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:48:54 INFO - PROCESS | 1927 | RSS: Main: 148914176 18:48:54 INFO - PROCESS | 1927 | 18:49:45 INFO - PROCESS | 1927 | 1451357385686 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] 18:51:54 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36218/tests/dromaeo/cssquery-ext.html) 18:51:55 INFO - PROCESS | 1927 | RSS: Main: 270864384 18:51:55 INFO - PROCESS | 1927 | 18:54:58 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-ext.html (next: http://localhost:36218/tests/dromaeo/cssquery-jquery.html) 18:54:58 INFO - PROCESS | 1927 | RSS: Main: 235020288 18:54:58 INFO - PROCESS | 1927 | 18:58:00 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36218/tests/dromaeo/cssquery-mootools.html) 18:58:01 INFO - PROCESS | 1927 | RSS: Main: 230600704 18:58:01 INFO - PROCESS | 1927 | 19:01:03 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36218/tests/dromaeo/cssquery-prototype.html) 19:01:03 INFO - PROCESS | 1927 | RSS: Main: 213770240 19:01:03 INFO - PROCESS | 1927 | 19:04:06 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36218/tests/dromaeo/cssquery-yui.html) 19:04:06 INFO - PROCESS | 1927 | RSS: Main: 218615808 19:04:06 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | Cycle 1(1): loaded http://localhost:36218/tests/dromaeo/cssquery-yui.html (next: http://localhost:36218/tests/dromaeo/cssquery-dojo.html) 19:07:09 INFO - PROCESS | 1927 | RSS: Main: 261005312 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | __start_tp_report 19:07:09 INFO - PROCESS | 1927 | _x_x_mozilla_page_load 19:07:09 INFO - PROCESS | 1927 | _x_x_mozilla_page_load_details 19:07:09 INFO - PROCESS | 1927 | |i|pagename|runs| 19:07:09 INFO - PROCESS | 1927 | |0;dojo.html;3119.204602826279;3164.8575814088363;3201.2797120647842;3212.7751057425976;3229.111994201595;5065.949340506594;5204.34945631796;5210.723402564639;5240.502152295526;5262.842114736559;5098.184290513518;5186.170212765958;5231.450697676746;5280.049591073605;5291.497307755767;4583.518730533296;4659.068186362724;4767.809287628491;4840.394950631171;4902.779374928136;4728.71627702339;4834.734089625069;4853;4861.854144375674;4961.18140506816;4700.741459219742;4746.477887432379;4757.690750101232;4767.332573439721;4777.761111944406;4787.2101103318255;4812.133815913135;4812.566868981773;4820.903581928342;4830.275458681226;4625.699329543569;4734.905301893943;4761.976190119062;4801.73590452525;4815.422149342101;5074.441811400743;5089.05852417304;5091.872703182413;5101.846944591668;5107.540321371094;5593.133064375028;5597.272354593877;5610.6661360131175;5615.803446879339;5649.4633009864;5546;5642.633228840154;5647.265855438808;5664.348599910981;5666.093425051972;5300.496452837013;5318.30861987943;5323.414424413311;5325.201219817059;5330.706811125387;5766.192733017381;5777.133429985452;5786.594938354275;5788.450097240755;5834.474897259182;5401.108817045222;5501.477359650827;5505.449455054542;5505.476979686923;5544.168374743821;5602.271704678447;5680.715964201773;5695.886082278331;5718.971405142947;5720.942790572124;5595.524380427628;5653.321601407857;5654.97172514143;5656.038473459522;5662.773489060474;5518.365387980353;5632.211490391349;5663.178839068312;5668.291463567054;5669.206311116447;4317.611414972667;4345.956540434619;4349.565043495689;4373.125374925028;4408.184485870061;3893.3575959966856;3897.649211570972;3904.082540602956;3936.1340505088833;3951.9802400988387;5048.722320272347;5152.562032227228;5226.189940559219;5232.9738351308;5276.36683597963;5584.6090773646265;5598.664080155204;5664.886702266014;5685.914711279334;5705.2012718219485;5277.050130976384;5283.630145889751;5284.7093409862055;5290.100682883919;5291.841244762663;4917;4925.605951523869;4927.088488629615;4927.531884470969;4948.134076536592;5683.232763576864;5739.626924249994;5762.971185144047;5793.449622285876;5883.352831188566;5686.800961966312;5693.430656934439;5695.658260504383;5699.116636921284;5700.914486282626;5835.94164058354;5848.912266316093;5855.970720146372;5861.238039054895;5867.530597552271;5444.564434845123;5547.972260138674;5553.139263414178;5553.944460555343;5673.234113394639;5682.431756824284;5703.7433315500075;5712.457316554921;5713.8285851424525;5715.342735585461;5515.117581186991;5554.416786237387;5562.777488900399;5568.91646625309;5571.582131340085;5311.070562651444;5392.029434701792;5478.534324582455;5534.7509362078;5567.693776842312;5462.6995515247045;5492.148716948879;5494.862628434321;5496.890062198813;5501.944980550144;5340.919886201632;5588.748506317144;5590.357108932525;5612.130119831432;5651.067573850269;5375.489328513785;5416.593755468277;5423.972880135574;5433.701146436826;5476.616636835383 19:07:09 INFO - PROCESS | 1927 | |1;ext.html;549.3572520151422;562.6680258647399;568.9914651280229;575.6200907401117;583.8336074218847;29145.12564623062;29667.258318542048;29824.403511929748;29841.253968650795;29854.402911941776;29901.55147672781;30494.390112197743;37741;38179.42730859039;38390.424143637865;8637.09310522394;8770.473771573694;8781.912180878173;8784.341174411913;8788.8681669775;8579.613917373734;8637.309015278763;8698.434601750898;8713.912860871373;8723.432976856484;7632.198619144993;7828.412869034817;7833.255840695125;10351.223658225663;10584.364938103738;10254.333468324572;10354.119899808526;10359.32664376813;10364.32631878933;10381.377117372982;7637.885431718529;10103.848442273298;10251;10267.127294180003;10279.229057820694;29192.12423627273;29633.851830740925;41013.1797364054;41849.58150418488;41855.37216941748;3196.4725820239632;3278.1476816027766;3310.2220978070136;3337.4493208620547;3358.5969683637877;27700.584491232647;28109.29726756827;28317.716822831713;28519.287017824514;28530;3906.7069969752383;3954.960450395488;3969.9007524811823;4070.796460177009;4172.082141928801;264535.5784084836;295735;300001;401949;409812.99999999703;57878.421215787304;58136.70931645399;58175.70912145412;58233.41766582365;58435;62188.68905655533;63015.6849215751;63081.43022837289;63136;63146.68426657837;15546.37814487408;15797.289121989537;15808.76286855675;15831.129287889276;16034.759478607597;11133.443327833576;11168.832467512993;11171.106311495061;11172.776544469065;11179.66461006171;20576.485587860425;20594.27920022792;20855.791442085385;20868.582628347347;20871.478213044797;7955.761327160194;8113.148119447373;8133.511989280662;8158.102608713037;8328.66685332592;921.6037104045191;961.9134277914882;1055.6410820321128;1056.4981633724074;1062.7024433158574;29066.564001539995;29365.559516607267;29510.40979180447;29923.850380747957;30112.397752044835;1013.0882206014498;1039.6984874386494;1077.7251800790905;1092.1481244629201;1126.9294170538021;15397.461088861835;15454.3727566314;15522.456714015181;15569.922150389175;15753.921230394004;344637;349618;351305.1129631352;351360;352041;46472.5352746475;52561.211581826305;52961.2055819163;52992.47007529953;53032.73483632557;1199.5921386728555;1316.7761480548522;1318.8878945289566;1339.9464021439032;1359.6125104345215;27113.86443067772;27188.320291992066;27523.58714619242;27955.44089118247;28001.29996750016;45089.549104509846;46229.76885115553;51846.74076629593;52801.20798187953;52832.471675284294;320157;322585;323164;326024;327154;40037.59962400455;40128;40834.59165408308;40840.79579602083;40926.386104207864;42154.578454216295;43185.56814431815;46305;47416.52583474259;47605.28592071052;39030.41454378243;39161;39515.2096958065;40436;41195;38005.809970949966;38870.04078145444;39574.40638390369;39606.40590391204;39655.80172099121;37484.25031499409;38516.229675406896;38903;39064.60935390723;39078.6092139075;32303.676963230067;35408;35713.36088840135;35991.46012809758;36120;25991.480170396866;26282.342941426617;26330.605040924784;26498.602520961816;26669.866650666623 19:07:09 INFO - PROCESS | 1927 | |2;jquery.html;355.0998219513532;360.7943472220835;361.4036839215294;363.8471841826433;363.8580953428163;13889.513867014632;14024;16255.756163657554;16947.322107115717;17882.642347153065;15774;15961.920190399032;16097.758533621976;16711.498655040366;16713;5383.596230282735;5487.588430867681;5520.365158006821;5523;5528.9723551382185;4081.8163182656854;4182.205380977604;5451.454854514536;5493.807716729915;6016.187814645033;6102;6126.938730612704;6143.293521245047;6152.938470615281;6152.969235153818;5616.494515493605;5789.739461724233;5795.1017592273265;5796.855078623026;6093.6039157454625;5155.690658560498;5156.510131537498;5172.741362931876;5233;5371.221172929903;12896.484140634364;12921.418536165895;13158.60524184276;15707.685846283124;20282.49293767653;637.6811594202899;638.2532437048665;638.3010603389328;2071.8031786980214;2149.9032543535577;9260.861087083698;9356.719298421058;9572.042795720441;12565.93717031418;13166.670833229246;1781.1806568978286;1788.0492927051494;1804.8736588438815;1817.6546456173285;1850.1581780289937;58751;61039.38960610382;61082.08376874306;62333;62566;9692.854607180898;10049.497525123714;10164.136048435817;10195.796084078425;10226.07965283128;13625.931870340783;13631.250281234428;13643.522476713268;13654.59036228895;13656.65858353549;7508.361789247975;7551.056117985252;7566.508176968479;7574.659140338698;7626.6186690665245;7323.926760732431;7325.230850760593;7356.852862942711;7389.261073892568;7397.445191610651;4341.804618792162;4445.666575006888;4448.755318457451;4459;4537.0925814837165;1703.5741064733816;1753.815849335827;1767.5492749348834;1768.3899054826065;1768.823117688221;884.7434244069276;979.8334283171878;998.8002399520125;1030.9432383570672;1066.370841203678;14860.70278594422;15985.760213596805;16114.838851611568;16227.269772860249;17000.319987200623;843.7470356520562;880.3309484791605;892.1078921078921;916.1113719691888;958.9376690515094;8746.606402711894;9002.549872506348;9023.909760902437;9024.503652299056;9203.585838637144;134572.32713836565;134876;135126.32436837754;603886.415533674;606623;75988.62005689937;76430.6178469104;76601.61699191468;77253.22746772572;79353;1087.3747595132672;1142.0977427832086;1152.4929031226234;1161.175565348595;1161.268400907423;14481.420743170576;14800;15027;15183.924080379527;15233.771493427386;33333.333333333685;33796.493052604725;33923.3215335687;34304;35174.12064698403;44922.32616510821;45789.31316030329;46201.30698039465;46329.07341853211;49681.50318496914;9588.137067663665;9601.231901447727;9743.171830394213;9768.853467197856;9788.755281118029;16812.159392030593;16984.824538369572;17239.7414038787;17833.46499605014;17885.10574471297;10869;12688.6827829305;13545.458181672622;13620.591382258548;14104.08323458972;12420.937895310466;13685.931570342484;13793.655158621115;13892.16647001183;13991.16053036821;13851.376688049264;14192.219427931563;14338.928305358824;14410.207438590978;14822.03656762307;9211.124943130391;9231.86152207704;9371.203447707021;9493.857592135986;9693.224542036762;13647.522336718168;14027.579172624837;14051.859481405463;14404.99165058436;14462.27688615586 19:07:09 INFO - PROCESS | 1927 | |3;mootools.html;1247.519704913608;1435.720034593254;1446.1539999100526;1581.6441300707343;1750.3873644224523;6175.938240617593;6628.50286228533;6701.631410272439;6714.798556043326;6721.663916804165;6695.397414232718;6848.178218613761;6853.417459515935;6855.108835851345;6865.073215115958;2066.2768031189075;2099.233779670417;2105.515731381783;2106.5260316428835;2107.146605624717;2142.5286436983915;2178.6187417202004;2184.421128400975;2186.4533866533366;2188.223180770827;2104.6948192512077;2128.733908261467;2149.3659370485743;2149.8495105342554;2152.418846911333;2137.2092325839385;2150.892455377225;2168.349495151448;2168.4904047548894;2168.5879682860286;2138.5936672032262;2171.565686862634;2178.422717979721;2179.1283486605325;2179.52050548879;6783.660816959133;6856.794296171123;6862.073620061277;6872.62200578968;6883.070785443951;4337.696361254713;4375.0593622371025;4387.056782791715;4411.536788637211;4419.248727716264;2919.5474701421313;2943.1023537820956;3022.1084779989956;3040.042386648221;3048.2684155802667;968.9951550242274;1000.0549480740702;1015.8374660054429;1022.371241686365;1030.649579143095;9249.12133347331;9324;9334.953325233399;9336.11306925841;9374.625014999392;3897.142628621699;3927.0378757204667;3946.9210615787524;3977.065389633434;3981.7411868228473;8050.919490805017;8054.154313797084;8059.194080591894;8070.1526339734655;8087.636056377477;4352.9129417412105;4384.0355121873135;4384.956150438518;4389.385486031958;4396.736195828261;3413.5391722117197;3492.4586689063235;3949.466821978996;4034.8991275218355;4040.313146765057;3406.9659303407143;3409.7613167078066;3427.3145370925417;3440.7935523868646;3465.9826700866333;1095.4139535348709;1101.8292164714483;1104.4256986367045;1119.0599896087326;1127.1546340244815;1274.5347947999098;1284.9293288869014;1302.863199364072;1315.414640484975;1316.5721140629335;6389.808305750835;6508.088867558546;6540.247871494839;6576.934230657632;6581.177352830896;1097.1113398147527;1100.5102729285552;1104.2435931387026;1105.7180418993105;1129.7458071933913;5112.565431938327;5147.022065807485;5147.40804807452;5149.819756308586;5158.819441319536;7946.284834364935;7959.283664470226;8107.4324797263625;8249.463784853966;8283.917160828436;8173.550454724928;8335.208155225244;8340.082590914995;8348;8352.624131914079;6515.73937042513;6664.500162487833;6718.932810671929;6728.764493242713;6739.831504212434;6509.446697030806;6598.406143447113;6636.369544893228;6639.435647969976;6647.767328143492;7417.147028091623;7475.813104672427;7557.962210188914;7657.731979380695;7678.769636910902;7670.654820532978;7707.383409327353;7858.724944626911;7866.449348545547;7892.289693927574;5509.146082357241;5604.635698679573;5615.466530679579;6153.107799368977;6215.782447614492;6331.556791024768;6390.488760899024;6429.132067170872;6454.903176452263;6455.806325810233;5901.557383196192;5918.2898052234;5944.821655350346;6034.366391528826;6188.44304012641;5980.910286345796;6030.276366835832;6161.753529858755;6172.351903050115;6239.220097487814;6089.2997305310455;6273.15312432834;6280.27776805655;6280.591761535486;6287.434130928238;5789.334226563999;5811.622244554091;5836.824895253149;5840.853978650568;5859.619124756877;5778.913316300343;5820.621659592113;5840.474357307863;5876.559258055578;5893.882122357614 19:07:09 INFO - PROCESS | 1927 | |4;prototype.html;338.4128536988326;341.1539382331815;342.209496064092;347.6280379993407;349.4129861832121;5982.940170598293;6037.0340745480735;6065.545084118692;6070.423309785563;6095.634261944287;5962.284525856903;5963.522918166547;5970.283565972079;5980.282366116061;5985.880282394361;4537.682362234645;4622.37597924281;4622.58396744293;4625.121226966882;4629.745364004978;4594.2419500782335;4607.378003969455;4608.423947006624;4614.538546145375;4627.676062675597;4557.407537020183;4559.908801823978;4564.224081906067;4569.634429245669;4573.176828170945;4344.956550434503;4411.051623900877;4427.712198707074;4559.338895860098;4566.292224705176;3967.107400834818;3990.201959608061;3999.8200080996426;4000.219957108365;4004.979975100135;5535.806246781343;5552.250446189753;5625.943740562624;5653.208550802891;5658.151277308396;5045.596352291808;5174.456682048369;5176.120059589879;5210.505002024802;5299.788008479656;6195.2255968004;6201.472874805647;6211.596246243979;6229.844253893643;6237.033259844731;4419.160359531678;4420.226460369422;4431.268840641323;4431.933520997188;4433.445819272591;6380.361963803629;6535.052417399451;6541.901871471884;6547.443467305285;6551.344865513458;4568.428946381702;4573.245414506636;4573.931391029138;4574.108048930493;4575.725456472623;4631.722096674143;4631.814727410866;4632.72203667781;4638.489766125724;4638.512956139624;5278.762455689503;5281.762320695578;5283.07546179417;5284.815031473957;5288.65623734456;6159.384061593805;6302.968485157637;6322.71547780351;6389.808305750835;6394.8721025579225;1607.5579215715538;1627.7314243149747;1629.08771088191;1629.136557624461;1630.5108467459715;1082.5074591061048;1087.4073629871739;1091.5197313182175;1104.320842681745;1113.3208742666966;6023.728932198062;6027.186329845503;6033.095035744585;6033.909491357633;6038.154658347747;6560.343965603402;6564.245111812203;6573.605583664996;6576.243731970884;6576.342365763481;5919.378465261172;6004.909926351108;6024.578279520391;6025.3974602540275;6031.4270144336215;3492.895213143559;3553.8045407502836;3562.857485700543;3568.339857126388;3569.8929032129076;6746.763863264762;6779.322067793181;6779.49153813466;6793.252742198354;6793.490488213305;6451.1936007999;6572.309907459648;6614.86770264592;6712.798616041527;6717.193936727624;6810.795676129724;6841.62371069586;6849.760258390932;6859.794206173823;6871.381575658214;6575.80272591823;6582.0785090086465;6583.835404114744;6588.4399826013405;6588.967055164693;6354.968225158845;6477.352264773674;6526.498905251724;6528.053432252202;6532.41208291256;6811.489138314745;6812.0803691503;6821.283765204582;6825.385715285648;6834.863302733818;4538.546145385435;4544.909101817879;4548.840790572314;4550.590446859798;4552.362669226377;6457.096006558992;6623.966880165568;6636.966815166086;6637.6681165940545;6639.6680165992475;6452.451541619015;6455.386738259858;6457.903131453126;6462.4183823456115;6482.611043337415;6442.613443193423;6449.645269510222;6449.96775016122;6461.547691661539;6462.127612772216;6218.751249949952;6314.715837787218;6339.841503962253;6341.968290158519;6357.110004599453;6485.254195767548;6499.285078641251;6499.7400103995315;6507.479401647952;6512.47900167976;6331.6517591531065;6333.809985700436;6341.302456729663;6345.587536810092;6349.238091429058 19:07:09 INFO - PROCESS | 1927 | |5;yui.html;679.1137565477054;700.7267165805333;708.6988030087211;718.253016862463;757.1860250231;15369.385224591017;15626.21868906553;15630.531084067481;15639.765403518943;15650.060996340228;14832.406703731865;14910.403583856632;14921.776173357408;14923.104613723157;14926.104433733983;688.7348370877223;699.8110510162253;829.7386323308153;841.5035129273728;842.3934766967774;832.2883934236231;841.0244116824484;844.2444012608712;845.4758050009003;848.0713618587667;878.6134100995573;886.1271647427279;888.4269646078276;888.8977767556717;889.7642124836923;718.5796309159148;724.5254358395259;872.0538216035609;878.7056336127405;884.0673089890163;640.5100098424709;640.8654182621655;641.8491654461197;644.9613023218621;645.0872016097217;13477.19136851792;13526.661833454144;13585.252811095386;13611.387487562984;13611.863881361158;11560.710982225428;11742.412879355998;11886.40567971598;12042.81935770964;12246.326452045134;9885.703428897144;9941.65204217856;9952.303338766289;10036;10386.117180039706;3566.4293713006055;3586.264815712773;3589.892303230907;3663.816809159558;3679.2825399047197;48199.27701084451;49411.75294123506;49501.752491237676;49577.25634115491;49659;9426.811463770824;9526.714198574055;9668.129868311886;10013.79972400548;10124.038216369581;17643.294268229383;17708.203130859143;17733.556661083578;17793.19930603126;17809.10954452298;6619.371159739817;6636.767713130017;6786.491013174032;6918.308169183142;6951.930480695129;3881.340172170738;3890.3775395936514;3964.108075683006;4029.657479114308;4104.774237416971;3051.3134544727704;3073;3085.7531397488146;3086.120455670123;3087.6449208340878;532.9733513324318;554.4704806909392;566.7761234312505;568.9687067211261;576.826951914424;470.68228945461675;472.58838740358453;545.4736179586718;643.1831573901119;654.1169421281327;8434.451760635538;8602.139786021347;8647.827043459096;8661;8719.956400217958;504.9444561098276;613.6440864298696;630.4767043354005;638.9365563693322;646.0309535696455;3904.6681032112588;4141.958580414218;4280.250956082673;4387.341898715218;4498.212812757754;50352.24471632928;59868.70065649731;60075.69962150161;60135.097973530435;64608.73869414548;48965.265521017216;50208.74895625572;50336.24495632568;50585.494145058816;51193.7440312796;50326.49673503291;50642.74678626583;50744;51046.74476627593;51489.485105149215;8663.46717540562;8809.911900880908;8924.955375223082;9107;9184.357095003286;35755.28489430249;36892.262154756216;36959.6304036967;36999;37062.44406333853;44371;45706;46181.538184617726;47775.5222447785;47829.76085119552;10790.406527640742;10858.619948301772;11184.049355804847;11306.038986686224;11736.76526469483;10116.291859570054;10680.092192163753;10941.12471002302;11105.722356941142;11122.888771112186;10633.096186823897;10742.3017503862;10748.355098694103;10777.13782897382;11107.055900248246;10384.480775961323;10609.9469502652;10736.73158171052;10809.820628468646;10873.184511161537;10710.57157713714;10716.19628527848;10742;11051.778964420828;11192.832107518556;8645.351598630003;8708.346873984603;8981;9053.818923621358;9118.861110973121;9171.908280917105;9236.16874481273;9717.951410242904;9751.902480975099;9778.119969202806 19:07:09 INFO - PROCESS | 1927 | __end_tp_report 19:07:09 INFO - PROCESS | 1927 | __start_cc_report 19:07:09 INFO - PROCESS | 1927 | _x_x_mozilla_cycle_collect,1012 19:07:09 INFO - PROCESS | 1927 | __end_cc_report 19:07:09 INFO - PROCESS | 1927 | __startTimestamp1451358429667__endTimestamp 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | ------- Summary: start ------- 19:07:09 INFO - PROCESS | 1927 | Number of tests: 6 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#0] dojo.html Cycles:165 Average:5236.33 Median:5433.70 stddev:576.31 (10.6%) stddev-sans-first:553.63 19:07:09 INFO - PROCESS | 1927 | Values: 3119.2 3164.9 3201.3 3212.8 3229.1 5065.9 5204.3 5210.7 5240.5 5262.8 5098.2 5186.2 5231.5 5280.0 5291.5 4583.5 4659.1 4767.8 4840.4 4902.8 4728.7 4834.7 4853.0 4861.9 4961.2 4700.7 4746.5 4757.7 4767.3 4777.8 4787.2 4812.1 4812.6 4820.9 4830.3 4625.7 4734.9 4762.0 4801.7 4815.4 5074.4 5089.1 5091.9 5101.8 5107.5 5593.1 5597.3 5610.7 5615.8 5649.5 5546.0 5642.6 5647.3 5664.3 5666.1 5300.5 5318.3 5323.4 5325.2 5330.7 5766.2 5777.1 5786.6 5788.5 5834.5 5401.1 5501.5 5505.4 5505.5 5544.2 5602.3 5680.7 5695.9 5719.0 5720.9 5595.5 5653.3 5655.0 5656.0 5662.8 5518.4 5632.2 5663.2 5668.3 5669.2 4317.6 4346.0 4349.6 4373.1 4408.2 3893.4 3897.6 3904.1 3936.1 3952.0 5048.7 5152.6 5226.2 5233.0 5276.4 5584.6 5598.7 5664.9 5685.9 5705.2 5277.1 5283.6 5284.7 5290.1 5291.8 4917.0 4925.6 4927.1 4927.5 4948.1 5683.2 5739.6 5763.0 5793.4 5883.4 5686.8 5693.4 5695.7 5699.1 5700.9 5835.9 5848.9 5856.0 5861.2 5867.5 5444.6 5548.0 5553.1 5553.9 5673.2 5682.4 5703.7 5712.5 5713.8 5715.3 5515.1 5554.4 5562.8 5568.9 5571.6 5311.1 5392.0 5478.5 5534.8 5567.7 5462.7 5492.1 5494.9 5496.9 5501.9 5340.9 5588.7 5590.4 5612.1 5651.1 5375.5 5416.6 5424.0 5433.7 5476.6 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#1] ext.html Cycles:180 Average:50309.01 Median:351700.50 stddev:88714.71 (25.2%) stddev-sans-first:88884.91 19:07:09 INFO - PROCESS | 1927 | Values: 549.4 562.7 569.0 575.6 583.8 29145.1 29667.3 29824.4 29841.3 29854.4 29901.6 30494.4 37741.0 38179.4 38390.4 8637.1 8770.5 8781.9 8784.3 8788.9 8579.6 8637.3 8698.4 8713.9 8723.4 7632.2 7828.4 7833.3 10351.2 10584.4 10254.3 10354.1 10359.3 10364.3 10381.4 7637.9 10103.8 10251.0 10267.1 10279.2 29192.1 29633.9 41013.2 41849.6 41855.4 3196.5 3278.1 3310.2 3337.4 3358.6 27700.6 28109.3 28317.7 28519.3 28530.0 3906.7 3955.0 3969.9 4070.8 4172.1 264535.6 295735.0 300001.0 401949.0 409813.0 57878.4 58136.7 58175.7 58233.4 58435.0 62188.7 63015.7 63081.4 63136.0 63146.7 15546.4 15797.3 15808.8 15831.1 16034.8 11133.4 11168.8 11171.1 11172.8 11179.7 20576.5 20594.3 20855.8 20868.6 20871.5 7955.8 8113.1 8133.5 8158.1 8328.7 921.6 961.9 1055.6 1056.5 1062.7 29066.6 29365.6 29510.4 29923.9 30112.4 1013.1 1039.7 1077.7 1092.1 1126.9 15397.5 15454.4 15522.5 15569.9 15753.9 344637.0 349618.0 351305.1 351360.0 352041.0 46472.5 52561.2 52961.2 52992.5 53032.7 1199.6 1316.8 1318.9 1339.9 1359.6 27113.9 27188.3 27523.6 27955.4 28001.3 45089.5 46229.8 51846.7 52801.2 52832.5 320157.0 322585.0 323164.0 326024.0 327154.0 40037.6 40128.0 40834.6 40840.8 40926.4 42154.6 43185.6 46305.0 47416.5 47605.3 39030.4 39161.0 39515.2 40436.0 41195.0 38005.8 38870.0 39574.4 39606.4 39655.8 37484.3 38516.2 38903.0 39064.6 39078.6 32303.7 35408.0 35713.4 35991.5 36120.0 25991.5 26282.3 26330.6 26498.6 26669.9 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#2] jquery.html Cycles:180 Average:22504.94 Median:362.63 stddev:65905.54 (18174.5%) stddev-sans-first:66069.44 19:07:09 INFO - PROCESS | 1927 | Values: 355.1 360.8 361.4 363.8 363.9 13889.5 14024.0 16255.8 16947.3 17882.6 15774.0 15961.9 16097.8 16711.5 16713.0 5383.6 5487.6 5520.4 5523.0 5529.0 4081.8 4182.2 5451.5 5493.8 6016.2 6102.0 6126.9 6143.3 6152.9 6153.0 5616.5 5789.7 5795.1 5796.9 6093.6 5155.7 5156.5 5172.7 5233.0 5371.2 12896.5 12921.4 13158.6 15707.7 20282.5 637.7 638.3 638.3 2071.8 2149.9 9260.9 9356.7 9572.0 12565.9 13166.7 1781.2 1788.0 1804.9 1817.7 1850.2 58751.0 61039.4 61082.1 62333.0 62566.0 9692.9 10049.5 10164.1 10195.8 10226.1 13625.9 13631.3 13643.5 13654.6 13656.7 7508.4 7551.1 7566.5 7574.7 7626.6 7323.9 7325.2 7356.9 7389.3 7397.4 4341.8 4445.7 4448.8 4459.0 4537.1 1703.6 1753.8 1767.5 1768.4 1768.8 884.7 979.8 998.8 1030.9 1066.4 14860.7 15985.8 16114.8 16227.3 17000.3 843.7 880.3 892.1 916.1 958.9 8746.6 9002.5 9023.9 9024.5 9203.6 134572.3 134876.0 135126.3 603886.4 606623.0 75988.6 76430.6 76601.6 77253.2 79353.0 1087.4 1142.1 1152.5 1161.2 1161.3 14481.4 14800.0 15027.0 15183.9 15233.8 33333.3 33796.5 33923.3 34304.0 35174.1 44922.3 45789.3 46201.3 46329.1 49681.5 9588.1 9601.2 9743.2 9768.9 9788.8 16812.2 16984.8 17239.7 17833.5 17885.1 10869.0 12688.7 13545.5 13620.6 14104.1 12420.9 13685.9 13793.7 13892.2 13991.2 13851.4 14192.2 14338.9 14410.2 14822.0 9211.1 9231.9 9371.2 9493.9 9693.2 13647.5 14027.6 14051.9 14405.0 14462.3 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#3] mootools.html Cycles:180 Average:4897.40 Median:5828.72 stddev:2425.55 (41.6%) stddev-sans-first:2416.83 19:07:09 INFO - PROCESS | 1927 | Values: 1247.5 1435.7 1446.2 1581.6 1750.4 6175.9 6628.5 6701.6 6714.8 6721.7 6695.4 6848.2 6853.4 6855.1 6865.1 2066.3 2099.2 2105.5 2106.5 2107.1 2142.5 2178.6 2184.4 2186.5 2188.2 2104.7 2128.7 2149.4 2149.8 2152.4 2137.2 2150.9 2168.3 2168.5 2168.6 2138.6 2171.6 2178.4 2179.1 2179.5 6783.7 6856.8 6862.1 6872.6 6883.1 4337.7 4375.1 4387.1 4411.5 4419.2 2919.5 2943.1 3022.1 3040.0 3048.3 969.0 1000.1 1015.8 1022.4 1030.6 9249.1 9324.0 9335.0 9336.1 9374.6 3897.1 3927.0 3946.9 3977.1 3981.7 8050.9 8054.2 8059.2 8070.2 8087.6 4352.9 4384.0 4385.0 4389.4 4396.7 3413.5 3492.5 3949.5 4034.9 4040.3 3407.0 3409.8 3427.3 3440.8 3466.0 1095.4 1101.8 1104.4 1119.1 1127.2 1274.5 1284.9 1302.9 1315.4 1316.6 6389.8 6508.1 6540.2 6576.9 6581.2 1097.1 1100.5 1104.2 1105.7 1129.7 5112.6 5147.0 5147.4 5149.8 5158.8 7946.3 7959.3 8107.4 8249.5 8283.9 8173.6 8335.2 8340.1 8348.0 8352.6 6515.7 6664.5 6718.9 6728.8 6739.8 6509.4 6598.4 6636.4 6639.4 6647.8 7417.1 7475.8 7558.0 7657.7 7678.8 7670.7 7707.4 7858.7 7866.4 7892.3 5509.1 5604.6 5615.5 6153.1 6215.8 6331.6 6390.5 6429.1 6454.9 6455.8 5901.6 5918.3 5944.8 6034.4 6188.4 5980.9 6030.3 6161.8 6172.4 6239.2 6089.3 6273.2 6280.3 6280.6 6287.4 5789.3 5811.6 5836.8 5840.9 5859.6 5778.9 5820.6 5840.5 5876.6 5893.9 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#4] prototype.html Cycles:180 Average:5321.28 Median:6026.29 stddev:1600.82 (26.6%) stddev-sans-first:1561.01 19:07:09 INFO - PROCESS | 1927 | Values: 338.4 341.2 342.2 347.6 349.4 5982.9 6037.0 6065.5 6070.4 6095.6 5962.3 5963.5 5970.3 5980.3 5985.9 4537.7 4622.4 4622.6 4625.1 4629.7 4594.2 4607.4 4608.4 4614.5 4627.7 4557.4 4559.9 4564.2 4569.6 4573.2 4345.0 4411.1 4427.7 4559.3 4566.3 3967.1 3990.2 3999.8 4000.2 4005.0 5535.8 5552.3 5625.9 5653.2 5658.2 5045.6 5174.5 5176.1 5210.5 5299.8 6195.2 6201.5 6211.6 6229.8 6237.0 4419.2 4420.2 4431.3 4431.9 4433.4 6380.4 6535.1 6541.9 6547.4 6551.3 4568.4 4573.2 4573.9 4574.1 4575.7 4631.7 4631.8 4632.7 4638.5 4638.5 5278.8 5281.8 5283.1 5284.8 5288.7 6159.4 6303.0 6322.7 6389.8 6394.9 1607.6 1627.7 1629.1 1629.1 1630.5 1082.5 1087.4 1091.5 1104.3 1113.3 6023.7 6027.2 6033.1 6033.9 6038.2 6560.3 6564.2 6573.6 6576.2 6576.3 5919.4 6004.9 6024.6 6025.4 6031.4 3492.9 3553.8 3562.9 3568.3 3569.9 6746.8 6779.3 6779.5 6793.3 6793.5 6451.2 6572.3 6614.9 6712.8 6717.2 6810.8 6841.6 6849.8 6859.8 6871.4 6575.8 6582.1 6583.8 6588.4 6589.0 6355.0 6477.4 6526.5 6528.1 6532.4 6811.5 6812.1 6821.3 6825.4 6834.9 4538.5 4544.9 4548.8 4550.6 4552.4 6457.1 6624.0 6637.0 6637.7 6639.7 6452.5 6455.4 6457.9 6462.4 6482.6 6442.6 6449.6 6450.0 6461.5 6462.1 6218.8 6314.7 6339.8 6342.0 6357.1 6485.3 6499.3 6499.7 6507.5 6512.5 6331.7 6333.8 6341.3 6345.6 6349.2 19:07:09 INFO - PROCESS | 1927 | 19:07:09 INFO - PROCESS | 1927 | [#5] yui.html Cycles:180 Average:14010.62 Median:49618.13 stddev:16547.23 (33.3%) stddev-sans-first:16563.36 19:07:09 INFO - PROCESS | 1927 | Values: 679.1 700.7 708.7 718.3 757.2 15369.4 15626.2 15630.5 15639.8 15650.1 14832.4 14910.4 14921.8 14923.1 14926.1 688.7 699.8 829.7 841.5 842.4 832.3 841.0 844.2 845.5 848.1 878.6 886.1 888.4 888.9 889.8 718.6 724.5 872.1 878.7 884.1 640.5 640.9 641.8 645.0 645.1 13477.2 13526.7 13585.3 13611.4 13611.9 11560.7 11742.4 11886.4 12042.8 12246.3 9885.7 9941.7 9952.3 10036.0 10386.1 3566.4 3586.3 3589.9 3663.8 3679.3 48199.3 49411.8 49501.8 49577.3 49659.0 9426.8 9526.7 9668.1 10013.8 10124.0 17643.3 17708.2 17733.6 17793.2 17809.1 6619.4 6636.8 6786.5 6918.3 6951.9 3881.3 3890.4 3964.1 4029.7 4104.8 3051.3 3073.0 3085.8 3086.1 3087.6 533.0 554.5 566.8 569.0 576.8 470.7 472.6 545.5 643.2 654.1 8434.5 8602.1 8647.8 8661.0 8720.0 504.9 613.6 630.5 638.9 646.0 3904.7 4142.0 4280.3 4387.3 4498.2 50352.2 59868.7 60075.7 60135.1 64608.7 48965.3 50208.7 50336.2 50585.5 51193.7 50326.5 50642.7 50744.0 51046.7 51489.5 8663.5 8809.9 8925.0 9107.0 9184.4 35755.3 36892.3 36959.6 36999.0 37062.4 44371.0 45706.0 46181.5 47775.5 47829.8 10790.4 10858.6 11184.0 11306.0 11736.8 10116.3 10680.1 10941.1 11105.7 11122.9 10633.1 10742.3 10748.4 10777.1 11107.1 10384.5 10609.9 10736.7 10809.8 10873.2 10710.6 10716.2 10742.0 11051.8 11192.8 8645.4 8708.3 8981.0 9053.8 9118.9 9171.9 9236.2 9718.0 9751.9 9778.1 19:07:09 INFO - PROCESS | 1927 | -------- Summary: end -------- 19:07:09 INFO - PROCESS | 1927 | 19:07:10 INFO - TEST-INFO | 1927: exit 0 19:07:10 INFO - TEST-OK | dromaeo_css | took 1114006ms 19:07:10 INFO - TEST-START | kraken 19:07:10 INFO - operating with platform_type : linux_ 19:07:10 INFO - Initialising browser for kraken test... 19:07:10 INFO - TEST-INFO | started process 2120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQhOb6r/profile http://localhost:36218/getInfo.html) 19:07:14 INFO - PROCESS | 2120 | __metrics Screen width/height:1600/1200 19:07:14 INFO - PROCESS | 2120 | colorDepth:24 19:07:14 INFO - PROCESS | 2120 | Browser inner width/height: 1024/697 19:07:14 INFO - PROCESS | 2120 | __metrics 19:07:15 INFO - PROCESS | 2120 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:15 INFO - PROCESS | 2120 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:07:16 INFO - TEST-INFO | 2120: exit 0 19:07:16 INFO - Browser initialized. 19:07:16 INFO - Running cycle 1/1 for kraken test... 19:07:16 INFO - TEST-INFO | started process 2208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQhOb6r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:27 INFO - PROCESS | 2208 | RSS: Main: 148946944 19:07:27 INFO - PROCESS | 2208 | 19:07:30 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-beat-detection) 19:07:30 INFO - PROCESS | 2208 | RSS: Main: 185077760 19:07:30 INFO - PROCESS | 2208 | 19:07:33 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-dft) 19:07:34 INFO - PROCESS | 2208 | RSS: Main: 175951872 19:07:34 INFO - PROCESS | 2208 | 19:07:36 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-fft) 19:07:37 INFO - PROCESS | 2208 | RSS: Main: 161267712 19:07:37 INFO - PROCESS | 2208 | 19:07:39 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36218/tests/kraken/driver.html?testName=audio-oscillator) 19:07:40 INFO - PROCESS | 2208 | RSS: Main: 161673216 19:07:40 INFO - PROCESS | 2208 | 19:07:42 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:07:42 INFO - PROCESS | 2208 | RSS: Main: 165404672 19:07:42 INFO - PROCESS | 2208 | 19:07:45 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-darkroom) 19:07:46 INFO - PROCESS | 2208 | RSS: Main: 166154240 19:07:46 INFO - PROCESS | 2208 | 19:07:49 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36218/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:50 INFO - PROCESS | 2208 | RSS: Main: 164954112 19:07:50 INFO - PROCESS | 2208 | 19:07:53 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36218/tests/kraken/driver.html?testName=json-parse-financial) 19:07:53 INFO - PROCESS | 2208 | RSS: Main: 166727680 19:07:53 INFO - PROCESS | 2208 | 19:07:55 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:55 INFO - PROCESS | 2208 | RSS: Main: 175804416 19:07:55 INFO - PROCESS | 2208 | 19:07:57 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:58 INFO - PROCESS | 2208 | RSS: Main: 173121536 19:07:58 INFO - PROCESS | 2208 | 19:08:00 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:08:00 INFO - PROCESS | 2208 | RSS: Main: 187256832 19:08:00 INFO - PROCESS | 2208 | 19:08:03 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:08:03 INFO - PROCESS | 2208 | RSS: Main: 190529536 19:08:03 INFO - PROCESS | 2208 | 19:08:06 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:08:07 INFO - PROCESS | 2208 | RSS: Main: 189886464 19:08:07 INFO - PROCESS | 2208 | 19:08:08 INFO - PROCESS | 2208 | Cycle 1(1): loaded http://localhost:36218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36218/tests/kraken/driver.html?testName=ai-astar) 19:08:09 INFO - PROCESS | 2208 | RSS: Main: 249540608 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | __start_tp_report 19:08:09 INFO - PROCESS | 2208 | _x_x_mozilla_page_load 19:08:09 INFO - PROCESS | 2208 | _x_x_mozilla_page_load_details 19:08:09 INFO - PROCESS | 2208 | |i|pagename|runs| 19:08:09 INFO - PROCESS | 2208 | |0;ai-astar;109;110;106;110;110;111;101;110;111;101 19:08:09 INFO - PROCESS | 2208 | |1;audio-beat-detection;149;124;150;164;124;154;154;126;164;126 19:08:09 INFO - PROCESS | 2208 | |2;audio-dft;161;163;162;162;162;159;160;161;162;161 19:08:09 INFO - PROCESS | 2208 | |3;audio-fft;72;72;84;99;74;74;75;114;98;74 19:08:09 INFO - PROCESS | 2208 | |4;audio-oscillator;97;98;141;95;96;96;140;96;96;139 19:08:09 INFO - PROCESS | 2208 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 19:08:09 INFO - PROCESS | 2208 | |6;imaging-darkroom;146;146;146;148;168;151;145;145;145;145 19:08:09 INFO - PROCESS | 2208 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;97 19:08:09 INFO - PROCESS | 2208 | |8;json-parse-financial;60;58;60;59;58;60;60;68;57;58 19:08:09 INFO - PROCESS | 2208 | |9;json-stringify-tinderbox;67;68;67;68;69;68;69;68;68;68 19:08:09 INFO - PROCESS | 2208 | |10;stanford-crypto-aes;85;86;87;85;85;86;86;85;88;85 19:08:09 INFO - PROCESS | 2208 | |11;stanford-crypto-ccm;117;119;117;121;114;124;119;126;133;121 19:08:09 INFO - PROCESS | 2208 | |12;stanford-crypto-pbkdf2;147;158;159;156;158;147;154;152;152;142 19:08:09 INFO - PROCESS | 2208 | |13;stanford-crypto-sha256-iterative;67;67;69;68;66;66;67;66;69;67 19:08:09 INFO - PROCESS | 2208 | __end_tp_report 19:08:09 INFO - PROCESS | 2208 | __start_cc_report 19:08:09 INFO - PROCESS | 2208 | _x_x_mozilla_cycle_collect,919 19:08:09 INFO - PROCESS | 2208 | __end_cc_report 19:08:09 INFO - PROCESS | 2208 | __startTimestamp1451358489085__endTimestamp 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | ------- Summary: start ------- 19:08:09 INFO - PROCESS | 2208 | Number of tests: 14 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:3.90 (3.5%) stddev-sans-first:4.12 19:08:09 INFO - PROCESS | 2208 | Values: 109.0 110.0 106.0 110.0 110.0 111.0 101.0 110.0 111.0 101.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:152.00 stddev:16.69 (11.0%) stddev-sans-first:17.58 19:08:09 INFO - PROCESS | 2208 | Values: 149.0 124.0 150.0 164.0 124.0 154.0 154.0 126.0 164.0 126.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 19:08:09 INFO - PROCESS | 2208 | Values: 161.0 163.0 162.0 162.0 162.0 159.0 160.0 161.0 162.0 161.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.50 stddev:14.86 (20.0%) stddev-sans-first:15.16 19:08:09 INFO - PROCESS | 2208 | Values: 72.0 72.0 84.0 99.0 74.0 74.0 75.0 114.0 98.0 74.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.14 (22.0%) stddev-sans-first:21.94 19:08:09 INFO - PROCESS | 2208 | Values: 97.0 98.0 141.0 95.0 96.0 96.0 140.0 96.0 96.0 139.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 19:08:09 INFO - PROCESS | 2208 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:146.00 stddev:7.11 (4.9%) stddev-sans-first:7.48 19:08:09 INFO - PROCESS | 2208 | Values: 146.0 146.0 146.0 148.0 168.0 151.0 145.0 145.0 145.0 145.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 19:08:09 INFO - PROCESS | 2208 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:3.08 (5.1%) stddev-sans-first:3.27 19:08:09 INFO - PROCESS | 2208 | Values: 60.0 58.0 60.0 59.0 58.0 60.0 60.0 68.0 57.0 58.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 19:08:09 INFO - PROCESS | 2208 | Values: 67.0 68.0 67.0 68.0 69.0 68.0 69.0 68.0 68.0 68.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.03 (1.2%) stddev-sans-first:1.05 19:08:09 INFO - PROCESS | 2208 | Values: 85.0 86.0 87.0 85.0 85.0 86.0 86.0 85.0 88.0 85.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:5.45 (4.5%) stddev-sans-first:5.57 19:08:09 INFO - PROCESS | 2208 | Values: 117.0 119.0 117.0 121.0 114.0 124.0 119.0 126.0 133.0 121.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:155.00 stddev:5.66 (3.7%) stddev-sans-first:5.64 19:08:09 INFO - PROCESS | 2208 | Values: 147.0 158.0 159.0 156.0 158.0 147.0 154.0 152.0 152.0 142.0 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - PROCESS | 2208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 19:08:09 INFO - PROCESS | 2208 | Values: 67.0 67.0 69.0 68.0 66.0 66.0 67.0 66.0 69.0 67.0 19:08:09 INFO - PROCESS | 2208 | -------- Summary: end -------- 19:08:09 INFO - PROCESS | 2208 | 19:08:09 INFO - TEST-INFO | 2208: exit 0 19:08:09 INFO - TEST-OK | kraken | took 59513ms 19:08:09 INFO - TEST-START | v8_7 19:08:09 INFO - operating with platform_type : linux_ 19:08:09 INFO - Initialising browser for v8_7 test... 19:08:09 INFO - TEST-INFO | started process 2526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8QKZQa/profile http://localhost:36218/getInfo.html) 19:08:14 INFO - PROCESS | 2526 | __metrics Screen width/height:1600/1200 19:08:14 INFO - PROCESS | 2526 | colorDepth:24 19:08:14 INFO - PROCESS | 2526 | Browser inner width/height: 1024/697 19:08:14 INFO - PROCESS | 2526 | __metrics 19:08:14 INFO - PROCESS | 2526 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:08:14 INFO - PROCESS | 2526 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:08:15 INFO - TEST-INFO | 2526: exit 0 19:08:15 INFO - Browser initialized. 19:08:15 INFO - Running cycle 1/1 for v8_7 test... 19:08:15 INFO - TEST-INFO | started process 2624 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8QKZQa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:27 INFO - PROCESS | 2624 | RSS: Main: 148213760 19:08:27 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | Cycle 1(1): loaded http://localhost:36218/tests/v8_7/run.html (next: http://localhost:36218/tests/v8_7/run.html) 19:08:48 INFO - PROCESS | 2624 | RSS: Main: 604753920 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | __start_tp_report 19:08:48 INFO - PROCESS | 2624 | _x_x_mozilla_page_load 19:08:48 INFO - PROCESS | 2624 | _x_x_mozilla_page_load_details 19:08:48 INFO - PROCESS | 2624 | |i|pagename|runs| 19:08:48 INFO - PROCESS | 2624 | |0;Richards;168.8048615800135 19:08:48 INFO - PROCESS | 2624 | |1;DeltaBlue;196.9667126255663 19:08:48 INFO - PROCESS | 2624 | |2;Encrypt;284.4141069397042 19:08:48 INFO - PROCESS | 2624 | |3;Decrypt;5246.073298429319 19:08:48 INFO - PROCESS | 2624 | |4;RayTrace;1107.4197120708748 19:08:48 INFO - PROCESS | 2624 | |5;Earley;792.3930269413629 19:08:48 INFO - PROCESS | 2624 | |6;Boyer;12419.753086419752 19:08:48 INFO - PROCESS | 2624 | |7;RegExp;25974.358974358973 19:08:48 INFO - PROCESS | 2624 | |8;Splay;636.7088607594936 19:08:48 INFO - PROCESS | 2624 | |9;NavierStokes;4835.748792270531 19:08:48 INFO - PROCESS | 2624 | __end_tp_report 19:08:48 INFO - PROCESS | 2624 | __startTimestamp1451358528956__endTimestamp 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | ------- Summary: start ------- 19:08:48 INFO - PROCESS | 2624 | Number of tests: 10 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#0] Richards Cycles:1 Average:168.80 Median:168.80 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 168.8 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#1] DeltaBlue Cycles:1 Average:196.97 Median:196.97 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 197.0 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 284.4 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 5246.1 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 1107.4 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 792.4 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 12419.8 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 25974.4 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#8] Splay Cycles:1 Average:636.71 Median:636.71 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 636.7 19:08:48 INFO - PROCESS | 2624 | 19:08:48 INFO - PROCESS | 2624 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:08:48 INFO - PROCESS | 2624 | Values: 4835.7 19:08:48 INFO - PROCESS | 2624 | -------- Summary: end -------- 19:08:48 INFO - PROCESS | 2624 | 19:08:49 INFO - TEST-INFO | 2624: exit 0 19:08:49 INFO - TEST-OK | v8_7 | took 39960ms 19:08:49 INFO - SUITE-END | took 1213s 19:08:50 INFO - Completed test suite (00:20:13) 19:08:50 INFO - Working with test: dromaeo_css 19:08:50 INFO - Generating results file: dromaeo_css 19:08:50 INFO - Working with test: kraken 19:08:50 INFO - Generating results file: kraken 19:08:50 INFO - javascript benchmark 19:08:50 INFO - Working with test: v8_7 19:08:50 INFO - Generating results file: v8_7 19:08:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 19:08:50 INFO - process_Request line: dromaeo_css 6854.71 graph.html#tests=[[72,63,35]] 19:08:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:50 INFO - process_Request line: kraken 1513.70 graph.html#tests=[[232,63,35]] 19:08:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:08:50 INFO - process_Request line: v8_7 20696.57 graph.html#tests=[[230,63,35]] 19:08:50 INFO - RETURN: dromaeo_css: 6854.71 19:08:50 INFO - RETURN: kraken: 1513.70 19:08:50 INFO - RETURN: v8_7: 20696.57 19:08:50 INFO - javascript benchmark 19:08:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3119.204602826279, 3164.8575814088363, 3201.2797120647842, 3212.7751057425976, 3229.111994201595, 5065.949340506594, 5204.34945631796, 5210.723402564639, 5240.502152295526, 5262.842114736559, 5098.184290513518, 5186.170212765958, 5231.450697676746, 5280.049591073605, 5291.497307755767, 4583.518730533296, 4659.068186362724, 4767.809287628491, 4840.394950631171, 4902.779374928136, 4728.71627702339, 4834.734089625069, 4853.0, 4861.854144375674, 4961.18140506816, 4700.741459219742, 4746.477887432379, 4757.690750101232, 4767.332573439721, 4777.761111944406, 4787.2101103318255, 4812.133815913135, 4812.566868981773, 4820.903581928342, 4830.275458681226, 4625.699329543569, 4734.905301893943, 4761.976190119062, 4801.73590452525, 4815.422149342101, 5074.441811400743, 5089.05852417304, 5091.872703182413, 5101.846944591668, 5107.540321371094, 5593.133064375028, 5597.272354593877, 5610.6661360131175, 5615.803446879339, 5649.4633009864, 5546.0, 5642.633228840154, 5647.265855438808, 5664.348599910981, 5666.093425051972, 5300.496452837013, 5318.30861987943, 5323.414424413311, 5325.201219817059, 5330.706811125387, 5766.192733017381, 5777.133429985452, 5786.594938354275, 5788.450097240755, 5834.474897259182, 5401.108817045222, 5501.477359650827, 5505.449455054542, 5505.476979686923, 5544.168374743821, 5602.271704678447, 5680.715964201773, 5695.886082278331, 5718.971405142947, 5720.942790572124, 5595.524380427628, 5653.321601407857, 5654.97172514143, 5656.038473459522, 5662.773489060474, 5518.365387980353, 5632.211490391349, 5663.178839068312, 5668.291463567054, 5669.206311116447, 4317.611414972667, 4345.956540434619, 4349.565043495689, 4373.125374925028, 4408.184485870061, 3893.3575959966856, 3897.649211570972, 3904.082540602956, 3936.1340505088833, 3951.9802400988387, 5048.722320272347, 5152.562032227228, 5226.189940559219, 5232.9738351308, 5276.36683597963, 5584.6090773646265, 5598.664080155204, 5664.886702266014, 5685.914711279334, 5705.2012718219485, 5277.050130976384, 5283.630145889751, 5284.7093409862055, 5290.100682883919, 5291.841244762663, 4917.0, 4925.605951523869, 4927.088488629615, 4927.531884470969, 4948.134076536592, 5683.232763576864, 5739.626924249994, 5762.971185144047, 5793.449622285876, 5883.352831188566, 5686.800961966312, 5693.430656934439, 5695.658260504383, 5699.116636921284, 5700.914486282626, 5835.94164058354, 5848.912266316093, 5855.970720146372, 5861.238039054895, 5867.530597552271, 5444.564434845123, 5547.972260138674, 5553.139263414178, 5553.944460555343, 5673.234113394639, 5682.431756824284, 5703.7433315500075, 5712.457316554921, 5713.8285851424525, 5715.342735585461, 5515.117581186991, 5554.416786237387, 5562.777488900399, 5568.91646625309, 5571.582131340085, 5311.070562651444, 5392.029434701792, 5478.534324582455, 5534.7509362078, 5567.693776842312, 5462.6995515247045, 5492.148716948879, 5494.862628434321, 5496.890062198813, 5501.944980550144, 5340.919886201632, 5588.748506317144, 5590.357108932525, 5612.130119831432, 5651.067573850269, 5375.489328513785, 5416.593755468277, 5423.972880135574, 5433.701146436826, 5476.616636835383], "unit": "score", "name": "dojo.html", "value": 5199.572465632313}, {"lowerIsBetter": false, "replicates": [549.3572520151422, 562.6680258647399, 568.9914651280229, 575.6200907401117, 583.8336074218847, 29145.12564623062, 29667.258318542048, 29824.403511929748, 29841.253968650795, 29854.402911941776, 29901.55147672781, 30494.390112197743, 37741.0, 38179.42730859039, 38390.424143637865, 8637.09310522394, 8770.473771573694, 8781.912180878173, 8784.341174411913, 8788.8681669775, 8579.613917373734, 8637.309015278763, 8698.434601750898, 8713.912860871373, 8723.432976856484, 7632.198619144993, 7828.412869034817, 7833.255840695125, 10351.223658225663, 10584.364938103738, 10254.333468324572, 10354.119899808526, 10359.32664376813, 10364.32631878933, 10381.377117372982, 7637.885431718529, 10103.848442273298, 10251.0, 10267.127294180003, 10279.229057820694, 29192.12423627273, 29633.851830740925, 41013.1797364054, 41849.58150418488, 41855.37216941748, 3196.4725820239632, 3278.1476816027766, 3310.2220978070136, 3337.4493208620547, 3358.5969683637877, 27700.584491232647, 28109.29726756827, 28317.716822831713, 28519.287017824514, 28530.0, 3906.7069969752383, 3954.960450395488, 3969.9007524811823, 4070.796460177009, 4172.082141928801, 264535.5784084836, 295735.0, 300001.0, 401949.0, 409812.99999999703, 57878.421215787304, 58136.70931645399, 58175.70912145412, 58233.41766582365, 58435.0, 62188.68905655533, 63015.6849215751, 63081.43022837289, 63136.0, 63146.68426657837, 15546.37814487408, 15797.289121989537, 15808.76286855675, 15831.129287889276, 16034.759478607597, 11133.443327833576, 11168.832467512993, 11171.106311495061, 11172.776544469065, 11179.66461006171, 20576.485587860425, 20594.27920022792, 20855.791442085385, 20868.582628347347, 20871.478213044797, 7955.761327160194, 8113.148119447373, 8133.511989280662, 8158.102608713037, 8328.66685332592, 921.6037104045191, 961.9134277914882, 1055.6410820321128, 1056.4981633724074, 1062.7024433158574, 29066.564001539995, 29365.559516607267, 29510.40979180447, 29923.850380747957, 30112.397752044835, 1013.0882206014498, 1039.6984874386494, 1077.7251800790905, 1092.1481244629201, 1126.9294170538021, 15397.461088861835, 15454.3727566314, 15522.456714015181, 15569.922150389175, 15753.921230394004, 344637.0, 349618.0, 351305.1129631352, 351360.0, 352041.0, 46472.5352746475, 52561.211581826305, 52961.2055819163, 52992.47007529953, 53032.73483632557, 1199.5921386728555, 1316.7761480548522, 1318.8878945289566, 1339.9464021439032, 1359.6125104345215, 27113.86443067772, 27188.320291992066, 27523.58714619242, 27955.44089118247, 28001.29996750016, 45089.549104509846, 46229.76885115553, 51846.74076629593, 52801.20798187953, 52832.471675284294, 320157.0, 322585.0, 323164.0, 326024.0, 327154.0, 40037.59962400455, 40128.0, 40834.59165408308, 40840.79579602083, 40926.386104207864, 42154.578454216295, 43185.56814431815, 46305.0, 47416.52583474259, 47605.28592071052, 39030.41454378243, 39161.0, 39515.2096958065, 40436.0, 41195.0, 38005.809970949966, 38870.04078145444, 39574.40638390369, 39606.40590391204, 39655.80172099121, 37484.25031499409, 38516.229675406896, 38903.0, 39064.60935390723, 39078.6092139075, 32303.676963230067, 35408.0, 35713.36088840135, 35991.46012809758, 36120.0, 25991.480170396866, 26282.342941426617, 26330.605040924784, 26498.602520961816, 26669.866650666623], "unit": "score", "name": "ext.html", "value": 18991.02046480785}, {"lowerIsBetter": false, "replicates": [355.0998219513532, 360.7943472220835, 361.4036839215294, 363.8471841826433, 363.8580953428163, 13889.513867014632, 14024.0, 16255.756163657554, 16947.322107115717, 17882.642347153065, 15774.0, 15961.920190399032, 16097.758533621976, 16711.498655040366, 16713.0, 5383.596230282735, 5487.588430867681, 5520.365158006821, 5523.0, 5528.9723551382185, 4081.8163182656854, 4182.205380977604, 5451.454854514536, 5493.807716729915, 6016.187814645033, 6102.0, 6126.938730612704, 6143.293521245047, 6152.938470615281, 6152.969235153818, 5616.494515493605, 5789.739461724233, 5795.1017592273265, 5796.855078623026, 6093.6039157454625, 5155.690658560498, 5156.510131537498, 5172.741362931876, 5233.0, 5371.221172929903, 12896.484140634364, 12921.418536165895, 13158.60524184276, 15707.685846283124, 20282.49293767653, 637.6811594202899, 638.2532437048665, 638.3010603389328, 2071.8031786980214, 2149.9032543535577, 9260.861087083698, 9356.719298421058, 9572.042795720441, 12565.93717031418, 13166.670833229246, 1781.1806568978286, 1788.0492927051494, 1804.8736588438815, 1817.6546456173285, 1850.1581780289937, 58751.0, 61039.38960610382, 61082.08376874306, 62333.0, 62566.0, 9692.854607180898, 10049.497525123714, 10164.136048435817, 10195.796084078425, 10226.07965283128, 13625.931870340783, 13631.250281234428, 13643.522476713268, 13654.59036228895, 13656.65858353549, 7508.361789247975, 7551.056117985252, 7566.508176968479, 7574.659140338698, 7626.6186690665245, 7323.926760732431, 7325.230850760593, 7356.852862942711, 7389.261073892568, 7397.445191610651, 4341.804618792162, 4445.666575006888, 4448.755318457451, 4459.0, 4537.0925814837165, 1703.5741064733816, 1753.815849335827, 1767.5492749348834, 1768.3899054826065, 1768.823117688221, 884.7434244069276, 979.8334283171878, 998.8002399520125, 1030.9432383570672, 1066.370841203678, 14860.70278594422, 15985.760213596805, 16114.838851611568, 16227.269772860249, 17000.319987200623, 843.7470356520562, 880.3309484791605, 892.1078921078921, 916.1113719691888, 958.9376690515094, 8746.606402711894, 9002.549872506348, 9023.909760902437, 9024.503652299056, 9203.585838637144, 134572.32713836565, 134876.0, 135126.32436837754, 603886.415533674, 606623.0, 75988.62005689937, 76430.6178469104, 76601.61699191468, 77253.22746772572, 79353.0, 1087.3747595132672, 1142.0977427832086, 1152.4929031226234, 1161.175565348595, 1161.268400907423, 14481.420743170576, 14800.0, 15027.0, 15183.924080379527, 15233.771493427386, 33333.333333333685, 33796.493052604725, 33923.3215335687, 34304.0, 35174.12064698403, 44922.32616510821, 45789.31316030329, 46201.30698039465, 46329.07341853211, 49681.50318496914, 9588.137067663665, 9601.231901447727, 9743.171830394213, 9768.853467197856, 9788.755281118029, 16812.159392030593, 16984.824538369572, 17239.7414038787, 17833.46499605014, 17885.10574471297, 10869.0, 12688.6827829305, 13545.458181672622, 13620.591382258548, 14104.08323458972, 12420.937895310466, 13685.931570342484, 13793.655158621115, 13892.16647001183, 13991.16053036821, 13851.376688049264, 14192.219427931563, 14338.928305358824, 14410.207438590978, 14822.03656762307, 9211.124943130391, 9231.86152207704, 9371.203447707021, 9493.857592135986, 9693.224542036762, 13647.522336718168, 14027.579172624837, 14051.859481405463, 14404.99165058436, 14462.27688615586], "unit": "score", "name": "jquery.html", "value": 8515.258247393247}, {"lowerIsBetter": false, "replicates": [1247.519704913608, 1435.720034593254, 1446.1539999100526, 1581.6441300707343, 1750.3873644224523, 6175.938240617593, 6628.50286228533, 6701.631410272439, 6714.798556043326, 6721.663916804165, 6695.397414232718, 6848.178218613761, 6853.417459515935, 6855.108835851345, 6865.073215115958, 2066.2768031189075, 2099.233779670417, 2105.515731381783, 2106.5260316428835, 2107.146605624717, 2142.5286436983915, 2178.6187417202004, 2184.421128400975, 2186.4533866533366, 2188.223180770827, 2104.6948192512077, 2128.733908261467, 2149.3659370485743, 2149.8495105342554, 2152.418846911333, 2137.2092325839385, 2150.892455377225, 2168.349495151448, 2168.4904047548894, 2168.5879682860286, 2138.5936672032262, 2171.565686862634, 2178.422717979721, 2179.1283486605325, 2179.52050548879, 6783.660816959133, 6856.794296171123, 6862.073620061277, 6872.62200578968, 6883.070785443951, 4337.696361254713, 4375.0593622371025, 4387.056782791715, 4411.536788637211, 4419.248727716264, 2919.5474701421313, 2943.1023537820956, 3022.1084779989956, 3040.042386648221, 3048.2684155802667, 968.9951550242274, 1000.0549480740702, 1015.8374660054429, 1022.371241686365, 1030.649579143095, 9249.12133347331, 9324.0, 9334.953325233399, 9336.11306925841, 9374.625014999392, 3897.142628621699, 3927.0378757204667, 3946.9210615787524, 3977.065389633434, 3981.7411868228473, 8050.919490805017, 8054.154313797084, 8059.194080591894, 8070.1526339734655, 8087.636056377477, 4352.9129417412105, 4384.0355121873135, 4384.956150438518, 4389.385486031958, 4396.736195828261, 3413.5391722117197, 3492.4586689063235, 3949.466821978996, 4034.8991275218355, 4040.313146765057, 3406.9659303407143, 3409.7613167078066, 3427.3145370925417, 3440.7935523868646, 3465.9826700866333, 1095.4139535348709, 1101.8292164714483, 1104.4256986367045, 1119.0599896087326, 1127.1546340244815, 1274.5347947999098, 1284.9293288869014, 1302.863199364072, 1315.414640484975, 1316.5721140629335, 6389.808305750835, 6508.088867558546, 6540.247871494839, 6576.934230657632, 6581.177352830896, 1097.1113398147527, 1100.5102729285552, 1104.2435931387026, 1105.7180418993105, 1129.7458071933913, 5112.565431938327, 5147.022065807485, 5147.40804807452, 5149.819756308586, 5158.819441319536, 7946.284834364935, 7959.283664470226, 8107.4324797263625, 8249.463784853966, 8283.917160828436, 8173.550454724928, 8335.208155225244, 8340.082590914995, 8348.0, 8352.624131914079, 6515.73937042513, 6664.500162487833, 6718.932810671929, 6728.764493242713, 6739.831504212434, 6509.446697030806, 6598.406143447113, 6636.369544893228, 6639.435647969976, 6647.767328143492, 7417.147028091623, 7475.813104672427, 7557.962210188914, 7657.731979380695, 7678.769636910902, 7670.654820532978, 7707.383409327353, 7858.724944626911, 7866.449348545547, 7892.289693927574, 5509.146082357241, 5604.635698679573, 5615.466530679579, 6153.107799368977, 6215.782447614492, 6331.556791024768, 6390.488760899024, 6429.132067170872, 6454.903176452263, 6455.806325810233, 5901.557383196192, 5918.2898052234, 5944.821655350346, 6034.366391528826, 6188.44304012641, 5980.910286345796, 6030.276366835832, 6161.753529858755, 6172.351903050115, 6239.220097487814, 6089.2997305310455, 6273.15312432834, 6280.27776805655, 6280.591761535486, 6287.434130928238, 5789.334226563999, 5811.622244554091, 5836.824895253149, 5840.853978650568, 5859.619124756877, 5778.913316300343, 5820.621659592113, 5840.474357307863, 5876.559258055578, 5893.882122357614], "unit": "score", "name": "mootools.html", "value": 4112.509460873066}, {"lowerIsBetter": false, "replicates": [338.4128536988326, 341.1539382331815, 342.209496064092, 347.6280379993407, 349.4129861832121, 5982.940170598293, 6037.0340745480735, 6065.545084118692, 6070.423309785563, 6095.634261944287, 5962.284525856903, 5963.522918166547, 5970.283565972079, 5980.282366116061, 5985.880282394361, 4537.682362234645, 4622.37597924281, 4622.58396744293, 4625.121226966882, 4629.745364004978, 4594.2419500782335, 4607.378003969455, 4608.423947006624, 4614.538546145375, 4627.676062675597, 4557.407537020183, 4559.908801823978, 4564.224081906067, 4569.634429245669, 4573.176828170945, 4344.956550434503, 4411.051623900877, 4427.712198707074, 4559.338895860098, 4566.292224705176, 3967.107400834818, 3990.201959608061, 3999.8200080996426, 4000.219957108365, 4004.979975100135, 5535.806246781343, 5552.250446189753, 5625.943740562624, 5653.208550802891, 5658.151277308396, 5045.596352291808, 5174.456682048369, 5176.120059589879, 5210.505002024802, 5299.788008479656, 6195.2255968004, 6201.472874805647, 6211.596246243979, 6229.844253893643, 6237.033259844731, 4419.160359531678, 4420.226460369422, 4431.268840641323, 4431.933520997188, 4433.445819272591, 6380.361963803629, 6535.052417399451, 6541.901871471884, 6547.443467305285, 6551.344865513458, 4568.428946381702, 4573.245414506636, 4573.931391029138, 4574.108048930493, 4575.725456472623, 4631.722096674143, 4631.814727410866, 4632.72203667781, 4638.489766125724, 4638.512956139624, 5278.762455689503, 5281.762320695578, 5283.07546179417, 5284.815031473957, 5288.65623734456, 6159.384061593805, 6302.968485157637, 6322.71547780351, 6389.808305750835, 6394.8721025579225, 1607.5579215715538, 1627.7314243149747, 1629.08771088191, 1629.136557624461, 1630.5108467459715, 1082.5074591061048, 1087.4073629871739, 1091.5197313182175, 1104.320842681745, 1113.3208742666966, 6023.728932198062, 6027.186329845503, 6033.095035744585, 6033.909491357633, 6038.154658347747, 6560.343965603402, 6564.245111812203, 6573.605583664996, 6576.243731970884, 6576.342365763481, 5919.378465261172, 6004.909926351108, 6024.578279520391, 6025.3974602540275, 6031.4270144336215, 3492.895213143559, 3553.8045407502836, 3562.857485700543, 3568.339857126388, 3569.8929032129076, 6746.763863264762, 6779.322067793181, 6779.49153813466, 6793.252742198354, 6793.490488213305, 6451.1936007999, 6572.309907459648, 6614.86770264592, 6712.798616041527, 6717.193936727624, 6810.795676129724, 6841.62371069586, 6849.760258390932, 6859.794206173823, 6871.381575658214, 6575.80272591823, 6582.0785090086465, 6583.835404114744, 6588.4399826013405, 6588.967055164693, 6354.968225158845, 6477.352264773674, 6526.498905251724, 6528.053432252202, 6532.41208291256, 6811.489138314745, 6812.0803691503, 6821.283765204582, 6825.385715285648, 6834.863302733818, 4538.546145385435, 4544.909101817879, 4548.840790572314, 4550.590446859798, 4552.362669226377, 6457.096006558992, 6623.966880165568, 6636.966815166086, 6637.6681165940545, 6639.6680165992475, 6452.451541619015, 6455.386738259858, 6457.903131453126, 6462.4183823456115, 6482.611043337415, 6442.613443193423, 6449.645269510222, 6449.96775016122, 6461.547691661539, 6462.127612772216, 6218.751249949952, 6314.715837787218, 6339.841503962253, 6341.968290158519, 6357.110004599453, 6485.254195767548, 6499.285078641251, 6499.7400103995315, 6507.479401647952, 6512.47900167976, 6331.6517591531065, 6333.809985700436, 6341.302456729663, 6345.587536810092, 6349.238091429058], "unit": "score", "name": "prototype.html", "value": 4804.54157694733}, {"lowerIsBetter": false, "replicates": [679.1137565477054, 700.7267165805333, 708.6988030087211, 718.253016862463, 757.1860250231, 15369.385224591017, 15626.21868906553, 15630.531084067481, 15639.765403518943, 15650.060996340228, 14832.406703731865, 14910.403583856632, 14921.776173357408, 14923.104613723157, 14926.104433733983, 688.7348370877223, 699.8110510162253, 829.7386323308153, 841.5035129273728, 842.3934766967774, 832.2883934236231, 841.0244116824484, 844.2444012608712, 845.4758050009003, 848.0713618587667, 878.6134100995573, 886.1271647427279, 888.4269646078276, 888.8977767556717, 889.7642124836923, 718.5796309159148, 724.5254358395259, 872.0538216035609, 878.7056336127405, 884.0673089890163, 640.5100098424709, 640.8654182621655, 641.8491654461197, 644.9613023218621, 645.0872016097217, 13477.19136851792, 13526.661833454144, 13585.252811095386, 13611.387487562984, 13611.863881361158, 11560.710982225428, 11742.412879355998, 11886.40567971598, 12042.81935770964, 12246.326452045134, 9885.703428897144, 9941.65204217856, 9952.303338766289, 10036.0, 10386.117180039706, 3566.4293713006055, 3586.264815712773, 3589.892303230907, 3663.816809159558, 3679.2825399047197, 48199.27701084451, 49411.75294123506, 49501.752491237676, 49577.25634115491, 49659.0, 9426.811463770824, 9526.714198574055, 9668.129868311886, 10013.79972400548, 10124.038216369581, 17643.294268229383, 17708.203130859143, 17733.556661083578, 17793.19930603126, 17809.10954452298, 6619.371159739817, 6636.767713130017, 6786.491013174032, 6918.308169183142, 6951.930480695129, 3881.340172170738, 3890.3775395936514, 3964.108075683006, 4029.657479114308, 4104.774237416971, 3051.3134544727704, 3073.0, 3085.7531397488146, 3086.120455670123, 3087.6449208340878, 532.9733513324318, 554.4704806909392, 566.7761234312505, 568.9687067211261, 576.826951914424, 470.68228945461675, 472.58838740358453, 545.4736179586718, 643.1831573901119, 654.1169421281327, 8434.451760635538, 8602.139786021347, 8647.827043459096, 8661.0, 8719.956400217958, 504.9444561098276, 613.6440864298696, 630.4767043354005, 638.9365563693322, 646.0309535696455, 3904.6681032112588, 4141.958580414218, 4280.250956082673, 4387.341898715218, 4498.212812757754, 50352.24471632928, 59868.70065649731, 60075.69962150161, 60135.097973530435, 64608.73869414548, 48965.265521017216, 50208.74895625572, 50336.24495632568, 50585.494145058816, 51193.7440312796, 50326.49673503291, 50642.74678626583, 50744.0, 51046.74476627593, 51489.485105149215, 8663.46717540562, 8809.911900880908, 8924.955375223082, 9107.0, 9184.357095003286, 35755.28489430249, 36892.262154756216, 36959.6304036967, 36999.0, 37062.44406333853, 44371.0, 45706.0, 46181.538184617726, 47775.5222447785, 47829.76085119552, 10790.406527640742, 10858.619948301772, 11184.049355804847, 11306.038986686224, 11736.76526469483, 10116.291859570054, 10680.092192163753, 10941.12471002302, 11105.722356941142, 11122.888771112186, 10633.096186823897, 10742.3017503862, 10748.355098694103, 10777.13782897382, 11107.055900248246, 10384.480775961323, 10609.9469502652, 10736.73158171052, 10809.820628468646, 10873.184511161537, 10710.57157713714, 10716.19628527848, 10742.0, 11051.778964420828, 11192.832107518556, 8645.351598630003, 8708.346873984603, 8981.0, 9053.818923621358, 9118.861110973121, 9171.908280917105, 9236.16874481273, 9717.951410242904, 9751.902480975099, 9778.119969202806], "unit": "score", "name": "yui.html", "value": 6243.391071715538}], "name": "dromaeo_css", "value": 6854.713808331077}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 110.0, 110.0, 111.0, 101.0, 110.0, 111.0, 101.0], "unit": "score", "name": "ai-astar", "value": 107.9}, {"lowerIsBetter": true, "replicates": [149.0, 124.0, 150.0, 164.0, 124.0, 154.0, 154.0, 126.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 159.0, 160.0, 161.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 99.0, 74.0, 74.0, 75.0, 114.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 141.0, 95.0, 96.0, 96.0, 140.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.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.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 148.0, 168.0, 151.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 60.0, 59.0, 58.0, 60.0, 60.0, 68.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 87.0, 85.0, 85.0, 86.0, 86.0, 85.0, 88.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [117.0, 119.0, 117.0, 121.0, 114.0, 124.0, 119.0, 126.0, 133.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [147.0, 158.0, 159.0, 156.0, 158.0, 147.0, 154.0, 152.0, 152.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 68.0, 66.0, 66.0, 67.0, 66.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1513.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.8048615800135], "unit": "score", "name": "Richards", "value": 209.1290480000001}, {"lowerIsBetter": false, "replicates": [196.9667126255663], "unit": "score", "name": "DeltaBlue", "value": 335.681086}, {"lowerIsBetter": false, "replicates": [284.4141069397042], "unit": "score", "name": "Encrypt", "value": 935.8923959999998}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [636.7088607594936], "unit": "score", "name": "Splay", "value": 127.98785288270379}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20696.568685919858}]} 19:08:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20696.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1513.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6854.71"}}} 19:08:50 INFO - Return code: 0 19:08:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:08:50 INFO - # TBPL SUCCESS # 19:08:50 INFO - Running post-action listener: _resource_record_post_action 19:08:50 INFO - Running post-run listener: _resource_record_post_run 19:08:51 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 556105728; Read time: 384; Write time: 666976 19:08:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 235401216; Read time: 0; Write time: 380532 19:08:51 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320704512; Read time: 384; Write time: 286444 19:08:51 INFO - Running post-run listener: _upload_blobber_files 19:08:51 INFO - Blob upload gear active. 19:08:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:08:51 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 19:08:51 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:08:51 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:08:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:08:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:08:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:53 INFO - (blobuploader) - INFO - Done attempting. 19:08:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:08:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:08:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:08:53 INFO - (blobuploader) - INFO - Done attempting. 19:08:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:08:53 INFO - Return code: 0 19:08:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:08:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:08:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89f4ff9112419a05a849270706adde5c05e068ec53cc731bc3d6340a1026a624aba4906ab0dcb5fcc242302476cd5626b55b506d374b1f57e6d20f24e0747c90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978ebdc8df86563c420b01f7a5eb424268ae92b592d7d0ec88aa8e5b7fe252b250f55d3db8ec02db66fdf4f7dd99d22978daafb4a83d54a14b84cd36d8df79b3"} 19:08:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:08:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:08:53 INFO - Contents: 19:08:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89f4ff9112419a05a849270706adde5c05e068ec53cc731bc3d6340a1026a624aba4906ab0dcb5fcc242302476cd5626b55b506d374b1f57e6d20f24e0747c90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978ebdc8df86563c420b01f7a5eb424268ae92b592d7d0ec88aa8e5b7fe252b250f55d3db8ec02db66fdf4f7dd99d22978daafb4a83d54a14b84cd36d8df79b3"} 19:08:53 INFO - Copying logs to upload dir... 19:08:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.929101 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-28 19:08:53.026633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 19:08:53.029778) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89f4ff9112419a05a849270706adde5c05e068ec53cc731bc3d6340a1026a624aba4906ab0dcb5fcc242302476cd5626b55b506d374b1f57e6d20f24e0747c90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978ebdc8df86563c420b01f7a5eb424268ae92b592d7d0ec88aa8e5b7fe252b250f55d3db8ec02db66fdf4f7dd99d22978daafb4a83d54a14b84cd36d8df79b3"} build_url:https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/TA5oNWqhSjyYfbpS_P6oKQ/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/Mozilla-Inbound/sha512/89f4ff9112419a05a849270706adde5c05e068ec53cc731bc3d6340a1026a624aba4906ab0dcb5fcc242302476cd5626b55b506d374b1f57e6d20f24e0747c90", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/978ebdc8df86563c420b01f7a5eb424268ae92b592d7d0ec88aa8e5b7fe252b250f55d3db8ec02db66fdf4f7dd99d22978daafb4a83d54a14b84cd36d8df79b3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 19:08:53.054407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:08:53.054729) ========= 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=0cff312cb257a7829adc5a5d000001df-1451351918.616307-849349093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 19:08:53.140536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 19:08:53.140865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 19:08:53.141176) ========= ========= Total master_lag: 0.22 =========