builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1452095569.65 results: success (0) buildid: 20160106053004 builduid: cd2ecc82a6bf4ea9b41c4bd35eb268b1 revision: 70ae39b770ed0c821f83c40823efbe8ad10708e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.648984) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.649580) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.649946) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006417 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.676852) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.677172) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.706187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.706537) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.757590) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.757901) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.758305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.758645) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 07:52:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.0M=0s 2016-01-06 07:52:50 (83.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170637 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.944564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.945128) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018102 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:49.997651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 07:52:49.998476) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 70ae39b770ed0c821f83c40823efbe8ad10708e5 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 70ae39b770ed0c821f83c40823efbe8ad10708e5 --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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 07:52:50,464 truncating revision to first 12 chars 2016-01-06 07:52:50,464 Setting DEBUG logging. 2016-01-06 07:52:50,464 attempt 1/10 2016-01-06 07:52:50,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/70ae39b770ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 07:52:51,709 unpacking tar archive at: b2g-inbound-70ae39b770ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.532081 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-06 07:52:51.549982) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:51.550358) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:51.562905) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:51.563191) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 07:52:51.563681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 07:52:51.564004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:52 INFO - MultiFileLogger online at 20160106 07:52:52 in /builds/slave/test-pgo 07:52:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 07:52:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:52:52 INFO - {'append_to_log': False, 07:52:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:52:52 INFO - 'blob_upload_branch': 'B2G-Inbound', 07:52:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:52:52 INFO - 'branch': 'B2G-Inbound', 07:52:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:52 INFO - 'config_files': ('talos/linux_config.py',), 07:52:52 INFO - 'default_actions': ('clobber', 07:52:52 INFO - 'read-buildbot-config', 07:52:52 INFO - 'download-and-extract', 07:52:52 INFO - 'populate-webroot', 07:52:52 INFO - 'create-virtualenv', 07:52:52 INFO - 'install', 07:52:52 INFO - 'run-tests'), 07:52:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:52 INFO - 'download_minidump_stackwalk': True, 07:52:52 INFO - 'download_symbols': 'ondemand', 07:52:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:52 INFO - 'installer_path': 'installer.exe', 07:52:52 INFO - 'log_level': 'info', 07:52:52 INFO - 'log_name': 'talos', 07:52:52 INFO - 'log_to_console': True, 07:52:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:52 INFO - 'opt_config_files': (), 07:52:52 INFO - 'pip_index': False, 07:52:52 INFO - 'sps_profile': False, 07:52:52 INFO - 'sps_profile_interval': 0, 07:52:52 INFO - 'suite': 'dromaeojs', 07:52:52 INFO - 'system_bits': '32', 07:52:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:52 INFO - 'title': 'talos-linux64-ix-019', 07:52:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:52 INFO - 'use_talos_json': True, 07:52:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:52:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:52 INFO - 'work_dir': 'build'} 07:52:52 INFO - ##### 07:52:52 INFO - ##### Running clobber step. 07:52:52 INFO - ##### 07:52:52 INFO - Running pre-action listener: _resource_record_pre_action 07:52:52 INFO - Running main action method: clobber 07:52:52 INFO - rmtree: /builds/slave/test-pgo/build 07:52:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:52:53 INFO - Running post-action listener: _resource_record_post_action 07:52:53 INFO - ##### 07:52:53 INFO - ##### Running read-buildbot-config step. 07:52:53 INFO - ##### 07:52:53 INFO - Running pre-action listener: _resource_record_pre_action 07:52:53 INFO - Running main action method: read_buildbot_config 07:52:53 INFO - Using buildbot properties: 07:52:53 INFO - { 07:52:53 INFO - "project": "", 07:52:53 INFO - "product": "firefox", 07:52:53 INFO - "script_repo_revision": "production", 07:52:53 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 07:52:53 INFO - "repository": "", 07:52:53 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 07:52:53 INFO - "buildid": "20160106053004", 07:52:53 INFO - "pgo_build": "True", 07:52:53 INFO - "basedir": "/builds/slave/test-pgo", 07:52:53 INFO - "buildnumber": 9, 07:52:53 INFO - "slavename": "talos-linux64-ix-019", 07:52:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:52:53 INFO - "platform": "ubuntu64_hw", 07:52:53 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 07:52:53 INFO - "branch": "b2g-inbound", 07:52:53 INFO - "repo_path": "integration/b2g-inbound", 07:52:53 INFO - "revision": "70ae39b770ed0c821f83c40823efbe8ad10708e5", 07:52:53 INFO - "stage_platform": "linux64-pgo", 07:52:53 INFO - "builduid": "cd2ecc82a6bf4ea9b41c4bd35eb268b1", 07:52:53 INFO - "slavebuilddir": "test" 07:52:53 INFO - } 07:52:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:52:53 INFO - Running post-action listener: _resource_record_post_action 07:52:53 INFO - ##### 07:52:53 INFO - ##### Running download-and-extract step. 07:52:53 INFO - ##### 07:52:53 INFO - Running pre-action listener: _resource_record_pre_action 07:52:53 INFO - Running main action method: download_and_extract 07:52:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:52: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')]} 07:52:53 INFO - https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/test_packages.json 07:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/test_packages.json 07:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:52:53 INFO - Downloaded 1302 bytes. 07:52:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:52:53 INFO - Using the following test package requirements: 07:52:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:52:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'jsshell-linux-x86_64.zip'], 07:52:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:52:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:52:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:52:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:52:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:52:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:52: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')]} 07:52:53 INFO - https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:55 INFO - Downloaded 24054411 bytes. 07:52:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:52:56 INFO - Return code: 0 07:52:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:56 INFO - https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:58 INFO - Downloaded 24054411 bytes. 07:52:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:52:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:53:00 INFO - Return code: 0 07:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:00 INFO - https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:53:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:53:01 INFO - Downloaded 11132285 bytes. 07:53:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:53:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:53:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:53:01 INFO - Return code: 0 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:01 INFO - https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:53:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:53:06 INFO - Downloaded 55065405 bytes. 07:53:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:06 INFO - mkdir: /builds/slave/test-pgo/properties 07:53:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:53:06 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:53:06 INFO - Contents: 07:53:06 INFO - build_url:https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:53:06 INFO - Running post-action listener: _resource_record_post_action 07:53:06 INFO - Running post-action listener: set_extra_try_arguments 07:53:06 INFO - ##### 07:53:06 INFO - ##### Running populate-webroot step. 07:53:06 INFO - ##### 07:53:06 INFO - Running pre-action listener: _resource_record_pre_action 07:53:06 INFO - Running main action method: populate_webroot 07:53:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:53:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:53:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:53:06 INFO - '--tppagecycles', 07:53:06 INFO - '7'], 07:53:06 INFO - 'tests': ['tsvgm']}}, 07:53:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:53:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:53:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:53:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:53:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'tests': ['damp', 'tps']}, 07:53:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['damp', 'tps']}, 07:53:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:53:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:53:06 INFO - 'other': {'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'other_l64': {'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'other_nol64': {'tests': ['a11yr', 07:53:06 INFO - 'ts_paint', 07:53:06 INFO - 'tpaint', 07:53:06 INFO - 'sessionrestore', 07:53:06 INFO - 'sessionrestore_no_auto_restore']}, 07:53:06 INFO - 'svgr': {'tests': ['tsvgx', 07:53:06 INFO - 'tsvgr_opacity', 07:53:06 INFO - 'tart', 07:53:06 INFO - 'tscrollx', 07:53:06 INFO - 'cart']}, 07:53:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['tsvgx', 07:53:06 INFO - 'tsvgr_opacity', 07:53:06 INFO - 'tart', 07:53:06 INFO - 'tscrollx', 07:53:06 INFO - 'cart']}, 07:53:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'tests': ['tp5o']}, 07:53:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'talos_options': ['--e10s'], 07:53:06 INFO - 'tests': ['tp5o']}, 07:53:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'talos_options': ['--xperf_path', 07:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:06 INFO - 'tests': ['tp5n']}, 07:53:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:53:06 INFO - 'talos_options': ['--e10s', 07:53:06 INFO - '--xperf_path', 07:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:53:06 INFO - 'tests': ['tp5n']}}, 07:53:06 INFO - 'talos.zip': {'path': '', 07:53:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:53:06 INFO - Running post-action listener: _resource_record_post_action 07:53:06 INFO - ##### 07:53:06 INFO - ##### Running create-virtualenv step. 07:53:06 INFO - ##### 07:53:06 INFO - Running pre-action listener: _resource_record_pre_action 07:53:06 INFO - Running main action method: create_virtualenv 07:53:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:53:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 07:53:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:53:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:53:06 INFO - Using real prefix '/usr' 07:53:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:53:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:08 INFO - Installing pip.................done. 07:53:08 INFO - Return code: 0 07:53:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:53:08 INFO - Using env: {'DISPLAY': ':0', 07:53:08 INFO - 'HOME': '/home/cltbld', 07:53:08 INFO - 'LANG': 'en_US.UTF-8', 07:53:08 INFO - 'LANGUAGE': 'en_US:en', 07:53:08 INFO - 'LOGNAME': 'cltbld', 07:53:08 INFO - 'MAIL': '/var/mail/cltbld', 07:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:08 INFO - 'MOZ_NO_REMOTE': '1', 07:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:08 INFO - 'NO_EM_RESTART': '1', 07:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:08 INFO - 'SHELL': '/bin/bash', 07:53:08 INFO - 'SHLVL': '1', 07:53:08 INFO - 'TERM': 'linux', 07:53:08 INFO - 'TMOUT': '86400', 07:53:08 INFO - 'USER': 'cltbld', 07:53:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:08 INFO - '_': '/tools/buildbot/bin/python'} 07:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:53:08 INFO - Cleaning up... 07:53:08 INFO - Return code: 0 07:53:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:53:08 INFO - Using env: {'DISPLAY': ':0', 07:53:08 INFO - 'HOME': '/home/cltbld', 07:53:08 INFO - 'LANG': 'en_US.UTF-8', 07:53:08 INFO - 'LANGUAGE': 'en_US:en', 07:53:08 INFO - 'LOGNAME': 'cltbld', 07:53:08 INFO - 'MAIL': '/var/mail/cltbld', 07:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:08 INFO - 'MOZ_NO_REMOTE': '1', 07:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:08 INFO - 'NO_EM_RESTART': '1', 07:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:08 INFO - 'SHELL': '/bin/bash', 07:53:08 INFO - 'SHLVL': '1', 07:53:08 INFO - 'TERM': 'linux', 07:53:08 INFO - 'TMOUT': '86400', 07:53:08 INFO - 'USER': 'cltbld', 07:53:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:08 INFO - '_': '/tools/buildbot/bin/python'} 07:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:09 INFO - Downloading/unpacking psutil>=0.7.1 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:53:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:53:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:11 INFO - Installing collected packages: psutil 07:53:11 INFO - Running setup.py install for psutil 07:53:11 INFO - building 'psutil._psutil_linux' extension 07:53:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:53:11 INFO - building 'psutil._psutil_posix' extension 07:53:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:11 INFO - Successfully installed psutil 07:53:11 INFO - Cleaning up... 07:53:11 INFO - Return code: 0 07:53:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:11 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:53:11 INFO - Using env: {'DISPLAY': ':0', 07:53:11 INFO - 'HOME': '/home/cltbld', 07:53:11 INFO - 'LANG': 'en_US.UTF-8', 07:53:11 INFO - 'LANGUAGE': 'en_US:en', 07:53:11 INFO - 'LOGNAME': 'cltbld', 07:53:11 INFO - 'MAIL': '/var/mail/cltbld', 07:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:11 INFO - 'MOZ_NO_REMOTE': '1', 07:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:11 INFO - 'NO_EM_RESTART': '1', 07:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:11 INFO - 'SHELL': '/bin/bash', 07:53:11 INFO - 'SHLVL': '1', 07:53:11 INFO - 'TERM': 'linux', 07:53:11 INFO - 'TMOUT': '86400', 07:53:11 INFO - 'USER': 'cltbld', 07:53:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:11 INFO - '_': '/tools/buildbot/bin/python'} 07:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:53:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:13 INFO - Installing collected packages: mozsystemmonitor 07:53:13 INFO - Running setup.py install for mozsystemmonitor 07:53:13 INFO - Successfully installed mozsystemmonitor 07:53:13 INFO - Cleaning up... 07:53:13 INFO - Return code: 0 07:53:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', '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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:53: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 blobuploader==1.2.4 07:53:13 INFO - Using env: {'DISPLAY': ':0', 07:53:13 INFO - 'HOME': '/home/cltbld', 07:53:13 INFO - 'LANG': 'en_US.UTF-8', 07:53:13 INFO - 'LANGUAGE': 'en_US:en', 07:53:13 INFO - 'LOGNAME': 'cltbld', 07:53:13 INFO - 'MAIL': '/var/mail/cltbld', 07:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:13 INFO - 'MOZ_NO_REMOTE': '1', 07:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:13 INFO - 'NO_EM_RESTART': '1', 07:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:13 INFO - 'SHELL': '/bin/bash', 07:53:13 INFO - 'SHLVL': '1', 07:53:13 INFO - 'TERM': 'linux', 07:53:13 INFO - 'TMOUT': '86400', 07:53:13 INFO - 'USER': 'cltbld', 07:53:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:13 INFO - '_': '/tools/buildbot/bin/python'} 07:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:13 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:15 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:53:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:53:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:53:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:16 INFO - Downloading docopt-0.6.1.tar.gz 07:53:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:53:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:16 INFO - Running setup.py install for blobuploader 07:53:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:53:16 INFO - Running setup.py install for requests 07:53:16 INFO - Running setup.py install for docopt 07:53:16 INFO - Successfully installed blobuploader requests docopt 07:53:16 INFO - Cleaning up... 07:53:16 INFO - Return code: 0 07:53:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:16 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:53:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:16 INFO - Using env: {'DISPLAY': ':0', 07:53:16 INFO - 'HOME': '/home/cltbld', 07:53:16 INFO - 'LANG': 'en_US.UTF-8', 07:53:16 INFO - 'LANGUAGE': 'en_US:en', 07:53:16 INFO - 'LOGNAME': 'cltbld', 07:53:16 INFO - 'MAIL': '/var/mail/cltbld', 07:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:16 INFO - 'MOZ_NO_REMOTE': '1', 07:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:16 INFO - 'NO_EM_RESTART': '1', 07:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:16 INFO - 'SHELL': '/bin/bash', 07:53:16 INFO - 'SHLVL': '1', 07:53:16 INFO - 'TERM': 'linux', 07:53:16 INFO - 'TMOUT': '86400', 07:53:16 INFO - 'USER': 'cltbld', 07:53:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:16 INFO - '_': '/tools/buildbot/bin/python'} 07:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:17 INFO - Running setup.py (path:/tmp/pip-zgcjBc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:17 INFO - Running setup.py (path:/tmp/pip-z0Hjgr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:17 INFO - Running setup.py (path:/tmp/pip-z2SKqR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:17 INFO - Running setup.py (path:/tmp/pip-MBDnlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:17 INFO - Running setup.py (path:/tmp/pip-FRbVd3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:17 INFO - Running setup.py (path:/tmp/pip-tki928-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:17 INFO - Running setup.py (path:/tmp/pip-WWpPfR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:17 INFO - Running setup.py (path:/tmp/pip-v7cmgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:17 INFO - Running setup.py (path:/tmp/pip-d8uwV7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:17 INFO - Running setup.py (path:/tmp/pip-_boxZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:17 INFO - Running setup.py (path:/tmp/pip-AEC9I8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:17 INFO - Running setup.py (path:/tmp/pip-P0k_W_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:17 INFO - Running setup.py (path:/tmp/pip-go2HUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:17 INFO - Running setup.py (path:/tmp/pip-CSgJpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:18 INFO - Running setup.py (path:/tmp/pip-9W9P_j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:18 INFO - Running setup.py (path:/tmp/pip-LWmiWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:18 INFO - Running setup.py (path:/tmp/pip-M1BQhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:18 INFO - Running setup.py install for manifestparser 07:53:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:53:18 INFO - Running setup.py install for mozcrash 07:53:18 INFO - Running setup.py install for mozdebug 07:53:18 INFO - Running setup.py install for mozdevice 07:53:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:53:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:53:18 INFO - Running setup.py install for mozfile 07:53:18 INFO - Running setup.py install for mozhttpd 07:53:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:53:18 INFO - Running setup.py install for mozinfo 07:53:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:53:18 INFO - Running setup.py install for mozInstall 07:53:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Running setup.py install for mozleak 07:53:19 INFO - Running setup.py install for mozlog 07:53:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Running setup.py install for moznetwork 07:53:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Running setup.py install for mozprocess 07:53:19 INFO - Running setup.py install for mozprofile 07:53:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Running setup.py install for mozrunner 07:53:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:53:19 INFO - Running setup.py install for mozscreenshot 07:53:19 INFO - Running setup.py install for moztest 07:53:19 INFO - Running setup.py install for mozversion 07:53:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:53:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:20 INFO - Cleaning up... 07:53:20 INFO - Return code: 0 07:53:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:53:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:20 INFO - Using env: {'DISPLAY': ':0', 07:53:20 INFO - 'HOME': '/home/cltbld', 07:53:20 INFO - 'LANG': 'en_US.UTF-8', 07:53:20 INFO - 'LANGUAGE': 'en_US:en', 07:53:20 INFO - 'LOGNAME': 'cltbld', 07:53:20 INFO - 'MAIL': '/var/mail/cltbld', 07:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:20 INFO - 'MOZ_NO_REMOTE': '1', 07:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:20 INFO - 'NO_EM_RESTART': '1', 07:53:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:20 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:20 INFO - 'SHELL': '/bin/bash', 07:53:20 INFO - 'SHLVL': '1', 07:53:20 INFO - 'TERM': 'linux', 07:53:20 INFO - 'TMOUT': '86400', 07:53:20 INFO - 'USER': 'cltbld', 07:53:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:20 INFO - '_': '/tools/buildbot/bin/python'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:20 INFO - Running setup.py (path:/tmp/pip-TwxQrs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:20 INFO - Running setup.py (path:/tmp/pip-xXbii2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:20 INFO - Running setup.py (path:/tmp/pip-mkiEEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:20 INFO - Running setup.py (path:/tmp/pip-oqC96o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:20 INFO - Running setup.py (path:/tmp/pip-CqutrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:20 INFO - Running setup.py (path:/tmp/pip-5n0XZ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:20 INFO - Running setup.py (path:/tmp/pip-2H1RGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:20 INFO - Running setup.py (path:/tmp/pip-K4ApuY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:20 INFO - Running setup.py (path:/tmp/pip-fdStvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:53:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:20 INFO - Running setup.py (path:/tmp/pip-XpL35X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:21 INFO - Running setup.py (path:/tmp/pip-2WF4_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:21 INFO - Running setup.py (path:/tmp/pip-i2Fd_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:21 INFO - Running setup.py (path:/tmp/pip-8BuPhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:21 INFO - Running setup.py (path:/tmp/pip-PNfLc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:21 INFO - Running setup.py (path:/tmp/pip-oDh3ho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:21 INFO - Running setup.py (path:/tmp/pip-_nKi8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:53:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:21 INFO - Running setup.py (path:/tmp/pip-qLvd8p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:53:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:23 INFO - Downloading blessings-1.5.1.tar.gz 07:53:23 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:53:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:23 INFO - Installing collected packages: blessings 07:53:23 INFO - Running setup.py install for blessings 07:53:23 INFO - Successfully installed blessings 07:53:23 INFO - Cleaning up... 07:53:23 INFO - Return code: 0 07:53:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:53:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:23 INFO - Reading from file tmpfile_stdout 07:53:23 INFO - Current package versions: 07:53:23 INFO - argparse == 1.2.1 07:53:23 INFO - blessings == 1.5.1 07:53:23 INFO - blobuploader == 1.2.4 07:53:23 INFO - docopt == 0.6.1 07:53:23 INFO - manifestparser == 1.1 07:53:23 INFO - mozInstall == 1.12 07:53:23 INFO - mozcrash == 0.16 07:53:23 INFO - mozdebug == 0.1 07:53:23 INFO - mozdevice == 0.47 07:53:23 INFO - mozfile == 1.2 07:53:23 INFO - mozhttpd == 0.7 07:53:23 INFO - mozinfo == 0.9 07:53:23 INFO - mozleak == 0.1 07:53:23 INFO - mozlog == 3.1 07:53:23 INFO - moznetwork == 0.27 07:53:23 INFO - mozprocess == 0.22 07:53:23 INFO - mozprofile == 0.28 07:53:23 INFO - mozrunner == 6.11 07:53:23 INFO - mozscreenshot == 0.1 07:53:23 INFO - mozsystemmonitor == 0.0 07:53:23 INFO - moztest == 0.7 07:53:23 INFO - mozversion == 1.4 07:53:23 INFO - psutil == 3.1.1 07:53:23 INFO - requests == 1.2.3 07:53:23 INFO - wsgiref == 0.1.2 07:53:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:53:23 INFO - Using env: {'DISPLAY': ':0', 07:53:23 INFO - 'HOME': '/home/cltbld', 07:53:23 INFO - 'LANG': 'en_US.UTF-8', 07:53:23 INFO - 'LANGUAGE': 'en_US:en', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MAIL': '/var/mail/cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SHLVL': '1', 07:53:23 INFO - 'TERM': 'linux', 07:53:23 INFO - 'TMOUT': '86400', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - '_': '/tools/buildbot/bin/python'} 07:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:53:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:53:23 INFO - Cleaning up... 07:53:23 INFO - Return code: 0 07:53:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:23 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:53:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:53:23 INFO - Using env: {'DISPLAY': ':0', 07:53:23 INFO - 'HOME': '/home/cltbld', 07:53:23 INFO - 'LANG': 'en_US.UTF-8', 07:53:23 INFO - 'LANGUAGE': 'en_US:en', 07:53:23 INFO - 'LOGNAME': 'cltbld', 07:53:23 INFO - 'MAIL': '/var/mail/cltbld', 07:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:23 INFO - 'MOZ_NO_REMOTE': '1', 07:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:23 INFO - 'NO_EM_RESTART': '1', 07:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:23 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:23 INFO - 'SHELL': '/bin/bash', 07:53:23 INFO - 'SHLVL': '1', 07:53:23 INFO - 'TERM': 'linux', 07:53:23 INFO - 'TMOUT': '86400', 07:53:23 INFO - 'USER': 'cltbld', 07:53:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:23 INFO - '_': '/tools/buildbot/bin/python'} 07:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:24 INFO - Downloading/unpacking jsonschema 07:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:53:25 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:53:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:26 INFO - warning: no files found matching '*.txt' 07:53:26 INFO - no previously-included directories found matching 'build' 07:53:26 INFO - no previously-included directories found matching 'dist' 07:53:26 INFO - no previously-included directories found matching '.git*' 07:53:26 INFO - Installing collected packages: jsonschema, functools32 07:53:26 INFO - Running setup.py install for functools32 07:53:26 INFO - warning: no files found matching '*.txt' 07:53:26 INFO - no previously-included directories found matching 'build' 07:53:26 INFO - no previously-included directories found matching 'dist' 07:53:26 INFO - no previously-included directories found matching '.git*' 07:53:26 INFO - Successfully installed jsonschema functools32 07:53:26 INFO - Cleaning up... 07:53:26 INFO - Return code: 0 07:53:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:26 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 0x7ff581c3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b37630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:53:26 INFO - Using env: {'DISPLAY': ':0', 07:53:26 INFO - 'HOME': '/home/cltbld', 07:53:26 INFO - 'LANG': 'en_US.UTF-8', 07:53:26 INFO - 'LANGUAGE': 'en_US:en', 07:53:26 INFO - 'LOGNAME': 'cltbld', 07:53:26 INFO - 'MAIL': '/var/mail/cltbld', 07:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:26 INFO - 'MOZ_NO_REMOTE': '1', 07:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:26 INFO - 'NO_EM_RESTART': '1', 07:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:26 INFO - 'SHELL': '/bin/bash', 07:53:26 INFO - 'SHLVL': '1', 07:53:26 INFO - 'TERM': 'linux', 07:53:26 INFO - 'TMOUT': '86400', 07:53:26 INFO - 'USER': 'cltbld', 07:53:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:26 INFO - '_': '/tools/buildbot/bin/python'} 07:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:26 INFO - Downloading/unpacking flake8 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:53:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:53:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:53:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:53:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:53:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:29 INFO - no previously-included directories found matching 'docs/_build' 07:53:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:53:29 INFO - Running setup.py install for pep8 07:53:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:29 INFO - no previously-included directories found matching 'docs/_build' 07:53:29 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:53:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:53:29 INFO - Cleaning up... 07:53:29 INFO - Return code: 0 07:53:29 INFO - Running post-action listener: _resource_record_post_action 07:53:29 INFO - Running post-action listener: _start_resource_monitoring 07:53:29 INFO - Starting resource monitoring. 07:53:29 INFO - ##### 07:53:29 INFO - ##### Running install step. 07:53:29 INFO - ##### 07:53:29 INFO - Running pre-action listener: _resource_record_pre_action 07:53:29 INFO - Running main action method: install 07:53:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:29 INFO - Reading from file tmpfile_stdout 07:53:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:53:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:53:29 INFO - Reading from file tmpfile_stdout 07:53:29 INFO - Output received: 07:53:29 INFO - Usage: mozinstall [options] installer 07:53:29 INFO - Options: 07:53:29 INFO - -h, --help show this help message and exit 07:53:29 INFO - -d DEST, --destination=DEST 07:53:29 INFO - Directory to install application into. [default: 07:53:29 INFO - "/builds/slave/test-pgo"] 07:53:29 INFO - --app=APP Application being installed. [default: firefox] 07:53:29 INFO - mkdir: /builds/slave/test-pgo/build/application 07:53:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:53:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:53:45 INFO - Reading from file tmpfile_stdout 07:53:45 INFO - Output received: 07:53:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:53:45 INFO - Running post-action listener: _resource_record_post_action 07:53:45 INFO - ##### 07:53:45 INFO - ##### Running run-tests step. 07:53:45 INFO - ##### 07:53:45 INFO - Running pre-action listener: _resource_record_pre_action 07:53:45 INFO - Running main action method: run_tests 07:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:53:45 INFO - Python 2.7.3 07:53:45 INFO - Return code: 0 07:53:45 INFO - grabbing minidump binary from tooltool 07:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:45 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 0x1bc8840>, '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 0x1b356b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b35b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:53:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:53:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:53:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:45 INFO - Return code: 0 07:53:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:53:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:53:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:53:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:53:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:53:46 INFO - Return code: 0 07:53:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:53:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:53:46 INFO - Using env: {'DISPLAY': ':0', 07:53:46 INFO - 'HOME': '/home/cltbld', 07:53:46 INFO - 'LANG': 'en_US.UTF-8', 07:53:46 INFO - 'LANGUAGE': 'en_US:en', 07:53:46 INFO - 'LOGNAME': 'cltbld', 07:53:46 INFO - 'MAIL': '/var/mail/cltbld', 07:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:46 INFO - 'MOZ_NO_REMOTE': '1', 07:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:46 INFO - 'NO_EM_RESTART': '1', 07:53:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:53:46 INFO - 'SHELL': '/bin/bash', 07:53:46 INFO - 'SHLVL': '1', 07:53:46 INFO - 'TERM': 'linux', 07:53:46 INFO - 'TMOUT': '86400', 07:53:46 INFO - 'USER': 'cltbld', 07:53:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680', 07:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:46 INFO - '_': '/tools/buildbot/bin/python'} 07:53:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:53:46 INFO - mozversion application_buildid: 20160106053004 07:53:46 INFO - mozversion application_changeset: 70ae39b770ed0c821f83c40823efbe8ad10708e5 07:53:46 INFO - mozversion application_display_name: Nightly 07:53:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:46 INFO - mozversion application_name: Firefox 07:53:46 INFO - mozversion application_remotingname: firefox 07:53:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 07:53:46 INFO - mozversion application_vendor: Mozilla 07:53:46 INFO - mozversion application_version: 46.0a1 07:53:46 INFO - mozversion platform_buildid: 20160106053004 07:53:46 INFO - mozversion platform_changeset: 70ae39b770ed0c821f83c40823efbe8ad10708e5 07:53:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 07:53:46 INFO - mozversion platform_version: 46.0a1 07:53:46 INFO - using testdate: 1452095626 07:53:46 INFO - actual date: 1452095626 07:53:46 INFO - starting webserver on 'localhost:54286' 07:53:46 INFO - SUITE-START | Running 3 tests 07:53:46 INFO - TEST-START | dromaeo_css 07:53:46 INFO - operating with platform_type : linux_ 07:53:46 INFO - Initialising browser for dromaeo_css test... 07:53:46 INFO - TEST-INFO | started process 20712 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu19aIB/profile http://localhost:54286/getInfo.html) 07:53:50 INFO - PROCESS | 20712 | __metrics Screen width/height:1600/1200 07:53:50 INFO - PROCESS | 20712 | colorDepth:24 07:53:50 INFO - PROCESS | 20712 | Browser inner width/height: 1024/697 07:53:50 INFO - PROCESS | 20712 | __metrics 07:53:50 INFO - PROCESS | 20712 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:53:50 INFO - PROCESS | 20712 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:52 INFO - TEST-INFO | 20712: exit 0 07:53:52 INFO - Browser initialized. 07:53:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:52 INFO - TEST-INFO | started process 20807 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu19aIB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:04 INFO - PROCESS | 20807 | RSS: Main: 150126592 07:54:04 INFO - PROCESS | 20807 | 07:54:55 INFO - PROCESS | 20807 | 1452095695526 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:57:03 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54286/tests/dromaeo/cssquery-ext.html) 07:57:05 INFO - PROCESS | 20807 | RSS: Main: 252485632 07:57:05 INFO - PROCESS | 20807 | 08:00:07 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-ext.html (next: http://localhost:54286/tests/dromaeo/cssquery-jquery.html) 08:00:08 INFO - PROCESS | 20807 | RSS: Main: 234393600 08:00:08 INFO - PROCESS | 20807 | 08:03:10 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54286/tests/dromaeo/cssquery-mootools.html) 08:03:10 INFO - PROCESS | 20807 | RSS: Main: 230055936 08:03:10 INFO - PROCESS | 20807 | 08:06:12 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54286/tests/dromaeo/cssquery-prototype.html) 08:06:13 INFO - PROCESS | 20807 | RSS: Main: 216010752 08:06:13 INFO - PROCESS | 20807 | 08:09:15 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54286/tests/dromaeo/cssquery-yui.html) 08:09:16 INFO - PROCESS | 20807 | RSS: Main: 219611136 08:09:16 INFO - PROCESS | 20807 | 08:12:18 INFO - PROCESS | 20807 | Cycle 1(1): loaded http://localhost:54286/tests/dromaeo/cssquery-yui.html (next: http://localhost:54286/tests/dromaeo/cssquery-dojo.html) 08:12:19 INFO - PROCESS | 20807 | RSS: Main: 273526784 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | __start_tp_report 08:12:19 INFO - PROCESS | 20807 | _x_x_mozilla_page_load 08:12:19 INFO - PROCESS | 20807 | _x_x_mozilla_page_load_details 08:12:19 INFO - PROCESS | 20807 | |i|pagename|runs| 08:12:19 INFO - PROCESS | 20807 | |0;dojo.html;3017.668056513783;3117.018139286126;3157.8894738684135;3160.7471402287806;3170.936581268374;5114.28400023997;5217.191335343018;5263.447338029505;5300.310959575249;5340.679559226444;5217.3217481727415;5253.500917412849;5256.132738098218;5260.105782017066;5351.438098999607;4678.836240731575;4741.8814529636775;4766.499517550659;4912.189488734354;4930.580900623433;4854.975725121387;4868.975655121737;4915.901681966377;4927.310176575283;4931.704097754128;4652.278896771006;4703.482616912137;4731.881702957437;4761.738104404257;4770.117528257283;4800.615950723934;4805.807767689288;4840.1771698810935;4840.540148685869;4850.902981940341;4752.6910750801435;4792.808287668489;4801.1117943180625;4808.110499557558;4868.294097355899;4878.853634390974;4967.329410529568;4999.925001124986;5085.567726743194;5164.406093299281;5619.8595035124445;5627.240322556484;5630.0991841305195;5640.5769567282205;5649.435056494359;5663.745131469093;5667.206591077212;5671.234383358235;5679.375268720438;5686.857828554319;5147.305113809625;5245.396779370345;5248.816291429782;5249.160134378481;5306.416294207634;5777.19119323295;5787.189793428924;5803.709814509258;5825.941740582624;5837.941620583825;5517.531009864207;5518.751656175482;5518.972405137949;5548.167774833726;5566.276384070045;5362.570994320445;5482.780688772485;5579.888402231933;5620.269364982526;5641.971790141023;5509.669419834822;5558.916616250759;5601.075822489325;5605.467480589337;5613.635113717677;5560.443955604407;5591.30108736408;5594.1608758686525;5596;5599.132134519156;4225.070484493406;4336.219480493542;4339.479262488521;4344.326629372453;4345.196138714348;3821.2357528494413;3868.4777555030273;3881.7865017423746;3891.5330160380936;3902;5213.061648903158;5249.7112658804135;5250.527452529291;5252.65857719247;5254.264402983586;5382.677039377571;5474.972625136849;5603.243562119062;5640.661560306395;5700.828975130753;5148.330717006766;5178.559822415137;5243.632945693765;5259.421463638997;5276.261323414725;4813.687110337817;4829.879253018632;4831.4685384607665;4844.8304309349705;4883.02339532095;5749.3963133871175;5770.019096753562;5770.19217309577;5772.682502462405;5779.190913272145;5496.560275178056;5599.692016939108;5601.6358936668985;5645.096784514458;5744.253247077853;5821.505172060422;5822.82531524055;5833.300003999547;5844.12338149281;5847.1229315603;5591.748371323219;5594.888102237851;5604;5606.495415412633;5610.242617246619;5423.132298832168;5434.891302174014;5548.306461692288;5578.60949733531;5585.022621041383;5508.834734957958;5520.420355862577;5545.195946587803;5546.084895992116;5557.610967232255;5496.065668836387;5531.253280807039;5531.861703457445;5535.280413546213;5581.162825576196;5251.553617942518;5337.386200586982;5346.064438723286;5350.010248104113;5430.185472179205;5486.945130548644;5490.69801160924;5500.4224556420995;5503.394626591152;5551.25058117149;5339.439358867263;5347.144456887035;5355.78576856937;5361.678299302054;5368.624196306221 08:12:19 INFO - PROCESS | 20807 | |1;ext.html;536.8979893820174;537.5699440447644;557.2950217974262;560.6888177061729;572.8138355034615;27456;28027.85986070072;28040;34208.65791342086;35214.82392588034;40482.39276410856;41250.587494125124;41272.58727412725;41292.38061429081;41342;8478.957605211981;8657.653693852239;8667.003294621105;8668.783280418009;8672.56637168139;7438.851222975537;7512.511686740371;7551.773446796577;7561;9960.750981225456;9931.702048938543;10026.699199024004;10030.448325342104;10037.146842518394;10044.045815647502;9878.950605246999;9924.652637157666;10024.59901603935;10044.497775111251;10045.949770251102;7350.705971761123;7482.21436749139;9939.70180894567;10139.340942838691;10151.137153341975;33791.15522111942;34158.6584134158;34210.48684269738;34241.82879085613;34299.82850085734;3140.984295078533;3249.9350012999607;3362.3947689415895;3520.4367301231937;4033.8588149414923;27233.86383068072;27457;27923.162305130878;28295.033910516067;28525.714742852513;3867.3038853006447;4016.49793775778;4030.7984600769846;4034.899127521806;4123.257813593552;244604;246360;246470;246823;247956.9999999982;58182;58567;58591.414085858596;58774;58849.41150588525;54272.45727542674;55634;61010.38989610136;61504;62227;13951.511697090553;14083.43666253359;14107.647308817157;14195.077319974169;14213.50252741149;10697.197710171768;10709.78580428387;10720.410377429316;10766.676999690022;10786.676399708022;17244;17791.555211119827;19814.900925495567;19979.900100499406;20175.697364539545;7675.731349402744;7792.571408572469;7803.453758236869;7808.336291415293;7938.166492518318;892.3396686451979;898.2723993565234;927.9118483744033;941.8493041113389;1014.7666036811574;25310.36724081876;25407.491850162893;25442.363940901254;25705.228843134362;26089.347766305993;1035.223582313265;1053.994730026345;1105.1545567640762;1142.3146112332533;1190.2739329009298;12921.547745828851;13534.86465135336;13599.52401665937;13672.863271367358;13767.38046787897;366768;368721;369309;370136.5972680585;370804;50310.24534631983;50762.74618626883;50801.74599126981;50853.49146508487;50907;1333.5732565579115;1336.73265346931;1343.4156142078227;1347.2522749873915;1355.390074466494;24896.502069958136;26651.466970660866;26853.731462685122;26961.73038269592;26972.730272697023;40864;41438.79280603577;41564;41830;41950.16099677928;306333;310311;311450;312742;313202;28814.423711526073;28837.134885952615;29175.854120729262;29497.557536636537;29537.409251815272;38636.6136338633;39067;39452.40821387739;39551.60448395479;39781;33994.83002584971;34886;35212.64787352094;35282.823585882936;37220;33687.4946875802;35380.823095884356;35422.291554169286;35611.465828012086;36123.458148127276;34578;34736.82631586826;39330.213395731356;39997.60002399939;40034.79982600185;29861.850690747277;32097.35805283928;32433.837830810695;32675.732426757135;32725.836370817993;24123.69900705787;24526.754732453162;24630.630540542264;24674.753252467246;24868.12961546337 08:12:19 INFO - PROCESS | 20807 | |2;jquery.html;353.57570914902124;355.829201983048;357.44060545246685;358.7309517861604;359.1703165687261;13410.798838017437;13733;15854.762178567316;15910.363585456582;16253.349866005346;15667.60830979226;15781.763273550878;16507.83492165078;16580.336786528525;16623.335066597352;5158.252053452247;5434.538064264522;5437.34751829781;5442.183672449144;5444.673319600817;4030.1939612077704;4118.341065429532;5386.192071189334;5845.415458454142;6056.242969628796;5967.224260846084;5980.043193089106;5996.100584912255;6007.519398448114;6011.158437818709;5782.479576838084;5831.79588714393;5898.705064746746;5902.203202567642;5907.113932910076;5119.052975199563;5197.7920883164625;5203.19350500673;5207.244949482304;5209.817656382046;20497.4875628109;20744;20796.48008799777;20796.48008799777;20849.89575052115;2203.3500117465387;2272.3523795718143;2278.5898538263104;2336.6144586143264;2393.3059412770276;11815.763684726257;12086.214396064228;12205.511779528808;12346.38268086601;12662.240265584001;1596.1380854338643;1600.1439230012004;1607.5820286725418;1679.4129547577545;1691.5348279223313;53658;55125.72437137789;56740.716296418665;59396.40603593952;59748.40251597472;9710.805783884283;9738.610455581698;9783.608655653836;9863.358881672812;9973.850392244121;13059.21644701321;13085.149465284727;13087.738245235232;13101.803472947913;13105.606831795061;7455.105387353552;7509.173990861001;7514.248575142551;7558.055243094614;7565.73519926811;7261.818454538678;7430.96284518574;7476.1776204617445;7543.434242431839;7548.8490230196185;4409.140217657526;4460.264056430718;4461.174682683714;4504.504504504502;4505.256632655575;1607.823139454659;1684.6462242929122;1804.4857215693726;1838.6648955826026;1845.2895635180284;874.5408660453313;922.0134456131874;948.8102379523984;988.4958671077802;1018.0430395428274;16527.173641317888;17020.31918723262;17032.914835425745;17152.914235428743;17350.219240134225;875.8628945373268;916.6196028648036;948.2556193388157;956.5934477846887;975.3855071305032;8839.955800221087;9131.680391186277;9455.621775129055;9960.252981026451;9998.500074996222;136534;136830;136835.31582342225;272465;555706;74885.25114748892;74919.62540187374;79587;79735.62775908562;81368.59315703383;1109.4951796932376;1138.1861968692424;1152.3489228585654;1155.058627218814;1156.3351073132983;14832.480863169738;15279.618009549406;15382.307796149424;15579.766303505683;15707.607309817346;31321.686783131878;31649.20876978094;31980.36039279155;33829.3234135311;36316.636833631324;42107;42257.78871105625;42322;43305.35041974436;45528.54471455243;9432.575534101119;9562.28282878773;9600.66397676078;9703.223742100756;9714.417134971924;12235.69410764738;12407;18067;18113.909430452764;18416.079196039875;11894.167408281683;13493.190408575518;13788.724225515634;13924.930375348058;14699.044562103429;11029.338239705643;14019.228942408265;14501.637459063608;14652.70694586081;14776.556703298918;14615.269236538343;15069.397224110913;15146.242687865342;15372.461963831212;15397.07617542951;9648.179904708179;9680;9709.465979371202;9761.365511241747;9764.072413120743;10205.132563732166;10836.837447438136;13863;13939.09395889264;15088 08:12:19 INFO - PROCESS | 20807 | |3;mootools.html;1318.0575888239907;1413.3074793351257;1414.837293711223;1557.4159690116207;1809.0773705410236;6934.44524438045;7513.2486751324905;7607.505512141707;7624.123225829031;7628.885566716497;7462.328390444873;7592.696292148321;7659.578723170223;7725.652345644446;7729.227077292268;1971.5366888781125;1999.330224374829;2167.2631305356176;2187.5406164705432;2204.030226700255;2266.3880752196897;2276.2147059264526;2276.829237807163;2277.567262220173;2278.5556816420803;2160.459885028743;2186.2020362567628;2187;2189.7591264960843;2193.243331050785;2187.1798075721604;2200.2629119244993;2224.63293556563;2225.5326381459913;2227.7326720793526;2230.397792596006;2238.149503188778;2260.457490202356;2265.920692775745;2267.7051983242236;7740.535567865946;7753.030871141107;7814.648340824677;7822.217778222189;7824.021997250344;4572.702774319659;4651.976740116278;4663.953360466386;4674.532546745332;4684.578387945101;3003.4293484237924;3030.5151175811984;3057.6942305769244;3061.2499937515227;3114.4394009078583;939.76036110792;954.0888451528773;1001.689476262361;1013.7871047080122;1035.9067683908484;10723.14214862809;10725.731856703645;10739.033486986209;10758.623448179276;10817.621383251628;4071.42999980003;4163.895902602399;4189.6229339359;4191.3293872980175;4206.26390381682;9215.49314787693;9225.261979041661;9237.861432078524;9239.214666753267;9247.583858726373;4723.48041715411;4730.172219861511;4733.928991065137;4739.857804265877;4740;4282.593153650399;4295.098029413795;4300.247456695066;4304.5480224576595;4305.160493703697;3317.0878008547843;3361.3949489092197;3545.4150065239464;3566.2154326048226;3590.8204589770407;1142.7600203957095;1159.2233203753337;1168.1705988748083;1171.917965742407;1183.8875306845837;1012.6202673997251;1014.5181039006413;1081.291753901196;1162.2503485251966;1348.1708749119416;7342.155652100077;7375.114986201583;7446;7456.589887556236;7461.403087752967;1081.3403823667556;1090.2804149261449;1091.2415870969758;1094.7865166292656;1100.7138144082596;5734;5845.678487683218;5880.617759845596;5881.147233651097;5891.116332550066;9173.58718857653;9267.814643707088;9473.715788526355;9517.952410237904;9610.423374597547;9395.436273823592;9481.573329200202;9499.857502137473;9539.713808585753;9540.666076687283;7316.085489313836;7415.5179913305465;7428.10862696469;7428.888566671504;7445.851082978418;7106.182788979334;7166;7178.138623365229;7195.640217989185;7198.8841729532005;8198.549079800669;8296.792580185302;8522.957385213034;8556.058833528183;8570.442921210102;8591.44155629882;8624.78438039054;8725.258353040063;8759.868601970848;8767.386282960131;6777.186737591323;6826.624535650389;6848.417884479875;6856.691448884712;6869.965650171717;6678.866422671616;6817.829554260985;7252.129744430702;7401.59291238987;7403.96298018528;7004.614746188805;7096.325849044332;7119.2524784898915;7141.250168732208;7145.535540189871;7000.544964577286;7014.5440546364325;7060.6116663584;7132.786016419515;7140.607266600179;6795.286494917962;6950.93049069523;6973.47698922593;6984.7206111757;7037.577745335091;6473.158489396348;6516.73933042673;6519.674016299071;6523.858324793047;6533.901991470037;6544.770933017321;6548.443382312366;6563.113979612691;6567.211934567882;6593.142891424084 08:12:19 INFO - PROCESS | 20807 | |4;prototype.html;333.9547217210132;337.5240910316454;339.45009085281816;342.125868406222;344.8310327939309;5776.162456443813;5802.535797136229;5806.535477161833;5821.825345239639;5918.4081591840795;5677.772889084432;5804.651720896749;5819.9418005819925;5829.854253643661;5831.679257640828;4478.686491945565;4480.887977800565;4486.371907932892;4493.438320209973;4497.280435130388;4307.806148723315;4380.408644832954;4385.232584297735;4385.780710964439;4483.6861419700635;4347.500037495697;4377.365282034119;4476.328550717402;4497.370368148462;4498.145352383053;4467.5755803198645;4475.641948644101;4480.462344518646;4486.3046227834575;4505.076459325846;3959;3963.7027222958104;3966.0679740261016;3970.5235371755575;3979.641832235113;5433.646812957145;5572.804951826707;5592.0773072443;5597.608167428281;5600.579956503238;5165.870853228662;5178.119719647669;5190.351206099238;5196.6881987080515;5196.870078248036;5905.4685078343155;6186.072089186613;6201.379862013762;6203.565750397474;6210.968945155245;4203.243416185085;4233.703640745149;4287.978560107211;4329.63616460817;4341.630961368288;6430.421262086435;6482.611043337415;6494.188226471691;6495.4803615710625;6506.2843087260835;4419.226635338803;4423.955760442354;4424.269995450714;4432.312991486325;4433.423654924839;4322.7190232634775;4466.307722303049;4477.3731677565165;4482.596566309048;4482.843100491467;5149.871253218625;5154.484551544891;5154.871128221825;5189.040027594831;5194.844154675366;6255.311915689271;6255.593386429868;6259.436650701458;6267.2479302484;6268.435840774352;1574.795276614033;1590.8091029076354;1593.1158207194887;1593.9521814345587;1594.3224129745045;1060.8408738689259;1069.1179776684266;1072.8122578548723;1087.141158484804;1092.2736380307008;5928.67392293428;5933.792317268962;5938.673372964442;5940.61386009908;5943.851403714942;6415.743370265231;6421.3578642136345;6421.51838612106;6427.421532062137;6448.935510644834;5904.143899134688;5924.792632257937;5926.822195334147;5928.08114742207;5934.258217722785;3405.4721518164724;3492.5808902931813;3499.9125021874656;3501.8949431517094;3504.3166582516164;6628.8674226515195;6665.966670166618;6680.3987641112535;6686.465082793365;6692.5984440932725;6581.670916454158;6596.703148358335;6631.071649969008;6662.100616416818;6663.100481434944;6420.486361091102;6579.80260592183;6604.4056034955165;6634.137562116894;6651.301613330627;6208.751649933952;6361.236651601653;6470.547061705635;6479.7408103675325;6480.935190648222;6230.314665386713;6333.145025421509;6338.778142764981;6357.777477788255;6358.078078678658;6558.508111891722;6570.868582628225;6622.1722284714415;6640.468762499085;6642.568233064835;4296.226679197649;4400.317950717644;4435.689501734848;4441.755703436342;4442.711223770445;6398.744050238124;6412.230532335963;6415.166028416276;6426.710798014007;6426.807195784134;6183.196184496167;6191.597546159485;6208.192934918612;6208.72060757258;6224.097505861715;6081.118237855575;6188.164597779242;6191.721372538156;6197.876042479035;6202.976508875985;6138.294096178818;6157.384261573807;6164.106204600397;6181.134641150333;6184.010558310649;6322.146510221061;6332.683365831782;6342.39747224013;6342.524310676626;6348.174737284124;6099.786507472217;6139.26328840542;6167.105769663463;6197.597156184834;6197.938020619736 08:12:19 INFO - PROCESS | 20807 | |5;yui.html;758.1546575568243;760.1752098972615;806.3790881021614;817.4727300890926;860.9784755381119;13154.07921445498;13304.800427993576;13389.464421423132;13415.060945733803;13427.798583021262;12589.937050314735;12612.62162135135;12643.49426022958;12665;12684.30236337001;650.3723906430293;661.4311691944923;662.3211208511266;786.8190316227272;796.366888323784;652.6997581112694;784.0591290451453;804.4007214625112;806.6773290683715;807.7011505742884;851.3146916732028;855.1533981358473;857.9613917373701;858.0175698824842;859.0936561927165;847.8473874702551;848.6308455821737;849.4223927729141;850.3792231670853;851.3657325292666;507.2214151277771;511.91809310510513;611.4710775179482;615.0988801405917;616.0020766358483;12809.423575939105;12838.679033024157;12842;12848;12868;11081.10124598972;11650.708732281675;11682.474288657031;11733.187534171628;11911;9934.304598678096;10079.244056695778;10279.691609251735;10312.587496500206;10614.310069845513;3590.9281814363826;3604.2070744436182;3613.1870329175727;3621.529201203853;3756.981215093907;46264.53735462636;46443.53556464426;46518.06963860704;46532.767336163444;46660.76669616664;9856.21150307988;10121.949390253149;10181.745456363502;10185.134263587677;10378.584856605803;18488.537786555444;18499.260029598936;18509.444716658523;18512.629747404975;18539.44381668552;7266.418686505172;7275.963620181865;7330.816729581697;7672.117706463828;7748.961255193688;3907.78507182102;3957.5053118360206;4066.674666026711;4415.735055896656;4527.230370836965;3084.0439463766306;3110.828904410279;3119.781615286908;3120.0639808057945;3121.828299443507;523.8926020165857;530.3476723629957;536.3992328591924;539.816462402785;549.5356423821864;567.6133493149977;586.8562202260473;673.8685956238585;696.0498918975663;720.1825927572244;7976.84046319082;8071.668710986222;8277.54473503951;8336.458130221516;8418.663253469915;650.4178760009764;677.993220067793;683.5010442377093;688.4939569416475;745.8620155271292;3808.3145033894166;4045.7977101144825;4073.246449406869;4329.826806927751;4424.292113261863;48757;49194.75402623036;49274;49285.50714492881;49428.752856235486;48773.26840097401;48986.26520602194;49230.261546076836;49316;49457.50542494601;42405.57594424078;44630.10739785251;45120.774396128465;45429.77285113619;45430.318545221846;8784;8886.73339799807;9006.369554131148;9040.728778136667;9083.18251357381;33385.49921751127;33515.83242083774;34088.82955585206;34246.14384640404;34542;42510.787446062575;43541.564584355016;43652.12695746131;43796.78101609471;44138.55861441473;10394.740131496774;10524.894751052392;10631.521581529005;10918.290311129751;11412.429378530875;12121.090978142374;12263.38683065861;12269.386530673251;12589.181703189264;12784.424700888669;11213.102951764002;11446.599369022377;11478.253913495597;11759.412029398667;11859.822102668639;11410.429478526206;11724.296542207494;11760.647180584596;11855.76288474243;12269.325187114795;11474.196806223485;11790.410479476164;11905.285682859056;12038.819417708917;12324.630261092181;9680.370775899544;9816.2147028239;10032.899671003197;10354.741131471774;10383;9208.263338932735;9547.331686782136;10066.929586476195;10073.798524029626;10081.848772268275 08:12:19 INFO - PROCESS | 20807 | __end_tp_report 08:12:19 INFO - PROCESS | 20807 | __start_cc_report 08:12:19 INFO - PROCESS | 20807 | _x_x_mozilla_cycle_collect,835 08:12:19 INFO - PROCESS | 20807 | __end_cc_report 08:12:19 INFO - PROCESS | 20807 | __startTimestamp1452096739118__endTimestamp 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | ------- Summary: start ------- 08:12:19 INFO - PROCESS | 20807 | Number of tests: 6 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#0] dojo.html Cycles:165 Average:5211.47 Median:5361.68 stddev:574.31 (10.7%) stddev-sans-first:549.68 08:12:19 INFO - PROCESS | 20807 | Values: 3017.7 3117.0 3157.9 3160.7 3170.9 5114.3 5217.2 5263.4 5300.3 5340.7 5217.3 5253.5 5256.1 5260.1 5351.4 4678.8 4741.9 4766.5 4912.2 4930.6 4855.0 4869.0 4915.9 4927.3 4931.7 4652.3 4703.5 4731.9 4761.7 4770.1 4800.6 4805.8 4840.2 4840.5 4850.9 4752.7 4792.8 4801.1 4808.1 4868.3 4878.9 4967.3 4999.9 5085.6 5164.4 5619.9 5627.2 5630.1 5640.6 5649.4 5663.7 5667.2 5671.2 5679.4 5686.9 5147.3 5245.4 5248.8 5249.2 5306.4 5777.2 5787.2 5803.7 5825.9 5837.9 5517.5 5518.8 5519.0 5548.2 5566.3 5362.6 5482.8 5579.9 5620.3 5642.0 5509.7 5558.9 5601.1 5605.5 5613.6 5560.4 5591.3 5594.2 5596.0 5599.1 4225.1 4336.2 4339.5 4344.3 4345.2 3821.2 3868.5 3881.8 3891.5 3902.0 5213.1 5249.7 5250.5 5252.7 5254.3 5382.7 5475.0 5603.2 5640.7 5700.8 5148.3 5178.6 5243.6 5259.4 5276.3 4813.7 4829.9 4831.5 4844.8 4883.0 5749.4 5770.0 5770.2 5772.7 5779.2 5496.6 5599.7 5601.6 5645.1 5744.3 5821.5 5822.8 5833.3 5844.1 5847.1 5591.7 5594.9 5604.0 5606.5 5610.2 5423.1 5434.9 5548.3 5578.6 5585.0 5508.8 5520.4 5545.2 5546.1 5557.6 5496.1 5531.3 5531.9 5535.3 5581.2 5251.6 5337.4 5346.1 5350.0 5430.2 5486.9 5490.7 5500.4 5503.4 5551.3 5339.4 5347.1 5355.8 5361.7 5368.6 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#1] ext.html Cycles:180 Average:46596.70 Median:34209.57 stddev:82204.47 (240.3%) stddev-sans-first:82362.33 08:12:19 INFO - PROCESS | 20807 | Values: 536.9 537.6 557.3 560.7 572.8 27456.0 28027.9 28040.0 34208.7 35214.8 40482.4 41250.6 41272.6 41292.4 41342.0 8479.0 8657.7 8667.0 8668.8 8672.6 7438.9 7512.5 7551.8 7561.0 9960.8 9931.7 10026.7 10030.4 10037.1 10044.0 9879.0 9924.7 10024.6 10044.5 10045.9 7350.7 7482.2 9939.7 10139.3 10151.1 33791.2 34158.7 34210.5 34241.8 34299.8 3141.0 3249.9 3362.4 3520.4 4033.9 27233.9 27457.0 27923.2 28295.0 28525.7 3867.3 4016.5 4030.8 4034.9 4123.3 244604.0 246360.0 246470.0 246823.0 247957.0 58182.0 58567.0 58591.4 58774.0 58849.4 54272.5 55634.0 61010.4 61504.0 62227.0 13951.5 14083.4 14107.6 14195.1 14213.5 10697.2 10709.8 10720.4 10766.7 10786.7 17244.0 17791.6 19814.9 19979.9 20175.7 7675.7 7792.6 7803.5 7808.3 7938.2 892.3 898.3 927.9 941.8 1014.8 25310.4 25407.5 25442.4 25705.2 26089.3 1035.2 1054.0 1105.2 1142.3 1190.3 12921.5 13534.9 13599.5 13672.9 13767.4 366768.0 368721.0 369309.0 370136.6 370804.0 50310.2 50762.7 50801.7 50853.5 50907.0 1333.6 1336.7 1343.4 1347.3 1355.4 24896.5 26651.5 26853.7 26961.7 26972.7 40864.0 41438.8 41564.0 41830.0 41950.2 306333.0 310311.0 311450.0 312742.0 313202.0 28814.4 28837.1 29175.9 29497.6 29537.4 38636.6 39067.0 39452.4 39551.6 39781.0 33994.8 34886.0 35212.6 35282.8 37220.0 33687.5 35380.8 35422.3 35611.5 36123.5 34578.0 34736.8 39330.2 39997.6 40034.8 29861.9 32097.4 32433.8 32675.7 32725.8 24123.7 24526.8 24630.6 24674.8 24868.1 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#2] jquery.html Cycles:180 Average:20396.14 Median:356.63 stddev:49756.31 (13951.6%) stddev-sans-first:49873.13 08:12:19 INFO - PROCESS | 20807 | Values: 353.6 355.8 357.4 358.7 359.2 13410.8 13733.0 15854.8 15910.4 16253.3 15667.6 15781.8 16507.8 16580.3 16623.3 5158.3 5434.5 5437.3 5442.2 5444.7 4030.2 4118.3 5386.2 5845.4 6056.2 5967.2 5980.0 5996.1 6007.5 6011.2 5782.5 5831.8 5898.7 5902.2 5907.1 5119.1 5197.8 5203.2 5207.2 5209.8 20497.5 20744.0 20796.5 20796.5 20849.9 2203.4 2272.4 2278.6 2336.6 2393.3 11815.8 12086.2 12205.5 12346.4 12662.2 1596.1 1600.1 1607.6 1679.4 1691.5 53658.0 55125.7 56740.7 59396.4 59748.4 9710.8 9738.6 9783.6 9863.4 9973.9 13059.2 13085.1 13087.7 13101.8 13105.6 7455.1 7509.2 7514.2 7558.1 7565.7 7261.8 7431.0 7476.2 7543.4 7548.8 4409.1 4460.3 4461.2 4504.5 4505.3 1607.8 1684.6 1804.5 1838.7 1845.3 874.5 922.0 948.8 988.5 1018.0 16527.2 17020.3 17032.9 17152.9 17350.2 875.9 916.6 948.3 956.6 975.4 8840.0 9131.7 9455.6 9960.3 9998.5 136534.0 136830.0 136835.3 272465.0 555706.0 74885.3 74919.6 79587.0 79735.6 81368.6 1109.5 1138.2 1152.3 1155.1 1156.3 14832.5 15279.6 15382.3 15579.8 15707.6 31321.7 31649.2 31980.4 33829.3 36316.6 42107.0 42257.8 42322.0 43305.4 45528.5 9432.6 9562.3 9600.7 9703.2 9714.4 12235.7 12407.0 18067.0 18113.9 18416.1 11894.2 13493.2 13788.7 13924.9 14699.0 11029.3 14019.2 14501.6 14652.7 14776.6 14615.3 15069.4 15146.2 15372.5 15397.1 9648.2 9680.0 9709.5 9761.4 9764.1 10205.1 10836.8 13863.0 13939.1 15088.0 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#3] mootools.html Cycles:180 Average:5448.72 Median:6521.77 stddev:2855.34 (43.8%) stddev-sans-first:2846.47 08:12:19 INFO - PROCESS | 20807 | Values: 1318.1 1413.3 1414.8 1557.4 1809.1 6934.4 7513.2 7607.5 7624.1 7628.9 7462.3 7592.7 7659.6 7725.7 7729.2 1971.5 1999.3 2167.3 2187.5 2204.0 2266.4 2276.2 2276.8 2277.6 2278.6 2160.5 2186.2 2187.0 2189.8 2193.2 2187.2 2200.3 2224.6 2225.5 2227.7 2230.4 2238.1 2260.5 2265.9 2267.7 7740.5 7753.0 7814.6 7822.2 7824.0 4572.7 4652.0 4664.0 4674.5 4684.6 3003.4 3030.5 3057.7 3061.2 3114.4 939.8 954.1 1001.7 1013.8 1035.9 10723.1 10725.7 10739.0 10758.6 10817.6 4071.4 4163.9 4189.6 4191.3 4206.3 9215.5 9225.3 9237.9 9239.2 9247.6 4723.5 4730.2 4733.9 4739.9 4740.0 4282.6 4295.1 4300.2 4304.5 4305.2 3317.1 3361.4 3545.4 3566.2 3590.8 1142.8 1159.2 1168.2 1171.9 1183.9 1012.6 1014.5 1081.3 1162.3 1348.2 7342.2 7375.1 7446.0 7456.6 7461.4 1081.3 1090.3 1091.2 1094.8 1100.7 5734.0 5845.7 5880.6 5881.1 5891.1 9173.6 9267.8 9473.7 9518.0 9610.4 9395.4 9481.6 9499.9 9539.7 9540.7 7316.1 7415.5 7428.1 7428.9 7445.9 7106.2 7166.0 7178.1 7195.6 7198.9 8198.5 8296.8 8523.0 8556.1 8570.4 8591.4 8624.8 8725.3 8759.9 8767.4 6777.2 6826.6 6848.4 6856.7 6870.0 6678.9 6817.8 7252.1 7401.6 7404.0 7004.6 7096.3 7119.3 7141.3 7145.5 7000.5 7014.5 7060.6 7132.8 7140.6 6795.3 6950.9 6973.5 6984.7 7037.6 6473.2 6516.7 6519.7 6523.9 6533.9 6544.8 6548.4 6563.1 6567.2 6593.1 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#4] prototype.html Cycles:180 Average:5199.24 Median:5911.94 stddev:1564.05 (26.5%) stddev-sans-first:1525.22 08:12:19 INFO - PROCESS | 20807 | Values: 334.0 337.5 339.5 342.1 344.8 5776.2 5802.5 5806.5 5821.8 5918.4 5677.8 5804.7 5819.9 5829.9 5831.7 4478.7 4480.9 4486.4 4493.4 4497.3 4307.8 4380.4 4385.2 4385.8 4483.7 4347.5 4377.4 4476.3 4497.4 4498.1 4467.6 4475.6 4480.5 4486.3 4505.1 3959.0 3963.7 3966.1 3970.5 3979.6 5433.6 5572.8 5592.1 5597.6 5600.6 5165.9 5178.1 5190.4 5196.7 5196.9 5905.5 6186.1 6201.4 6203.6 6211.0 4203.2 4233.7 4288.0 4329.6 4341.6 6430.4 6482.6 6494.2 6495.5 6506.3 4419.2 4424.0 4424.3 4432.3 4433.4 4322.7 4466.3 4477.4 4482.6 4482.8 5149.9 5154.5 5154.9 5189.0 5194.8 6255.3 6255.6 6259.4 6267.2 6268.4 1574.8 1590.8 1593.1 1594.0 1594.3 1060.8 1069.1 1072.8 1087.1 1092.3 5928.7 5933.8 5938.7 5940.6 5943.9 6415.7 6421.4 6421.5 6427.4 6448.9 5904.1 5924.8 5926.8 5928.1 5934.3 3405.5 3492.6 3499.9 3501.9 3504.3 6628.9 6666.0 6680.4 6686.5 6692.6 6581.7 6596.7 6631.1 6662.1 6663.1 6420.5 6579.8 6604.4 6634.1 6651.3 6208.8 6361.2 6470.5 6479.7 6480.9 6230.3 6333.1 6338.8 6357.8 6358.1 6558.5 6570.9 6622.2 6640.5 6642.6 4296.2 4400.3 4435.7 4441.8 4442.7 6398.7 6412.2 6415.2 6426.7 6426.8 6183.2 6191.6 6208.2 6208.7 6224.1 6081.1 6188.2 6191.7 6197.9 6203.0 6138.3 6157.4 6164.1 6181.1 6184.0 6322.1 6332.7 6342.4 6342.5 6348.2 6099.8 6139.3 6167.1 6197.6 6197.9 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - PROCESS | 20807 | [#5] yui.html Cycles:180 Average:13351.79 Median:43967.67 stddev:14905.23 (33.9%) stddev-sans-first:14917.04 08:12:19 INFO - PROCESS | 20807 | Values: 758.2 760.2 806.4 817.5 861.0 13154.1 13304.8 13389.5 13415.1 13427.8 12589.9 12612.6 12643.5 12665.0 12684.3 650.4 661.4 662.3 786.8 796.4 652.7 784.1 804.4 806.7 807.7 851.3 855.2 858.0 858.0 859.1 847.8 848.6 849.4 850.4 851.4 507.2 511.9 611.5 615.1 616.0 12809.4 12838.7 12842.0 12848.0 12868.0 11081.1 11650.7 11682.5 11733.2 11911.0 9934.3 10079.2 10279.7 10312.6 10614.3 3590.9 3604.2 3613.2 3621.5 3757.0 46264.5 46443.5 46518.1 46532.8 46660.8 9856.2 10121.9 10181.7 10185.1 10378.6 18488.5 18499.3 18509.4 18512.6 18539.4 7266.4 7276.0 7330.8 7672.1 7749.0 3907.8 3957.5 4066.7 4415.7 4527.2 3084.0 3110.8 3119.8 3120.1 3121.8 523.9 530.3 536.4 539.8 549.5 567.6 586.9 673.9 696.0 720.2 7976.8 8071.7 8277.5 8336.5 8418.7 650.4 678.0 683.5 688.5 745.9 3808.3 4045.8 4073.2 4329.8 4424.3 48757.0 49194.8 49274.0 49285.5 49428.8 48773.3 48986.3 49230.3 49316.0 49457.5 42405.6 44630.1 45120.8 45429.8 45430.3 8784.0 8886.7 9006.4 9040.7 9083.2 33385.5 33515.8 34088.8 34246.1 34542.0 42510.8 43541.6 43652.1 43796.8 44138.6 10394.7 10524.9 10631.5 10918.3 11412.4 12121.1 12263.4 12269.4 12589.2 12784.4 11213.1 11446.6 11478.3 11759.4 11859.8 11410.4 11724.3 11760.6 11855.8 12269.3 11474.2 11790.4 11905.3 12038.8 12324.6 9680.4 9816.2 10032.9 10354.7 10383.0 9208.3 9547.3 10066.9 10073.8 10081.8 08:12:19 INFO - PROCESS | 20807 | -------- Summary: end -------- 08:12:19 INFO - PROCESS | 20807 | 08:12:19 INFO - TEST-INFO | 20807: exit 0 08:12:19 INFO - TEST-OK | dromaeo_css | took 1113218ms 08:12:19 INFO - TEST-START | kraken 08:12:19 INFO - operating with platform_type : linux_ 08:12:19 INFO - Initialising browser for kraken test... 08:12:19 INFO - TEST-INFO | started process 20995 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppEkj8F/profile http://localhost:54286/getInfo.html) 08:12:24 INFO - PROCESS | 20995 | __metrics Screen width/height:1600/1200 08:12:24 INFO - PROCESS | 20995 | colorDepth:24 08:12:24 INFO - PROCESS | 20995 | Browser inner width/height: 1024/697 08:12:24 INFO - PROCESS | 20995 | __metrics 08:12:24 INFO - PROCESS | 20995 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:24 INFO - PROCESS | 20995 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:25 INFO - TEST-INFO | 20995: exit 0 08:12:25 INFO - Browser initialized. 08:12:25 INFO - Running cycle 1/1 for kraken test... 08:12:25 INFO - TEST-INFO | started process 21077 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppEkj8F/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:37 INFO - PROCESS | 21077 | RSS: Main: 150265856 08:12:37 INFO - PROCESS | 21077 | 08:12:39 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:40 INFO - PROCESS | 21077 | RSS: Main: 185614336 08:12:40 INFO - PROCESS | 21077 | 08:12:42 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-dft) 08:12:43 INFO - PROCESS | 21077 | RSS: Main: 175845376 08:12:43 INFO - PROCESS | 21077 | 08:12:46 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-fft) 08:12:46 INFO - PROCESS | 21077 | RSS: Main: 160829440 08:12:46 INFO - PROCESS | 21077 | 08:12:48 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54286/tests/kraken/driver.html?testName=audio-oscillator) 08:12:49 INFO - PROCESS | 21077 | RSS: Main: 162430976 08:12:49 INFO - PROCESS | 21077 | 08:12:51 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:52 INFO - PROCESS | 21077 | RSS: Main: 163209216 08:12:52 INFO - PROCESS | 21077 | 08:12:55 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:55 INFO - PROCESS | 21077 | RSS: Main: 163815424 08:12:55 INFO - PROCESS | 21077 | 08:12:59 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54286/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:59 INFO - PROCESS | 21077 | RSS: Main: 165240832 08:12:59 INFO - PROCESS | 21077 | 08:13:02 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54286/tests/kraken/driver.html?testName=json-parse-financial) 08:13:02 INFO - PROCESS | 21077 | RSS: Main: 165687296 08:13:02 INFO - PROCESS | 21077 | 08:13:04 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:13:05 INFO - PROCESS | 21077 | RSS: Main: 178106368 08:13:05 INFO - PROCESS | 21077 | 08:13:06 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:13:07 INFO - PROCESS | 21077 | RSS: Main: 175763456 08:13:07 INFO - PROCESS | 21077 | 08:13:09 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:10 INFO - PROCESS | 21077 | RSS: Main: 189636608 08:13:10 INFO - PROCESS | 21077 | 08:13:12 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:13 INFO - PROCESS | 21077 | RSS: Main: 194613248 08:13:13 INFO - PROCESS | 21077 | 08:13:15 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:16 INFO - PROCESS | 21077 | RSS: Main: 190758912 08:13:16 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | Cycle 1(1): loaded http://localhost:54286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54286/tests/kraken/driver.html?testName=ai-astar) 08:13:18 INFO - PROCESS | 21077 | RSS: Main: 249036800 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | __start_tp_report 08:13:18 INFO - PROCESS | 21077 | _x_x_mozilla_page_load 08:13:18 INFO - PROCESS | 21077 | _x_x_mozilla_page_load_details 08:13:18 INFO - PROCESS | 21077 | |i|pagename|runs| 08:13:18 INFO - PROCESS | 21077 | |0;ai-astar;109;112;105;110;112;112;100;110;110;109 08:13:18 INFO - PROCESS | 21077 | |1;audio-beat-detection;155;126;148;158;125;158;148;124;156;125 08:13:18 INFO - PROCESS | 21077 | |2;audio-dft;161;161;161;162;161;160;160;162;163;160 08:13:18 INFO - PROCESS | 21077 | |3;audio-fft;72;74;87;93;71;74;73;97;94;74 08:13:18 INFO - PROCESS | 21077 | |4;audio-oscillator;95;96;144;96;97;96;143;96;97;142 08:13:18 INFO - PROCESS | 21077 | |5;imaging-gaussian-blur;110;109;109;109;109;110;109;110;109;110 08:13:18 INFO - PROCESS | 21077 | |6;imaging-darkroom;146;146;145;146;147;146;146;145;146;169 08:13:18 INFO - PROCESS | 21077 | |7;imaging-desaturate;96;96;95;96;96;96;95;96;96;96 08:13:18 INFO - PROCESS | 21077 | |8;json-parse-financial;57;56;56;56;56;58;57;57;60;53 08:13:18 INFO - PROCESS | 21077 | |9;json-stringify-tinderbox;66;68;67;68;68;68;68;68;68;68 08:13:18 INFO - PROCESS | 21077 | |10;stanford-crypto-aes;86;85;86;87;87;86;86;93;87;87 08:13:18 INFO - PROCESS | 21077 | |11;stanford-crypto-ccm;119;125;127;117;123;118;116;119;126;118 08:13:18 INFO - PROCESS | 21077 | |12;stanford-crypto-pbkdf2;145;149;153;150;154;143;152;153;154;141 08:13:18 INFO - PROCESS | 21077 | |13;stanford-crypto-sha256-iterative;67;68;67;67;68;68;70;67;70;69 08:13:18 INFO - PROCESS | 21077 | __end_tp_report 08:13:18 INFO - PROCESS | 21077 | __start_cc_report 08:13:18 INFO - PROCESS | 21077 | _x_x_mozilla_cycle_collect,936 08:13:18 INFO - PROCESS | 21077 | __end_cc_report 08:13:18 INFO - PROCESS | 21077 | __startTimestamp1452096798271__endTimestamp 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | ------- Summary: start ------- 08:13:18 INFO - PROCESS | 21077 | Number of tests: 14 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.75 (3.4%) stddev-sans-first:3.98 08:13:18 INFO - PROCESS | 21077 | Values: 109.0 112.0 105.0 110.0 112.0 112.0 100.0 110.0 110.0 109.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:151.50 stddev:15.30 (10.1%) stddev-sans-first:15.52 08:13:18 INFO - PROCESS | 21077 | Values: 155.0 126.0 148.0 158.0 125.0 158.0 148.0 124.0 156.0 125.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 08:13:18 INFO - PROCESS | 21077 | Values: 161.0 161.0 161.0 162.0 161.0 160.0 160.0 162.0 163.0 160.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#3] audio-fft Cycles:10 Average:80.90 Median:80.50 stddev:10.52 (13.1%) stddev-sans-first:10.66 08:13:18 INFO - PROCESS | 21077 | Values: 72.0 74.0 87.0 93.0 71.0 74.0 73.0 97.0 94.0 74.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:22.65 (23.6%) stddev-sans-first:23.34 08:13:18 INFO - PROCESS | 21077 | Values: 95.0 96.0 144.0 96.0 97.0 96.0 143.0 96.0 97.0 142.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:13:18 INFO - PROCESS | 21077 | Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:146.00 stddev:7.33 (5.0%) stddev-sans-first:7.73 08:13:18 INFO - PROCESS | 21077 | Values: 146.0 146.0 145.0 146.0 147.0 146.0 146.0 145.0 146.0 169.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:13:18 INFO - PROCESS | 21077 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.78 (3.1%) stddev-sans-first:1.88 08:13:18 INFO - PROCESS | 21077 | Values: 57.0 56.0 56.0 56.0 56.0 58.0 57.0 57.0 60.0 53.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.33 08:13:18 INFO - PROCESS | 21077 | Values: 66.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.21 (2.5%) stddev-sans-first:2.32 08:13:18 INFO - PROCESS | 21077 | Values: 86.0 85.0 86.0 87.0 87.0 86.0 86.0 93.0 87.0 87.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.00 stddev:4.05 (3.3%) stddev-sans-first:4.24 08:13:18 INFO - PROCESS | 21077 | Values: 119.0 125.0 127.0 117.0 123.0 118.0 116.0 119.0 126.0 118.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:152.50 stddev:4.79 (3.1%) stddev-sans-first:4.81 08:13:18 INFO - PROCESS | 21077 | Values: 145.0 149.0 153.0 150.0 154.0 143.0 152.0 153.0 154.0 141.0 08:13:18 INFO - PROCESS | 21077 | 08:13:18 INFO - PROCESS | 21077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 08:13:18 INFO - PROCESS | 21077 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 70.0 67.0 70.0 69.0 08:13:18 INFO - PROCESS | 21077 | -------- Summary: end -------- 08:13:18 INFO - PROCESS | 21077 | 08:13:19 INFO - TEST-INFO | 21077: exit 0 08:13:19 INFO - TEST-OK | kraken | took 59274ms 08:13:19 INFO - TEST-START | v8_7 08:13:19 INFO - operating with platform_type : linux_ 08:13:19 INFO - Initialising browser for v8_7 test... 08:13:19 INFO - TEST-INFO | started process 21325 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiWDe4C/profile http://localhost:54286/getInfo.html) 08:13:23 INFO - PROCESS | 21325 | __metrics Screen width/height:1600/1200 08:13:23 INFO - PROCESS | 21325 | colorDepth:24 08:13:23 INFO - PROCESS | 21325 | Browser inner width/height: 1024/697 08:13:23 INFO - PROCESS | 21325 | __metrics 08:13:23 INFO - PROCESS | 21325 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:13:23 INFO - PROCESS | 21325 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:24 INFO - TEST-INFO | 21325: exit 0 08:13:24 INFO - Browser initialized. 08:13:24 INFO - Running cycle 1/1 for v8_7 test... 08:13:24 INFO - TEST-INFO | started process 21407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiWDe4C/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:36 INFO - PROCESS | 21407 | RSS: Main: 149692416 08:13:36 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | Cycle 1(1): loaded http://localhost:54286/tests/v8_7/run.html (next: http://localhost:54286/tests/v8_7/run.html) 08:13:57 INFO - PROCESS | 21407 | RSS: Main: 573005824 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | __start_tp_report 08:13:57 INFO - PROCESS | 21407 | _x_x_mozilla_page_load 08:13:57 INFO - PROCESS | 21407 | _x_x_mozilla_page_load_details 08:13:57 INFO - PROCESS | 21407 | |i|pagename|runs| 08:13:57 INFO - PROCESS | 21407 | |0;Richards;168.32183134152498 08:13:57 INFO - PROCESS | 21407 | |1;DeltaBlue;191.38755980861245 08:13:57 INFO - PROCESS | 21407 | |2;Encrypt;281.45229383619477 08:13:57 INFO - PROCESS | 21407 | |3;Decrypt;5301.587301587301 08:13:57 INFO - PROCESS | 21407 | |4;RayTrace;2000 08:13:57 INFO - PROCESS | 21407 | |5;Earley;800 08:13:57 INFO - PROCESS | 21407 | |6;Boyer;12506.172839506173 08:13:57 INFO - PROCESS | 21407 | |7;RegExp;26230.76923076923 08:13:57 INFO - PROCESS | 21407 | |8;Splay;583.0903790087464 08:13:57 INFO - PROCESS | 21407 | |9;NavierStokes;4840.579710144928 08:13:57 INFO - PROCESS | 21407 | __end_tp_report 08:13:57 INFO - PROCESS | 21407 | __startTimestamp1452096837860__endTimestamp 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | ------- Summary: start ------- 08:13:57 INFO - PROCESS | 21407 | Number of tests: 10 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#0] Richards Cycles:1 Average:168.32 Median:168.32 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 168.3 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 191.4 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 281.5 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#3] Decrypt Cycles:1 Average:5301.59 Median:5301.59 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 5301.6 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 2000.0 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 800.0 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 12506.2 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 26230.8 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#8] Splay Cycles:1 Average:583.09 Median:583.09 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 583.1 08:13:57 INFO - PROCESS | 21407 | 08:13:57 INFO - PROCESS | 21407 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:13:57 INFO - PROCESS | 21407 | Values: 4840.6 08:13:57 INFO - PROCESS | 21407 | -------- Summary: end -------- 08:13:57 INFO - PROCESS | 21407 | 08:13:58 INFO - TEST-INFO | 21407: exit 0 08:13:58 INFO - TEST-OK | v8_7 | took 39517ms 08:13:58 INFO - SUITE-END | took 1212s 08:13:58 INFO - Completed test suite (00:20:12) 08:13:58 INFO - Working with test: dromaeo_css 08:13:58 INFO - Generating results file: dromaeo_css 08:13:58 INFO - Working with test: kraken 08:13:58 INFO - Generating results file: kraken 08:13:58 INFO - javascript benchmark 08:13:58 INFO - Working with test: v8_7 08:13:58 INFO - Generating results file: v8_7 08:13:58 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:13:58 INFO - process_Request line: dromaeo_css 6859.74 graph.html#tests=[[72,201,35]] 08:13:58 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:58 INFO - process_Request line: kraken 1506.40 graph.html#tests=[[232,201,35]] 08:13:58 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:58 INFO - process_Request line: v8_7 19686.56 graph.html#tests=[[230,201,35]] 08:13:59 INFO - RETURN: dromaeo_css: 6859.74 08:13:59 INFO - RETURN: kraken: 1506.40 08:13:59 INFO - RETURN: v8_7: 19686.56 08:13:59 INFO - javascript benchmark 08:13:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3017.668056513783, 3117.018139286126, 3157.8894738684135, 3160.7471402287806, 3170.936581268374, 5114.28400023997, 5217.191335343018, 5263.447338029505, 5300.310959575249, 5340.679559226444, 5217.3217481727415, 5253.500917412849, 5256.132738098218, 5260.105782017066, 5351.438098999607, 4678.836240731575, 4741.8814529636775, 4766.499517550659, 4912.189488734354, 4930.580900623433, 4854.975725121387, 4868.975655121737, 4915.901681966377, 4927.310176575283, 4931.704097754128, 4652.278896771006, 4703.482616912137, 4731.881702957437, 4761.738104404257, 4770.117528257283, 4800.615950723934, 4805.807767689288, 4840.1771698810935, 4840.540148685869, 4850.902981940341, 4752.6910750801435, 4792.808287668489, 4801.1117943180625, 4808.110499557558, 4868.294097355899, 4878.853634390974, 4967.329410529568, 4999.925001124986, 5085.567726743194, 5164.406093299281, 5619.8595035124445, 5627.240322556484, 5630.0991841305195, 5640.5769567282205, 5649.435056494359, 5663.745131469093, 5667.206591077212, 5671.234383358235, 5679.375268720438, 5686.857828554319, 5147.305113809625, 5245.396779370345, 5248.816291429782, 5249.160134378481, 5306.416294207634, 5777.19119323295, 5787.189793428924, 5803.709814509258, 5825.941740582624, 5837.941620583825, 5517.531009864207, 5518.751656175482, 5518.972405137949, 5548.167774833726, 5566.276384070045, 5362.570994320445, 5482.780688772485, 5579.888402231933, 5620.269364982526, 5641.971790141023, 5509.669419834822, 5558.916616250759, 5601.075822489325, 5605.467480589337, 5613.635113717677, 5560.443955604407, 5591.30108736408, 5594.1608758686525, 5596.0, 5599.132134519156, 4225.070484493406, 4336.219480493542, 4339.479262488521, 4344.326629372453, 4345.196138714348, 3821.2357528494413, 3868.4777555030273, 3881.7865017423746, 3891.5330160380936, 3902.0, 5213.061648903158, 5249.7112658804135, 5250.527452529291, 5252.65857719247, 5254.264402983586, 5382.677039377571, 5474.972625136849, 5603.243562119062, 5640.661560306395, 5700.828975130753, 5148.330717006766, 5178.559822415137, 5243.632945693765, 5259.421463638997, 5276.261323414725, 4813.687110337817, 4829.879253018632, 4831.4685384607665, 4844.8304309349705, 4883.02339532095, 5749.3963133871175, 5770.019096753562, 5770.19217309577, 5772.682502462405, 5779.190913272145, 5496.560275178056, 5599.692016939108, 5601.6358936668985, 5645.096784514458, 5744.253247077853, 5821.505172060422, 5822.82531524055, 5833.300003999547, 5844.12338149281, 5847.1229315603, 5591.748371323219, 5594.888102237851, 5604.0, 5606.495415412633, 5610.242617246619, 5423.132298832168, 5434.891302174014, 5548.306461692288, 5578.60949733531, 5585.022621041383, 5508.834734957958, 5520.420355862577, 5545.195946587803, 5546.084895992116, 5557.610967232255, 5496.065668836387, 5531.253280807039, 5531.861703457445, 5535.280413546213, 5581.162825576196, 5251.553617942518, 5337.386200586982, 5346.064438723286, 5350.010248104113, 5430.185472179205, 5486.945130548644, 5490.69801160924, 5500.4224556420995, 5503.394626591152, 5551.25058117149, 5339.439358867263, 5347.144456887035, 5355.78576856937, 5361.678299302054, 5368.624196306221], "unit": "score", "name": "dojo.html", "value": 5174.396166539511}, {"lowerIsBetter": false, "replicates": [536.8979893820174, 537.5699440447644, 557.2950217974262, 560.6888177061729, 572.8138355034615, 27456.0, 28027.85986070072, 28040.0, 34208.65791342086, 35214.82392588034, 40482.39276410856, 41250.587494125124, 41272.58727412725, 41292.38061429081, 41342.0, 8478.957605211981, 8657.653693852239, 8667.003294621105, 8668.783280418009, 8672.56637168139, 7438.851222975537, 7512.511686740371, 7551.773446796577, 7561.0, 9960.750981225456, 9931.702048938543, 10026.699199024004, 10030.448325342104, 10037.146842518394, 10044.045815647502, 9878.950605246999, 9924.652637157666, 10024.59901603935, 10044.497775111251, 10045.949770251102, 7350.705971761123, 7482.21436749139, 9939.70180894567, 10139.340942838691, 10151.137153341975, 33791.15522111942, 34158.6584134158, 34210.48684269738, 34241.82879085613, 34299.82850085734, 3140.984295078533, 3249.9350012999607, 3362.3947689415895, 3520.4367301231937, 4033.8588149414923, 27233.86383068072, 27457.0, 27923.162305130878, 28295.033910516067, 28525.714742852513, 3867.3038853006447, 4016.49793775778, 4030.7984600769846, 4034.899127521806, 4123.257813593552, 244604.0, 246360.0, 246470.0, 246823.0, 247956.9999999982, 58182.0, 58567.0, 58591.414085858596, 58774.0, 58849.41150588525, 54272.45727542674, 55634.0, 61010.38989610136, 61504.0, 62227.0, 13951.511697090553, 14083.43666253359, 14107.647308817157, 14195.077319974169, 14213.50252741149, 10697.197710171768, 10709.78580428387, 10720.410377429316, 10766.676999690022, 10786.676399708022, 17244.0, 17791.555211119827, 19814.900925495567, 19979.900100499406, 20175.697364539545, 7675.731349402744, 7792.571408572469, 7803.453758236869, 7808.336291415293, 7938.166492518318, 892.3396686451979, 898.2723993565234, 927.9118483744033, 941.8493041113389, 1014.7666036811574, 25310.36724081876, 25407.491850162893, 25442.363940901254, 25705.228843134362, 26089.347766305993, 1035.223582313265, 1053.994730026345, 1105.1545567640762, 1142.3146112332533, 1190.2739329009298, 12921.547745828851, 13534.86465135336, 13599.52401665937, 13672.863271367358, 13767.38046787897, 366768.0, 368721.0, 369309.0, 370136.5972680585, 370804.0, 50310.24534631983, 50762.74618626883, 50801.74599126981, 50853.49146508487, 50907.0, 1333.5732565579115, 1336.73265346931, 1343.4156142078227, 1347.2522749873915, 1355.390074466494, 24896.502069958136, 26651.466970660866, 26853.731462685122, 26961.73038269592, 26972.730272697023, 40864.0, 41438.79280603577, 41564.0, 41830.0, 41950.16099677928, 306333.0, 310311.0, 311450.0, 312742.0, 313202.0, 28814.423711526073, 28837.134885952615, 29175.854120729262, 29497.557536636537, 29537.409251815272, 38636.6136338633, 39067.0, 39452.40821387739, 39551.60448395479, 39781.0, 33994.83002584971, 34886.0, 35212.64787352094, 35282.823585882936, 37220.0, 33687.4946875802, 35380.823095884356, 35422.291554169286, 35611.465828012086, 36123.458148127276, 34578.0, 34736.82631586826, 39330.213395731356, 39997.60002399939, 40034.79982600185, 29861.850690747277, 32097.35805283928, 32433.837830810695, 32675.732426757135, 32725.836370817993, 24123.69900705787, 24526.754732453162, 24630.630540542264, 24674.753252467246, 24868.12961546337], "unit": "score", "name": "ext.html", "value": 17959.333115599235}, {"lowerIsBetter": false, "replicates": [353.57570914902124, 355.829201983048, 357.44060545246685, 358.7309517861604, 359.1703165687261, 13410.798838017437, 13733.0, 15854.762178567316, 15910.363585456582, 16253.349866005346, 15667.60830979226, 15781.763273550878, 16507.83492165078, 16580.336786528525, 16623.335066597352, 5158.252053452247, 5434.538064264522, 5437.34751829781, 5442.183672449144, 5444.673319600817, 4030.1939612077704, 4118.341065429532, 5386.192071189334, 5845.415458454142, 6056.242969628796, 5967.224260846084, 5980.043193089106, 5996.100584912255, 6007.519398448114, 6011.158437818709, 5782.479576838084, 5831.79588714393, 5898.705064746746, 5902.203202567642, 5907.113932910076, 5119.052975199563, 5197.7920883164625, 5203.19350500673, 5207.244949482304, 5209.817656382046, 20497.4875628109, 20744.0, 20796.48008799777, 20796.48008799777, 20849.89575052115, 2203.3500117465387, 2272.3523795718143, 2278.5898538263104, 2336.6144586143264, 2393.3059412770276, 11815.763684726257, 12086.214396064228, 12205.511779528808, 12346.38268086601, 12662.240265584001, 1596.1380854338643, 1600.1439230012004, 1607.5820286725418, 1679.4129547577545, 1691.5348279223313, 53658.0, 55125.72437137789, 56740.716296418665, 59396.40603593952, 59748.40251597472, 9710.805783884283, 9738.610455581698, 9783.608655653836, 9863.358881672812, 9973.850392244121, 13059.21644701321, 13085.149465284727, 13087.738245235232, 13101.803472947913, 13105.606831795061, 7455.105387353552, 7509.173990861001, 7514.248575142551, 7558.055243094614, 7565.73519926811, 7261.818454538678, 7430.96284518574, 7476.1776204617445, 7543.434242431839, 7548.8490230196185, 4409.140217657526, 4460.264056430718, 4461.174682683714, 4504.504504504502, 4505.256632655575, 1607.823139454659, 1684.6462242929122, 1804.4857215693726, 1838.6648955826026, 1845.2895635180284, 874.5408660453313, 922.0134456131874, 948.8102379523984, 988.4958671077802, 1018.0430395428274, 16527.173641317888, 17020.31918723262, 17032.914835425745, 17152.914235428743, 17350.219240134225, 875.8628945373268, 916.6196028648036, 948.2556193388157, 956.5934477846887, 975.3855071305032, 8839.955800221087, 9131.680391186277, 9455.621775129055, 9960.252981026451, 9998.500074996222, 136534.0, 136830.0, 136835.31582342225, 272465.0, 555706.0, 74885.25114748892, 74919.62540187374, 79587.0, 79735.62775908562, 81368.59315703383, 1109.4951796932376, 1138.1861968692424, 1152.3489228585654, 1155.058627218814, 1156.3351073132983, 14832.480863169738, 15279.618009549406, 15382.307796149424, 15579.766303505683, 15707.607309817346, 31321.686783131878, 31649.20876978094, 31980.36039279155, 33829.3234135311, 36316.636833631324, 42107.0, 42257.78871105625, 42322.0, 43305.35041974436, 45528.54471455243, 9432.575534101119, 9562.28282878773, 9600.66397676078, 9703.223742100756, 9714.417134971924, 12235.69410764738, 12407.0, 18067.0, 18113.909430452764, 18416.079196039875, 11894.167408281683, 13493.190408575518, 13788.724225515634, 13924.930375348058, 14699.044562103429, 11029.338239705643, 14019.228942408265, 14501.637459063608, 14652.70694586081, 14776.556703298918, 14615.269236538343, 15069.397224110913, 15146.242687865342, 15372.461963831212, 15397.07617542951, 9648.179904708179, 9680.0, 9709.465979371202, 9761.365511241747, 9764.072413120743, 10205.132563732166, 10836.837447438136, 13863.0, 13939.09395889264, 15088.0], "unit": "score", "name": "jquery.html", "value": 8629.092282838827}, {"lowerIsBetter": false, "replicates": [1318.0575888239907, 1413.3074793351257, 1414.837293711223, 1557.4159690116207, 1809.0773705410236, 6934.44524438045, 7513.2486751324905, 7607.505512141707, 7624.123225829031, 7628.885566716497, 7462.328390444873, 7592.696292148321, 7659.578723170223, 7725.652345644446, 7729.227077292268, 1971.5366888781125, 1999.330224374829, 2167.2631305356176, 2187.5406164705432, 2204.030226700255, 2266.3880752196897, 2276.2147059264526, 2276.829237807163, 2277.567262220173, 2278.5556816420803, 2160.459885028743, 2186.2020362567628, 2187.0, 2189.7591264960843, 2193.243331050785, 2187.1798075721604, 2200.2629119244993, 2224.63293556563, 2225.5326381459913, 2227.7326720793526, 2230.397792596006, 2238.149503188778, 2260.457490202356, 2265.920692775745, 2267.7051983242236, 7740.535567865946, 7753.030871141107, 7814.648340824677, 7822.217778222189, 7824.021997250344, 4572.702774319659, 4651.976740116278, 4663.953360466386, 4674.532546745332, 4684.578387945101, 3003.4293484237924, 3030.5151175811984, 3057.6942305769244, 3061.2499937515227, 3114.4394009078583, 939.76036110792, 954.0888451528773, 1001.689476262361, 1013.7871047080122, 1035.9067683908484, 10723.14214862809, 10725.731856703645, 10739.033486986209, 10758.623448179276, 10817.621383251628, 4071.42999980003, 4163.895902602399, 4189.6229339359, 4191.3293872980175, 4206.26390381682, 9215.49314787693, 9225.261979041661, 9237.861432078524, 9239.214666753267, 9247.583858726373, 4723.48041715411, 4730.172219861511, 4733.928991065137, 4739.857804265877, 4740.0, 4282.593153650399, 4295.098029413795, 4300.247456695066, 4304.5480224576595, 4305.160493703697, 3317.0878008547843, 3361.3949489092197, 3545.4150065239464, 3566.2154326048226, 3590.8204589770407, 1142.7600203957095, 1159.2233203753337, 1168.1705988748083, 1171.917965742407, 1183.8875306845837, 1012.6202673997251, 1014.5181039006413, 1081.291753901196, 1162.2503485251966, 1348.1708749119416, 7342.155652100077, 7375.114986201583, 7446.0, 7456.589887556236, 7461.403087752967, 1081.3403823667556, 1090.2804149261449, 1091.2415870969758, 1094.7865166292656, 1100.7138144082596, 5734.0, 5845.678487683218, 5880.617759845596, 5881.147233651097, 5891.116332550066, 9173.58718857653, 9267.814643707088, 9473.715788526355, 9517.952410237904, 9610.423374597547, 9395.436273823592, 9481.573329200202, 9499.857502137473, 9539.713808585753, 9540.666076687283, 7316.085489313836, 7415.5179913305465, 7428.10862696469, 7428.888566671504, 7445.851082978418, 7106.182788979334, 7166.0, 7178.138623365229, 7195.640217989185, 7198.8841729532005, 8198.549079800669, 8296.792580185302, 8522.957385213034, 8556.058833528183, 8570.442921210102, 8591.44155629882, 8624.78438039054, 8725.258353040063, 8759.868601970848, 8767.386282960131, 6777.186737591323, 6826.624535650389, 6848.417884479875, 6856.691448884712, 6869.965650171717, 6678.866422671616, 6817.829554260985, 7252.129744430702, 7401.59291238987, 7403.96298018528, 7004.614746188805, 7096.325849044332, 7119.2524784898915, 7141.250168732208, 7145.535540189871, 7000.544964577286, 7014.5440546364325, 7060.6116663584, 7132.786016419515, 7140.607266600179, 6795.286494917962, 6950.93049069523, 6973.47698922593, 6984.7206111757, 7037.577745335091, 6473.158489396348, 6516.73933042673, 6519.674016299071, 6523.858324793047, 6533.901991470037, 6544.770933017321, 6548.443382312366, 6563.113979612691, 6567.211934567882, 6593.142891424084], "unit": "score", "name": "mootools.html", "value": 4452.350013385557}, {"lowerIsBetter": false, "replicates": [333.9547217210132, 337.5240910316454, 339.45009085281816, 342.125868406222, 344.8310327939309, 5776.162456443813, 5802.535797136229, 5806.535477161833, 5821.825345239639, 5918.4081591840795, 5677.772889084432, 5804.651720896749, 5819.9418005819925, 5829.854253643661, 5831.679257640828, 4478.686491945565, 4480.887977800565, 4486.371907932892, 4493.438320209973, 4497.280435130388, 4307.806148723315, 4380.408644832954, 4385.232584297735, 4385.780710964439, 4483.6861419700635, 4347.500037495697, 4377.365282034119, 4476.328550717402, 4497.370368148462, 4498.145352383053, 4467.5755803198645, 4475.641948644101, 4480.462344518646, 4486.3046227834575, 4505.076459325846, 3959.0, 3963.7027222958104, 3966.0679740261016, 3970.5235371755575, 3979.641832235113, 5433.646812957145, 5572.804951826707, 5592.0773072443, 5597.608167428281, 5600.579956503238, 5165.870853228662, 5178.119719647669, 5190.351206099238, 5196.6881987080515, 5196.870078248036, 5905.4685078343155, 6186.072089186613, 6201.379862013762, 6203.565750397474, 6210.968945155245, 4203.243416185085, 4233.703640745149, 4287.978560107211, 4329.63616460817, 4341.630961368288, 6430.421262086435, 6482.611043337415, 6494.188226471691, 6495.4803615710625, 6506.2843087260835, 4419.226635338803, 4423.955760442354, 4424.269995450714, 4432.312991486325, 4433.423654924839, 4322.7190232634775, 4466.307722303049, 4477.3731677565165, 4482.596566309048, 4482.843100491467, 5149.871253218625, 5154.484551544891, 5154.871128221825, 5189.040027594831, 5194.844154675366, 6255.311915689271, 6255.593386429868, 6259.436650701458, 6267.2479302484, 6268.435840774352, 1574.795276614033, 1590.8091029076354, 1593.1158207194887, 1593.9521814345587, 1594.3224129745045, 1060.8408738689259, 1069.1179776684266, 1072.8122578548723, 1087.141158484804, 1092.2736380307008, 5928.67392293428, 5933.792317268962, 5938.673372964442, 5940.61386009908, 5943.851403714942, 6415.743370265231, 6421.3578642136345, 6421.51838612106, 6427.421532062137, 6448.935510644834, 5904.143899134688, 5924.792632257937, 5926.822195334147, 5928.08114742207, 5934.258217722785, 3405.4721518164724, 3492.5808902931813, 3499.9125021874656, 3501.8949431517094, 3504.3166582516164, 6628.8674226515195, 6665.966670166618, 6680.3987641112535, 6686.465082793365, 6692.5984440932725, 6581.670916454158, 6596.703148358335, 6631.071649969008, 6662.100616416818, 6663.100481434944, 6420.486361091102, 6579.80260592183, 6604.4056034955165, 6634.137562116894, 6651.301613330627, 6208.751649933952, 6361.236651601653, 6470.547061705635, 6479.7408103675325, 6480.935190648222, 6230.314665386713, 6333.145025421509, 6338.778142764981, 6357.777477788255, 6358.078078678658, 6558.508111891722, 6570.868582628225, 6622.1722284714415, 6640.468762499085, 6642.568233064835, 4296.226679197649, 4400.317950717644, 4435.689501734848, 4441.755703436342, 4442.711223770445, 6398.744050238124, 6412.230532335963, 6415.166028416276, 6426.710798014007, 6426.807195784134, 6183.196184496167, 6191.597546159485, 6208.192934918612, 6208.72060757258, 6224.097505861715, 6081.118237855575, 6188.164597779242, 6191.721372538156, 6197.876042479035, 6202.976508875985, 6138.294096178818, 6157.384261573807, 6164.106204600397, 6181.134641150333, 6184.010558310649, 6322.146510221061, 6332.683365831782, 6342.39747224013, 6342.524310676626, 6348.174737284124, 6099.786507472217, 6139.26328840542, 6167.105769663463, 6197.597156184834, 6197.938020619736], "unit": "score", "name": "prototype.html", "value": 4696.182543261652}, {"lowerIsBetter": false, "replicates": [758.1546575568243, 760.1752098972615, 806.3790881021614, 817.4727300890926, 860.9784755381119, 13154.07921445498, 13304.800427993576, 13389.464421423132, 13415.060945733803, 13427.798583021262, 12589.937050314735, 12612.62162135135, 12643.49426022958, 12665.0, 12684.30236337001, 650.3723906430293, 661.4311691944923, 662.3211208511266, 786.8190316227272, 796.366888323784, 652.6997581112694, 784.0591290451453, 804.4007214625112, 806.6773290683715, 807.7011505742884, 851.3146916732028, 855.1533981358473, 857.9613917373701, 858.0175698824842, 859.0936561927165, 847.8473874702551, 848.6308455821737, 849.4223927729141, 850.3792231670853, 851.3657325292666, 507.2214151277771, 511.91809310510513, 611.4710775179482, 615.0988801405917, 616.0020766358483, 12809.423575939105, 12838.679033024157, 12842.0, 12848.0, 12868.0, 11081.10124598972, 11650.708732281675, 11682.474288657031, 11733.187534171628, 11911.0, 9934.304598678096, 10079.244056695778, 10279.691609251735, 10312.587496500206, 10614.310069845513, 3590.9281814363826, 3604.2070744436182, 3613.1870329175727, 3621.529201203853, 3756.981215093907, 46264.53735462636, 46443.53556464426, 46518.06963860704, 46532.767336163444, 46660.76669616664, 9856.21150307988, 10121.949390253149, 10181.745456363502, 10185.134263587677, 10378.584856605803, 18488.537786555444, 18499.260029598936, 18509.444716658523, 18512.629747404975, 18539.44381668552, 7266.418686505172, 7275.963620181865, 7330.816729581697, 7672.117706463828, 7748.961255193688, 3907.78507182102, 3957.5053118360206, 4066.674666026711, 4415.735055896656, 4527.230370836965, 3084.0439463766306, 3110.828904410279, 3119.781615286908, 3120.0639808057945, 3121.828299443507, 523.8926020165857, 530.3476723629957, 536.3992328591924, 539.816462402785, 549.5356423821864, 567.6133493149977, 586.8562202260473, 673.8685956238585, 696.0498918975663, 720.1825927572244, 7976.84046319082, 8071.668710986222, 8277.54473503951, 8336.458130221516, 8418.663253469915, 650.4178760009764, 677.993220067793, 683.5010442377093, 688.4939569416475, 745.8620155271292, 3808.3145033894166, 4045.7977101144825, 4073.246449406869, 4329.826806927751, 4424.292113261863, 48757.0, 49194.75402623036, 49274.0, 49285.50714492881, 49428.752856235486, 48773.26840097401, 48986.26520602194, 49230.261546076836, 49316.0, 49457.50542494601, 42405.57594424078, 44630.10739785251, 45120.774396128465, 45429.77285113619, 45430.318545221846, 8784.0, 8886.73339799807, 9006.369554131148, 9040.728778136667, 9083.18251357381, 33385.49921751127, 33515.83242083774, 34088.82955585206, 34246.14384640404, 34542.0, 42510.787446062575, 43541.564584355016, 43652.12695746131, 43796.78101609471, 44138.55861441473, 10394.740131496774, 10524.894751052392, 10631.521581529005, 10918.290311129751, 11412.429378530875, 12121.090978142374, 12263.38683065861, 12269.386530673251, 12589.181703189264, 12784.424700888669, 11213.102951764002, 11446.599369022377, 11478.253913495597, 11759.412029398667, 11859.822102668639, 11410.429478526206, 11724.296542207494, 11760.647180584596, 11855.76288474243, 12269.325187114795, 11474.196806223485, 11790.410479476164, 11905.285682859056, 12038.819417708917, 12324.630261092181, 9680.370775899544, 9816.2147028239, 10032.899671003197, 10354.741131471774, 10383.0, 9208.263338932735, 9547.331686782136, 10066.929586476195, 10073.798524029626, 10081.848772268275], "unit": "score", "name": "yui.html", "value": 6213.824537380806}], "name": "dromaeo_css", "value": 6859.742104450452}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 105.0, 110.0, 112.0, 112.0, 100.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [155.0, 126.0, 148.0, 158.0, 125.0, 158.0, 148.0, 124.0, 156.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 160.0, 162.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 87.0, 93.0, 71.0, 74.0, 73.0, 97.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 144.0, 96.0, 97.0, 96.0, 143.0, 96.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 169.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 56.0, 56.0, 58.0, 57.0, 57.0, 60.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 86.0, 87.0, 87.0, 86.0, 86.0, 93.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 127.0, 117.0, 123.0, 118.0, 116.0, 119.0, 126.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [145.0, 149.0, 153.0, 150.0, 154.0, 143.0, 152.0, 153.0, 154.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 70.0, 67.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1506.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.32183134152498], "unit": "score", "name": "Richards", "value": 209.72918199999998}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5301.587301587301], "unit": "score", "name": "Decrypt", "value": 50.20779341317366}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [583.0903790087464], "unit": "score", "name": "Splay", "value": 139.75706500000004}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19686.56028242809}]} 08:13:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19686.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1506.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6859.74"}}} 08:13:59 INFO - Return code: 0 08:13:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:13:59 INFO - # TBPL SUCCESS # 08:13:59 INFO - Running post-action listener: _resource_record_post_action 08:13:59 INFO - Running post-run listener: _resource_record_post_run 08:14:00 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 559562752; Read time: 0; Write time: 462984 08:14:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 207687680; Read time: 0; Write time: 181952 08:14:00 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 320339968; Read time: 0; Write time: 271648 08:14:00 INFO - Running post-run listener: _upload_blobber_files 08:14:00 INFO - Blob upload gear active. 08:14:00 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:14:00 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:14:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:14:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:14:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:01 INFO - (blobuploader) - INFO - Done attempting. 08:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:14:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:03 INFO - (blobuploader) - INFO - Done attempting. 08:14:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:03 INFO - Return code: 0 08:14:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:14:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa16951e42c5871479a934349dc117724b5728a82a179885c5f15e507dbb9c8f2699993790c5a2bd459dbb03f8d4cc47827170a317e0eef8f6bb5b99659700d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ba4d897c20517a32ffca22da2a613e2262dd15bb9445cec944d7b3acf730a0c275419d622032d8e1b225edda51d141a0f4ef6cfde4b54bf823a3519f89cd1541"} 08:14:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:14:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:14:03 INFO - Contents: 08:14:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa16951e42c5871479a934349dc117724b5728a82a179885c5f15e507dbb9c8f2699993790c5a2bd459dbb03f8d4cc47827170a317e0eef8f6bb5b99659700d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ba4d897c20517a32ffca22da2a613e2262dd15bb9445cec944d7b3acf730a0c275419d622032d8e1b225edda51d141a0f4ef6cfde4b54bf823a3519f89cd1541"} 08:14:03 INFO - Copying logs to upload dir... 08:14:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.513372 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-06 08:14:03.096419) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 08:14:03.099875) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa16951e42c5871479a934349dc117724b5728a82a179885c5f15e507dbb9c8f2699993790c5a2bd459dbb03f8d4cc47827170a317e0eef8f6bb5b99659700d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ba4d897c20517a32ffca22da2a613e2262dd15bb9445cec944d7b3acf730a0c275419d622032d8e1b225edda51d141a0f4ef6cfde4b54bf823a3519f89cd1541"} build_url:https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011543 build_url: 'https://queue.taskcluster.net/v1/task/SmW2_BIoQ4-0bCl-a7lrcA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/fa16951e42c5871479a934349dc117724b5728a82a179885c5f15e507dbb9c8f2699993790c5a2bd459dbb03f8d4cc47827170a317e0eef8f6bb5b99659700d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ba4d897c20517a32ffca22da2a613e2262dd15bb9445cec944d7b3acf730a0c275419d622032d8e1b225edda51d141a0f4ef6cfde4b54bf823a3519f89cd1541"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 08:14:03.124844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:14:03.125275) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1452095478.726108-406671680 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 08:14:03.209252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 08:14:03.209574) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 08:14:03.209906) ========= ========= Total master_lag: 0.25 =========