builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1453122219.07 results: success (0) buildid: 20160118023004 builduid: 6651887d74a54d54b18aea4beda26a38 revision: 80cf5f6c1863a73c59e6337eb19562aa4874e0f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.067494) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.067922) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.068205) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.091041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.091333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.104604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.104977) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.162244) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.162496) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.162827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.163087) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 05:03:39-- 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% 209M=0s 2016-01-18 05:03:39 (209 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.341467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.341784) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016144 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.391309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:39.391678) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80cf5f6c1863a73c59e6337eb19562aa4874e0f6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80cf5f6c1863a73c59e6337eb19562aa4874e0f6 --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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 05:03:39,771 truncating revision to first 12 chars 2016-01-18 05:03:39,771 Setting DEBUG logging. 2016-01-18 05:03:39,771 attempt 1/10 2016-01-18 05:03:39,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80cf5f6c1863?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 05:03:40,166 unpacking tar archive at: fx-team-80cf5f6c1863/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.079017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.079324) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003603 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.128704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.129001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.138641) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.138883) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 05:03:40.139233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-18 05:03:40.139506) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:40 INFO - MultiFileLogger online at 20160118 05:03:40 in /builds/slave/test-pgo 05:03:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:03:40 INFO - {'append_to_log': False, 05:03:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:03:40 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:03:40 INFO - 'branch': 'Fx-Team', 05:03:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:40 INFO - 'config_files': ('talos/linux_config.py',), 05:03:40 INFO - 'default_actions': ('clobber', 05:03:40 INFO - 'read-buildbot-config', 05:03:40 INFO - 'download-and-extract', 05:03:40 INFO - 'populate-webroot', 05:03:40 INFO - 'create-virtualenv', 05:03:40 INFO - 'install', 05:03:40 INFO - 'run-tests'), 05:03:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:40 INFO - 'download_minidump_stackwalk': True, 05:03:40 INFO - 'download_symbols': 'ondemand', 05:03:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:40 INFO - 'installer_path': 'installer.exe', 05:03:40 INFO - 'log_level': 'info', 05:03:40 INFO - 'log_name': 'talos', 05:03:40 INFO - 'log_to_console': True, 05:03:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:40 INFO - 'opt_config_files': (), 05:03:40 INFO - 'pip_index': False, 05:03:40 INFO - 'sps_profile': False, 05:03:40 INFO - 'sps_profile_interval': 0, 05:03:40 INFO - 'suite': 'dromaeojs', 05:03:40 INFO - 'system_bits': '32', 05:03:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:40 INFO - 'title': 'talos-linux64-ix-025', 05:03:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:40 INFO - 'use_talos_json': True, 05:03:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:03:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:40 INFO - 'work_dir': 'build'} 05:03:40 INFO - ##### 05:03:40 INFO - ##### Running clobber step. 05:03:40 INFO - ##### 05:03:40 INFO - Running pre-action listener: _resource_record_pre_action 05:03:40 INFO - Running main action method: clobber 05:03:40 INFO - rmtree: /builds/slave/test-pgo/build 05:03:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:03:41 INFO - Running post-action listener: _resource_record_post_action 05:03:41 INFO - ##### 05:03:41 INFO - ##### Running read-buildbot-config step. 05:03:41 INFO - ##### 05:03:41 INFO - Running pre-action listener: _resource_record_pre_action 05:03:41 INFO - Running main action method: read_buildbot_config 05:03:41 INFO - Using buildbot properties: 05:03:41 INFO - { 05:03:41 INFO - "project": "", 05:03:41 INFO - "product": "firefox", 05:03:41 INFO - "script_repo_revision": "production", 05:03:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:03:41 INFO - "repository": "", 05:03:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:03:41 INFO - "buildid": "20160118023004", 05:03:41 INFO - "pgo_build": "True", 05:03:41 INFO - "basedir": "/builds/slave/test-pgo", 05:03:41 INFO - "buildnumber": 424, 05:03:41 INFO - "slavename": "talos-linux64-ix-025", 05:03:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:03:41 INFO - "platform": "ubuntu64_hw", 05:03:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:41 INFO - "branch": "fx-team", 05:03:41 INFO - "repo_path": "integration/fx-team", 05:03:41 INFO - "revision": "80cf5f6c1863a73c59e6337eb19562aa4874e0f6", 05:03:41 INFO - "stage_platform": "linux64-pgo", 05:03:41 INFO - "builduid": "6651887d74a54d54b18aea4beda26a38", 05:03:41 INFO - "slavebuilddir": "test" 05:03:41 INFO - } 05:03:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:03:41 INFO - Running post-action listener: _resource_record_post_action 05:03:41 INFO - ##### 05:03:41 INFO - ##### Running download-and-extract step. 05:03:41 INFO - ##### 05:03:41 INFO - Running pre-action listener: _resource_record_pre_action 05:03:41 INFO - Running main action method: download_and_extract 05:03:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:41 INFO - https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/test_packages.json 05:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/test_packages.json 05:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:03:45 INFO - Downloaded 1448 bytes. 05:03:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:03:45 INFO - Using the following test package requirements: 05:03:45 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:45 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:45 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:03:45 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'jsshell-linux-x86_64.zip'], 05:03:45 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:45 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:45 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:45 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:45 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:45 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:45 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:45 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03: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')]} 05:03:45 INFO - https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:48 INFO - Downloaded 22484310 bytes. 05:03:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:03:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:03:49 INFO - Return code: 0 05:03:49 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 05:03:49 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')]} 05:03:49 INFO - https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:51 INFO - Downloaded 22484310 bytes. 05:03:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:03:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:03:52 INFO - Return code: 0 05:03:52 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')]} 05:03:52 INFO - https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:55 INFO - Downloaded 11132144 bytes. 05:03:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:03:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:03:55 INFO - Return code: 0 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UMnd30LbS2q_0SvaqtZDeQ/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 05:03:58 INFO - Downloaded 55937118 bytes. 05:03:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:58 INFO - mkdir: /builds/slave/test-pgo/properties 05:03:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:03:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:03:58 INFO - Contents: 05:03:58 INFO - build_url:https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:58 INFO - Running post-action listener: _resource_record_post_action 05:03:58 INFO - Running post-action listener: set_extra_try_arguments 05:03:58 INFO - ##### 05:03:58 INFO - ##### Running populate-webroot step. 05:03:58 INFO - ##### 05:03:58 INFO - Running pre-action listener: _resource_record_pre_action 05:03:58 INFO - Running main action method: populate_webroot 05:03:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:58 INFO - '--tppagecycles', 05:03:58 INFO - '7'], 05:03:58 INFO - 'tests': ['tsvgm']}}, 05:03:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:03:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'tests': ['damp', 'tps']}, 05:03:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['damp', 'tps']}, 05:03:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:03:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:58 INFO - 'other': {'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'other_l64': {'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'other_nol64': {'tests': ['a11yr', 05:03:58 INFO - 'ts_paint', 05:03:58 INFO - 'tpaint', 05:03:58 INFO - 'sessionrestore', 05:03:58 INFO - 'sessionrestore_no_auto_restore']}, 05:03:58 INFO - 'svgr': {'tests': ['tsvgx', 05:03:58 INFO - 'tsvgr_opacity', 05:03:58 INFO - 'tart', 05:03:58 INFO - 'tscrollx', 05:03:58 INFO - 'cart']}, 05:03:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['tsvgx', 05:03:58 INFO - 'tsvgr_opacity', 05:03:58 INFO - 'tart', 05:03:58 INFO - 'tscrollx', 05:03:58 INFO - 'cart']}, 05:03:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'tests': ['tp5o']}, 05:03:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'talos_options': ['--e10s'], 05:03:58 INFO - 'tests': ['tp5o']}, 05:03:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'talos_options': ['--xperf_path', 05:03:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:58 INFO - 'tests': ['tp5n']}, 05:03:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:58 INFO - 'talos_options': ['--e10s', 05:03:58 INFO - '--xperf_path', 05:03:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:58 INFO - 'tests': ['tp5n']}}, 05:03:58 INFO - 'talos.zip': {'path': '', 05:03:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:58 INFO - Running post-action listener: _resource_record_post_action 05:03:58 INFO - ##### 05:03:58 INFO - ##### Running create-virtualenv step. 05:03:58 INFO - ##### 05:03:58 INFO - Running pre-action listener: _resource_record_pre_action 05:03:58 INFO - Running main action method: create_virtualenv 05:03:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:03:58 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 05:03:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:03:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:58 INFO - Using real prefix '/usr' 05:03:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:03:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:01 INFO - Installing pip.................done. 05:04:01 INFO - Return code: 0 05:04:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:04:01 INFO - Using env: {'DISPLAY': ':0', 05:04:01 INFO - 'HOME': '/home/cltbld', 05:04:01 INFO - 'LANG': 'en_US.UTF-8', 05:04:01 INFO - 'LANGUAGE': 'en_US:en', 05:04:01 INFO - 'LOGNAME': 'cltbld', 05:04:01 INFO - 'MAIL': '/var/mail/cltbld', 05:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:01 INFO - 'MOZ_NO_REMOTE': '1', 05:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:01 INFO - 'NO_EM_RESTART': '1', 05:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:01 INFO - 'SHELL': '/bin/bash', 05:04:01 INFO - 'SHLVL': '1', 05:04:01 INFO - 'TERM': 'linux', 05:04:01 INFO - 'TMOUT': '86400', 05:04:01 INFO - 'USER': 'cltbld', 05:04:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:01 INFO - '_': '/tools/buildbot/bin/python'} 05:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:01 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 05:04:01 INFO - Cleaning up... 05:04:01 INFO - Return code: 0 05:04:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:04:01 INFO - Using env: {'DISPLAY': ':0', 05:04:01 INFO - 'HOME': '/home/cltbld', 05:04:01 INFO - 'LANG': 'en_US.UTF-8', 05:04:01 INFO - 'LANGUAGE': 'en_US:en', 05:04:01 INFO - 'LOGNAME': 'cltbld', 05:04:01 INFO - 'MAIL': '/var/mail/cltbld', 05:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:01 INFO - 'MOZ_NO_REMOTE': '1', 05:04:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:01 INFO - 'NO_EM_RESTART': '1', 05:04:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:01 INFO - 'SHELL': '/bin/bash', 05:04:01 INFO - 'SHLVL': '1', 05:04:01 INFO - 'TERM': 'linux', 05:04:01 INFO - 'TMOUT': '86400', 05:04:01 INFO - 'USER': 'cltbld', 05:04:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:01 INFO - '_': '/tools/buildbot/bin/python'} 05:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:01 INFO - Downloading/unpacking psutil>=0.7.1 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:04:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:04:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:03 INFO - Installing collected packages: psutil 05:04:03 INFO - Running setup.py install for psutil 05:04:03 INFO - building 'psutil._psutil_linux' extension 05:04:03 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 05:04:03 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 05:04:03 INFO - building 'psutil._psutil_posix' extension 05:04:03 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 05:04:04 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 05:04:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:04 INFO - Successfully installed psutil 05:04:04 INFO - Cleaning up... 05:04:04 INFO - Return code: 0 05:04:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:04:04 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')]} 05:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:04 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')]} 05:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:04 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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:04 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 05:04:04 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 05:04:04 INFO - Using env: {'DISPLAY': ':0', 05:04:04 INFO - 'HOME': '/home/cltbld', 05:04:04 INFO - 'LANG': 'en_US.UTF-8', 05:04:04 INFO - 'LANGUAGE': 'en_US:en', 05:04:04 INFO - 'LOGNAME': 'cltbld', 05:04:04 INFO - 'MAIL': '/var/mail/cltbld', 05:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:04 INFO - 'MOZ_NO_REMOTE': '1', 05:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:04 INFO - 'NO_EM_RESTART': '1', 05:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:04 INFO - 'SHELL': '/bin/bash', 05:04:04 INFO - 'SHLVL': '1', 05:04:04 INFO - 'TERM': 'linux', 05:04:04 INFO - 'TMOUT': '86400', 05:04:04 INFO - 'USER': 'cltbld', 05:04:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:04 INFO - '_': '/tools/buildbot/bin/python'} 05:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:04:04 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 05:04:04 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 05:04:04 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 05:04:04 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 05:04:04 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 05:04:04 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 05:04:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:04:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:04:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:04:06 INFO - Installing collected packages: mozsystemmonitor 05:04:06 INFO - Running setup.py install for mozsystemmonitor 05:04:06 INFO - Successfully installed mozsystemmonitor 05:04:06 INFO - Cleaning up... 05:04:06 INFO - Return code: 0 05:04:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:06 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 05:04:06 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 05:04:06 INFO - Using env: {'DISPLAY': ':0', 05:04:06 INFO - 'HOME': '/home/cltbld', 05:04:06 INFO - 'LANG': 'en_US.UTF-8', 05:04:06 INFO - 'LANGUAGE': 'en_US:en', 05:04:06 INFO - 'LOGNAME': 'cltbld', 05:04:06 INFO - 'MAIL': '/var/mail/cltbld', 05:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:06 INFO - 'MOZ_NO_REMOTE': '1', 05:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:06 INFO - 'NO_EM_RESTART': '1', 05:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:06 INFO - 'SHELL': '/bin/bash', 05:04:06 INFO - 'SHLVL': '1', 05:04:06 INFO - 'TERM': 'linux', 05:04:06 INFO - 'TMOUT': '86400', 05:04:06 INFO - 'USER': 'cltbld', 05:04:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:06 INFO - '_': '/tools/buildbot/bin/python'} 05:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:04:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:04:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:08 INFO - Downloading docopt-0.6.1.tar.gz 05:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:04:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:04:09 INFO - Running setup.py install for blobuploader 05:04:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:04:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:04:09 INFO - Running setup.py install for requests 05:04:09 INFO - Running setup.py install for docopt 05:04:09 INFO - Successfully installed blobuploader requests docopt 05:04:09 INFO - Cleaning up... 05:04:09 INFO - Return code: 0 05:04:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:09 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')]} 05:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:09 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')]} 05:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:09 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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:09 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 05:04:09 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 05:04:09 INFO - Using env: {'DISPLAY': ':0', 05:04:09 INFO - 'HOME': '/home/cltbld', 05:04:09 INFO - 'LANG': 'en_US.UTF-8', 05:04:09 INFO - 'LANGUAGE': 'en_US:en', 05:04:09 INFO - 'LOGNAME': 'cltbld', 05:04:09 INFO - 'MAIL': '/var/mail/cltbld', 05:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:09 INFO - 'MOZ_NO_REMOTE': '1', 05:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:09 INFO - 'NO_EM_RESTART': '1', 05:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:09 INFO - 'SHELL': '/bin/bash', 05:04:09 INFO - 'SHLVL': '1', 05:04:09 INFO - 'TERM': 'linux', 05:04:09 INFO - 'TMOUT': '86400', 05:04:09 INFO - 'USER': 'cltbld', 05:04:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:09 INFO - '_': '/tools/buildbot/bin/python'} 05:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:09 INFO - Running setup.py (path:/tmp/pip-0cF3zc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:09 INFO - Running setup.py (path:/tmp/pip-KmMfOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:09 INFO - Running setup.py (path:/tmp/pip-QryYPO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:10 INFO - Running setup.py (path:/tmp/pip-4fOvlh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:10 INFO - Running setup.py (path:/tmp/pip-vvKtBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:10 INFO - Running setup.py (path:/tmp/pip-BzyzrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:10 INFO - Running setup.py (path:/tmp/pip-6iB7Gb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:10 INFO - Running setup.py (path:/tmp/pip-D8jVb3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:10 INFO - Running setup.py (path:/tmp/pip-JDxepX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:10 INFO - Running setup.py (path:/tmp/pip-skWYC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:10 INFO - Running setup.py (path:/tmp/pip-1snwmE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:10 INFO - Running setup.py (path:/tmp/pip-XHs9jW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:10 INFO - Running setup.py (path:/tmp/pip-jcDaxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:10 INFO - Running setup.py (path:/tmp/pip-Al2M7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:10 INFO - Running setup.py (path:/tmp/pip-8h8kBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:10 INFO - Running setup.py (path:/tmp/pip-MJbcLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:10 INFO - Running setup.py (path:/tmp/pip-EhzmSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:04:11 INFO - Running setup.py install for manifestparser 05:04:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Running setup.py install for mozcrash 05:04:11 INFO - Running setup.py install for mozdebug 05:04:11 INFO - Running setup.py install for mozdevice 05:04:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Running setup.py install for mozfile 05:04:11 INFO - Running setup.py install for mozhttpd 05:04:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Running setup.py install for mozinfo 05:04:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Running setup.py install for mozInstall 05:04:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:04:11 INFO - Running setup.py install for mozleak 05:04:11 INFO - Running setup.py install for mozlog 05:04:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Running setup.py install for moznetwork 05:04:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Running setup.py install for mozprocess 05:04:12 INFO - Running setup.py install for mozprofile 05:04:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Running setup.py install for mozrunner 05:04:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Running setup.py install for mozscreenshot 05:04:12 INFO - Running setup.py install for moztest 05:04:12 INFO - Running setup.py install for mozversion 05:04:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:04:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:04:12 INFO - Cleaning up... 05:04:12 INFO - Return code: 0 05:04:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04:12 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')]} 05:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:12 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')]} 05:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:12 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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:12 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 05:04:12 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 05:04:12 INFO - Using env: {'DISPLAY': ':0', 05:04:12 INFO - 'HOME': '/home/cltbld', 05:04:12 INFO - 'LANG': 'en_US.UTF-8', 05:04:12 INFO - 'LANGUAGE': 'en_US:en', 05:04:12 INFO - 'LOGNAME': 'cltbld', 05:04:12 INFO - 'MAIL': '/var/mail/cltbld', 05:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:12 INFO - 'MOZ_NO_REMOTE': '1', 05:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:12 INFO - 'NO_EM_RESTART': '1', 05:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:12 INFO - 'SHELL': '/bin/bash', 05:04:12 INFO - 'SHLVL': '1', 05:04:12 INFO - 'TERM': 'linux', 05:04:12 INFO - 'TMOUT': '86400', 05:04:12 INFO - 'USER': 'cltbld', 05:04:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:12 INFO - '_': '/tools/buildbot/bin/python'} 05:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:13 INFO - Running setup.py (path:/tmp/pip-_ctKTx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:13 INFO - Running setup.py (path:/tmp/pip-sq_Rac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:13 INFO - Running setup.py (path:/tmp/pip-O4_H_5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:13 INFO - Running setup.py (path:/tmp/pip-WOJSIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:13 INFO - Running setup.py (path:/tmp/pip-xFJ3tR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:13 INFO - Running setup.py (path:/tmp/pip-id9PM0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:13 INFO - Running setup.py (path:/tmp/pip-cqLUW6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:13 INFO - Running setup.py (path:/tmp/pip-pGM92u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:13 INFO - Running setup.py (path:/tmp/pip-aJHW2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:13 INFO - Running setup.py (path:/tmp/pip-YNujeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:13 INFO - Running setup.py (path:/tmp/pip-IGOCuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:13 INFO - Running setup.py (path:/tmp/pip-Rc3j_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:13 INFO - Running setup.py (path:/tmp/pip-EdDcPH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:04:13 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)) 05:04:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:13 INFO - Running setup.py (path:/tmp/pip-DVfAms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:04:14 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)) 05:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:14 INFO - Running setup.py (path:/tmp/pip-v04nOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:04:14 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)) 05:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:14 INFO - Running setup.py (path:/tmp/pip-2wMsDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:04:14 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)) 05:04:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:14 INFO - Running setup.py (path:/tmp/pip-buR7GP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 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)) 05:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:04:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:15 INFO - Downloading blessings-1.5.1.tar.gz 05:04:15 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 05:04:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:04:16 INFO - Installing collected packages: blessings 05:04:16 INFO - Running setup.py install for blessings 05:04:16 INFO - Successfully installed blessings 05:04:16 INFO - Cleaning up... 05:04:16 INFO - Return code: 0 05:04:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:04:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:16 INFO - Reading from file tmpfile_stdout 05:04:16 INFO - Current package versions: 05:04:16 INFO - argparse == 1.2.1 05:04:16 INFO - blessings == 1.5.1 05:04:16 INFO - blobuploader == 1.2.4 05:04:16 INFO - docopt == 0.6.1 05:04:16 INFO - manifestparser == 1.1 05:04:16 INFO - mozInstall == 1.12 05:04:16 INFO - mozcrash == 0.16 05:04:16 INFO - mozdebug == 0.1 05:04:16 INFO - mozdevice == 0.48 05:04:16 INFO - mozfile == 1.2 05:04:16 INFO - mozhttpd == 0.7 05:04:16 INFO - mozinfo == 0.9 05:04:16 INFO - mozleak == 0.1 05:04:16 INFO - mozlog == 3.1 05:04:16 INFO - moznetwork == 0.27 05:04:16 INFO - mozprocess == 0.22 05:04:16 INFO - mozprofile == 0.28 05:04:16 INFO - mozrunner == 6.11 05:04:16 INFO - mozscreenshot == 0.1 05:04:16 INFO - mozsystemmonitor == 0.0 05:04:16 INFO - moztest == 0.7 05:04:16 INFO - mozversion == 1.4 05:04:16 INFO - psutil == 3.1.1 05:04:16 INFO - requests == 1.2.3 05:04:16 INFO - wsgiref == 0.1.2 05:04:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:16 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 05:04:16 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 05:04:16 INFO - Using env: {'DISPLAY': ':0', 05:04:16 INFO - 'HOME': '/home/cltbld', 05:04:16 INFO - 'LANG': 'en_US.UTF-8', 05:04:16 INFO - 'LANGUAGE': 'en_US:en', 05:04:16 INFO - 'LOGNAME': 'cltbld', 05:04:16 INFO - 'MAIL': '/var/mail/cltbld', 05:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:16 INFO - 'MOZ_NO_REMOTE': '1', 05:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:16 INFO - 'NO_EM_RESTART': '1', 05:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:16 INFO - 'SHELL': '/bin/bash', 05:04:16 INFO - 'SHLVL': '1', 05:04:16 INFO - 'TERM': 'linux', 05:04:16 INFO - 'TMOUT': '86400', 05:04:16 INFO - 'USER': 'cltbld', 05:04:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:16 INFO - '_': '/tools/buildbot/bin/python'} 05:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 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)) 05:04:16 INFO - Cleaning up... 05:04:16 INFO - Return code: 0 05:04:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:04: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')]} 05:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:04:16 INFO - Using env: {'DISPLAY': ':0', 05:04:16 INFO - 'HOME': '/home/cltbld', 05:04:16 INFO - 'LANG': 'en_US.UTF-8', 05:04:16 INFO - 'LANGUAGE': 'en_US:en', 05:04:16 INFO - 'LOGNAME': 'cltbld', 05:04:16 INFO - 'MAIL': '/var/mail/cltbld', 05:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:16 INFO - 'MOZ_NO_REMOTE': '1', 05:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:16 INFO - 'NO_EM_RESTART': '1', 05:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:16 INFO - 'SHELL': '/bin/bash', 05:04:16 INFO - 'SHLVL': '1', 05:04:16 INFO - 'TERM': 'linux', 05:04:16 INFO - 'TMOUT': '86400', 05:04:16 INFO - 'USER': 'cltbld', 05:04:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:16 INFO - '_': '/tools/buildbot/bin/python'} 05:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:16 INFO - Downloading/unpacking jsonschema 05:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:18 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 05:04:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:18 INFO - warning: no files found matching '*.txt' 05:04:18 INFO - no previously-included directories found matching 'build' 05:04:18 INFO - no previously-included directories found matching 'dist' 05:04:18 INFO - no previously-included directories found matching '.git*' 05:04:18 INFO - Installing collected packages: jsonschema, functools32 05:04:18 INFO - Running setup.py install for functools32 05:04:18 INFO - warning: no files found matching '*.txt' 05:04:18 INFO - no previously-included directories found matching 'build' 05:04:18 INFO - no previously-included directories found matching 'dist' 05:04:18 INFO - no previously-included directories found matching '.git*' 05:04:18 INFO - Successfully installed jsonschema functools32 05:04:18 INFO - Cleaning up... 05:04:19 INFO - Return code: 0 05:04:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:19 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 0x7f134c3d1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243e630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, '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': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', '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 05:04:19 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 05:04:19 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 05:04:19 INFO - Using env: {'DISPLAY': ':0', 05:04:19 INFO - 'HOME': '/home/cltbld', 05:04:19 INFO - 'LANG': 'en_US.UTF-8', 05:04:19 INFO - 'LANGUAGE': 'en_US:en', 05:04:19 INFO - 'LOGNAME': 'cltbld', 05:04:19 INFO - 'MAIL': '/var/mail/cltbld', 05:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:19 INFO - 'MOZ_NO_REMOTE': '1', 05:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:19 INFO - 'NO_EM_RESTART': '1', 05:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:19 INFO - 'SHELL': '/bin/bash', 05:04:19 INFO - 'SHLVL': '1', 05:04:19 INFO - 'TERM': 'linux', 05:04:19 INFO - 'TMOUT': '86400', 05:04:19 INFO - 'USER': 'cltbld', 05:04:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:19 INFO - '_': '/tools/buildbot/bin/python'} 05:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:19 INFO - Downloading/unpacking flake8 05:04:19 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 05:04:19 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 05:04:19 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 05:04:19 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 05:04:19 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 05:04:19 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 05:04:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:04:20 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 05:04:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:04:20 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 05:04:20 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 05:04:20 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 05:04:20 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 05:04:20 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 05:04:20 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 05:04:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:04:21 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 05:04:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:21 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 05:04:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04: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 05:04:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:21 INFO - no previously-included directories found matching 'docs/_build' 05:04:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:21 INFO - Running setup.py install for pep8 05:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:21 INFO - no previously-included directories found matching 'docs/_build' 05:04:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:04:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:21 INFO - Cleaning up... 05:04:21 INFO - Return code: 0 05:04:21 INFO - Running post-action listener: _resource_record_post_action 05:04:21 INFO - Running post-action listener: _start_resource_monitoring 05:04:21 INFO - Starting resource monitoring. 05:04:21 INFO - ##### 05:04:21 INFO - ##### Running install step. 05:04:21 INFO - ##### 05:04:21 INFO - Running pre-action listener: _resource_record_pre_action 05:04:21 INFO - Running main action method: install 05:04:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:22 INFO - Reading from file tmpfile_stdout 05:04:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:04:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:04:22 INFO - Reading from file tmpfile_stdout 05:04:22 INFO - Output received: 05:04:22 INFO - Usage: mozinstall [options] installer 05:04:22 INFO - Options: 05:04:22 INFO - -h, --help show this help message and exit 05:04:22 INFO - -d DEST, --destination=DEST 05:04:22 INFO - Directory to install application into. [default: 05:04:22 INFO - "/builds/slave/test-pgo"] 05:04:22 INFO - --app=APP Application being installed. [default: firefox] 05:04:22 INFO - mkdir: /builds/slave/test-pgo/build/application 05:04:22 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'] 05:04:22 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 05:04:38 INFO - Reading from file tmpfile_stdout 05:04:38 INFO - Output received: 05:04:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:04:38 INFO - Running post-action listener: _resource_record_post_action 05:04:38 INFO - ##### 05:04:38 INFO - ##### Running run-tests step. 05:04:38 INFO - ##### 05:04:38 INFO - Running pre-action listener: _resource_record_pre_action 05:04:38 INFO - Running main action method: run_tests 05:04:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:04:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:04:38 INFO - Python 2.7.3 05:04:38 INFO - Return code: 0 05:04:38 INFO - grabbing minidump binary from tooltool 05:04:38 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')]} 05:04:38 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 0x24cf840>, '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 0x243c6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x243cb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:04:38 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 05:04:38 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 05:04:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:38 INFO - Return code: 0 05:04:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:04:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:04:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:04:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:04:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:04:39 INFO - Return code: 0 05:04:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:04:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 05:04:39 INFO - Using env: {'DISPLAY': ':0', 05:04:39 INFO - 'HOME': '/home/cltbld', 05:04:39 INFO - 'LANG': 'en_US.UTF-8', 05:04:39 INFO - 'LANGUAGE': 'en_US:en', 05:04:39 INFO - 'LOGNAME': 'cltbld', 05:04:39 INFO - 'MAIL': '/var/mail/cltbld', 05:04:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:39 INFO - 'MOZ_NO_REMOTE': '1', 05:04:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:39 INFO - 'NO_EM_RESTART': '1', 05:04:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:04:39 INFO - 'SHELL': '/bin/bash', 05:04:39 INFO - 'SHLVL': '1', 05:04:39 INFO - 'TERM': 'linux', 05:04:39 INFO - 'TMOUT': '86400', 05:04:39 INFO - 'USER': 'cltbld', 05:04:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143', 05:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:39 INFO - '_': '/tools/buildbot/bin/python'} 05:04:39 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:04:39 INFO - mozversion application_buildid: 20160118023004 05:04:39 INFO - mozversion application_changeset: 80cf5f6c1863a73c59e6337eb19562aa4874e0f6 05:04:39 INFO - mozversion application_display_name: Nightly 05:04:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:39 INFO - mozversion application_name: Firefox 05:04:39 INFO - mozversion application_remotingname: firefox 05:04:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:39 INFO - mozversion application_vendor: Mozilla 05:04:39 INFO - mozversion application_version: 46.0a1 05:04:39 INFO - mozversion platform_buildid: 20160118023004 05:04:39 INFO - mozversion platform_changeset: 80cf5f6c1863a73c59e6337eb19562aa4874e0f6 05:04:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:39 INFO - mozversion platform_version: 46.0a1 05:04:39 INFO - using testdate: 1453122279 05:04:39 INFO - actual date: 1453122279 05:04:39 INFO - starting webserver on 'localhost:60718' 05:04:39 INFO - SUITE-START | Running 3 tests 05:04:39 INFO - TEST-START | dromaeo_css 05:04:39 INFO - operating with platform_type : linux_ 05:04:39 INFO - Initialising browser for dromaeo_css test... 05:04:39 INFO - TEST-INFO | started process 26865 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplAPkWq/profile http://localhost:60718/getInfo.html) 05:04:43 INFO - PROCESS | 26865 | __metrics Screen width/height:1600/1200 05:04:43 INFO - PROCESS | 26865 | colorDepth:24 05:04:43 INFO - PROCESS | 26865 | Browser inner width/height: 1024/697 05:04:43 INFO - PROCESS | 26865 | __metrics 05:04:43 INFO - PROCESS | 26865 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:04:43 INFO - PROCESS | 26865 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:44 INFO - TEST-INFO | 26865: exit 0 05:04:44 INFO - Browser initialized. 05:04:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:44 INFO - TEST-INFO | started process 26958 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplAPkWq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:56 INFO - PROCESS | 26958 | RSS: Main: 150085632 05:04:56 INFO - PROCESS | 26958 | 05:05:47 INFO - PROCESS | 26958 | 1453122347842 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] 05:07:56 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60718/tests/dromaeo/cssquery-ext.html) 05:07:57 INFO - PROCESS | 26958 | RSS: Main: 259411968 05:07:57 INFO - PROCESS | 26958 | 05:10:59 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-ext.html (next: http://localhost:60718/tests/dromaeo/cssquery-jquery.html) 05:11:00 INFO - PROCESS | 26958 | RSS: Main: 234201088 05:11:00 INFO - PROCESS | 26958 | 05:14:02 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60718/tests/dromaeo/cssquery-mootools.html) 05:14:02 INFO - PROCESS | 26958 | RSS: Main: 225464320 05:14:02 INFO - PROCESS | 26958 | 05:17:04 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60718/tests/dromaeo/cssquery-prototype.html) 05:17:05 INFO - PROCESS | 26958 | RSS: Main: 211718144 05:17:05 INFO - PROCESS | 26958 | 05:20:07 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60718/tests/dromaeo/cssquery-yui.html) 05:20:08 INFO - PROCESS | 26958 | RSS: Main: 215490560 05:20:08 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | Cycle 1(1): loaded http://localhost:60718/tests/dromaeo/cssquery-yui.html (next: http://localhost:60718/tests/dromaeo/cssquery-dojo.html) 05:23:11 INFO - PROCESS | 26958 | RSS: Main: 277745664 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | __start_tp_report 05:23:11 INFO - PROCESS | 26958 | _x_x_mozilla_page_load 05:23:11 INFO - PROCESS | 26958 | _x_x_mozilla_page_load_details 05:23:11 INFO - PROCESS | 26958 | |i|pagename|runs| 05:23:11 INFO - PROCESS | 26958 | |0;dojo.html;3025.1832005358556;3043.9239019024535;3073.738732207762;3095.6749541298163;3123.203583086313;4907.82822601209;4989.825356112537;5030.1951687729925;5061.595072394213;5098.31172791673;4949.28235405866;5018.071656743505;5067.290579318889;5087.694738315704;5103.923441148377;4566.566176213263;4582.793774280149;4594.885127871797;4647.34937108805;4746.952530474703;4574.6569007324415;4652.790624421909;4702.8118875244945;4703.059388122372;4704.788284527187;4536.115457485775;4611.262198048296;4618.261078227468;4641.303804429329;4683.90632187356;4572.611328037121;4578.198815207325;4585.679002469828;4588.839390621346;4589.495155532889;4541.8410355637725;4567.634589232886;4569.337446070301;4569.817207311704;4569.862904112882;4863.927041094386;4872.147374209535;4887.926681099786;4890.926636100461;4906.067847109038;5373.75818088183;5376.865578360533;5382.407935127133;5386.542143917772;5431.945680543184;5243.79024839006;5319.148936170232;5413.945860541423;5436.782528698887;5446.564274858041;4978.054169707781;4983.202687569971;5012.699238045765;5020.322256495363;5024.145895197825;5497.972510137423;5503.807366742225;5612.158176273591;5612.85967850807;5618.943810561924;5323.30796996388;5359.08895487768;5359.249705041298;5367.355917289872;5372;5266.7629956652045;5406.864828379244;5422.267993820863;5430.809921652803;5485.177223416519;5271.367435907716;5273.261743355856;5309;5423.755930983115;5474.09677403224;5323.387810401776;5327.147656374961;5337.706426146521;5344.759485823147;5345.118055520873;4125.463689720317;4226.091390351089;4227;4247.681423893158;4273.337632666941;3748.925021499609;3755.061234691327;3801.885943421702;3839.500864887547;3843.7885916274313;4977.178765503651;4982.526659967298;4986.501349864984;4991.425986011655;5037.7733002014265;5256.159014557652;5340.519353258225;5376.569874410116;5383.78464861409;5385.246065550826;4896.290037944549;4995.075910956485;5000.299958005882;5001.349824522788;5044.873878153002;4618.076384723069;4628.490866004737;4628.814847406066;4630.143423466669;4649.18639238132;5469.453054694499;5552.41699621542;5567.331920169606;5568.109102543654;5631.633943793722;5307.57539396855;5404.72976351173;5405.918911216414;5433.320834895638;5448.101063324507;5528;5530;5532.391436941853;5534.1975413565615;5542.3903370628395;5127.846164615067;5232.372115346183;5249.133892907627;5272.736363181903;5298.97350513245;5248.790048398021;5266.8419947401635;5268.2624432578705;5274.920876186783;5324.946750532445;5208.8437346879655;5225.686458812484;5268.710220937732;5281.049411105884;5302.416734159317;5095.745212739423;5187.58499320061;5206.375234971828;5259.973700131475;5261.421243663118;5181.53366197044;5217.243499692448;5219.2953951216095;5223.4776522347465;5224.138017227115;5299.894002120013;5325.414204437431;5368.919466208088;5374.865628359166;5377.300950876361;5065.898682026413;5122.334096567422;5132.050570644443;5176.275321454924;5201.817936372209 05:23:11 INFO - PROCESS | 26958 | |1;ext.html;514.3108234965146;534.48689258312;537.1405750798722;541.5640409470375;550.6448340820172;27933.580996285073;28524.714752852466;28530.14409567711;28542;28552;36990;37623.24753504928;37673.62326376735;37710.622893771055;37795.62204377956;8401.033881103675;8623.310135189202;8625.784355391103;8627.094155113686;8628.09405012474;8234.464759790595;8284.46151000186;8363.83272334553;8370.53962032088;8370.790730231762;8315.66737330509;8370.874436883452;8394.958025209866;8563.914360856405;8626.956865215665;8498.235158835703;8564.82870342596;8573.314134869195;8577.099404562556;8582.442141260799;8456.323494120517;8561.871571926426;8586.527740974245;8588.098249683755;8594.613242404106;38827.22345553073;39294.60705392966;39304.80347598244;39323.41014884779;39335.8033209835;3193.1697758582704;3299.7268438043207;3314.950275745866;3558.6085530591613;3814.7329686921926;29598.70401295981;29703.851480742458;30225;31174.37651246985;31204.375912481624;3847.903802404934;3850.191459793447;3877.84971843913;3891.4746509221177;3902.6682731967817;276462;277041;277082;277247;277268;51171;52528;55265.72367138219;57205.42794572084;58487.415125849046;53065.469345306825;53084;53318.200226996625;53404;53459.46540534623;12256.81614775779;12676.87323126757;12854.228746275254;12855.550055748005;12861.099723019299;8909.1536304051;9546.856797148048;9694.806103878023;9707.90292097084;9737.756556086013;18404.17181226848;18503.629927401376;18619.44141675752;18622;18652.067396630115;7280.854382912312;7398.11222653285;7506.249375062559;7524.9247507525315;7640.159582445926;961.1974001708652;1003.8996100390049;1019.4240254256322;1041.9479026048666;1101.6639924822846;28362.43275134527;28523.71476285252;28728.856355718086;29000.85499572531;29158.41683166325;1012.9949350253202;1101.5924108080062;1102.2835157147917;1121.4168632311153;1142.87999760024;14057.71884562303;14097.71804563903;14277.78583321251;14372.137671739729;14521.78217326741;332185;335336;335908;335983;336551;49112;49778;49926.25110623344;49930;49958.50041499611;1304.1132030219542;1325.9337033148304;1345.1861623717705;1351.0880155894731;1356.1930651262483;26445.73554264433;27286.727132728418;27737.583936240568;27792.58311125294;27896.302592435353;45040.54959450495;45094.77452612716;45351.77324113358;45361;45404.318935215335;281438;285503.30470257776;405073;413611;415091;30445.39109217759;30491.426286057267;30602.234944126576;30602.540961886036;30619.693803061684;40916.79541602273;41249.79375103105;41491;41916.79041604773;42277.36583951182;35069.82465087658;35203.471947921316;35433.82283088568;35544.28911421809;36082.63917360898;35438.11404714903;35622.82188589144;35727.46408803922;36477.81761091178;36502.8174859124;34663;35538;35642;35651.82174089113;35657.28685426225;29243.561346580245;31935;31951.36097277995;32082;32320.35359292754;24519;31439.371212575163;31462.213444664067;31516;31942 05:23:11 INFO - PROCESS | 26958 | |2;jquery.html;359.6870722471452;359.9100224943765;360.1572320769399;361.6239111324223;364.21693359277566;13642.454301827915;13714.24571648559;15754.369825206992;16863;18275.725864112017;15271.236438178075;15961.281742321595;16142.273597688103;16150.919245403786;17013.659726805457;5303.23103150043;5510.201020851974;5514.972425137868;5515.641483303592;5522.6686398816;4031.3751368537924;4114.012636967122;5366.4633536646215;5470.370907345667;5693.174489699012;5671.62538289719;5855.531557475413;5879.176915231871;5900.527957763368;5905.527557795387;5872.530197584183;5923.17075609415;5930.851728706773;5949.107633854935;5949.3158286796925;5247.39654939683;5261.500157485033;6167.660778657172;6455.806325810233;6462.192225971754;20449;21092.789072109237;22217.888910555343;23007.389482736216;23301.883490582437;2048.9692654610194;2062.391594479632;2076.8546201765885;2173.217641649005;2257.559775843711;13457.932710336385;13458.057935944487;13563;13624.93187534056;13919.860801391958;1895.5261184703825;2000.8999550022586;2011.3463124484601;2035.5827055453597;2061.165228082614;65332.366690832634;65749.67125164343;68295;68441.315586844;69130.65434672845;15201.771973420407;15290.617734556503;15304.923475382775;15308.923455382874;15327.157006364534;23042.313229883475;23060.654090188662;23272.65091023636;23368.182113625942;23440.882795586254;7913.841723165505;7968.920310796933;7986.480878742863;8063.233992770677;8079.515229086156;6543.967280163569;6567.605943643397;6621.702023408958;6644.169478815148;6665.533412661164;7529.284717951786;7529.58587277705;7532.154622117616;7545.660445279976;7546.434017448713;2596.2730435478097;2951.099914526047;3034.24143964009;3043.5738996540504;3049.771267154928;827.995860020696;895.1540793949786;895.4537731983485;1009.9949500252452;1066.2323127348297;15969.840301596836;16644;16759.497215083567;17036.574085647957;17112.144392780312;904.7783293093235;914.9130832570895;974.4396971741277;980.9068138526828;993.2451336983944;9127.22418594427;9587.808243835085;9829.55766990487;9893.109620134222;10090.142337901214;381856;470538;509500;539521;543049;60974.085388719206;60980;63355.68322158452;64562.031569526494;65213;1122.5958654884234;1128.4132251229314;1145.7593905279984;1150.0971737186435;1153.4636394076795;11697.2981621103;13877.889768818268;14651.70696586041;15299.541013769605;15497.5350739478;30722.846385767927;32355.19112022124;32982.50526242156;33413.66586334203;34297.31405371929;39781;40138.79930600328;40992.79503602463;41608.82967087552;42755.572444276404;7168.820779480555;7284.344409003215;7307.488475806643;7325.560466372035;7424.740134095281;10428.113610343205;10535.947320263656;10991.395473249047;11005.944970275097;11288.435578220891;9329.766755831159;9683.757906052406;9796;9942.950285248528;10240.641577545048;9888.703338899844;10105.141063009432;10244.436555989492;10442.738931526772;10552.84170737455;9295.814083718424;9590.856137157809;9653.1794797443;9688.41869487833;10029.247806414402;7427.925720742724;7662.195469475625;7676.117246516722;7744.806379840549;7775.339096176888;9192.632294708137;9433.29250306216;9452.385594936308;9694.612215511583;9704.805903882025 05:23:11 INFO - PROCESS | 26958 | |3;mootools.html;1271.790154624487;1449.268119599602;1463.6414078550754;1599.1284749811352;1775.405239244852;6808.046873437723;7384;7453.925460745391;7500.774976750693;7514.098308203023;7316.341529262365;7508.211637778037;7509.662065207065;7514.211007844166;7526.36025937796;1957.3345062678686;1999.7100420439028;2001.5096301406177;2270.2281224383705;2276.4422716434497;1998.1607724755565;2227.387468446174;2273.818094552432;2288.1533832481923;2289.416198869286;2193.363924461912;2237.966430503544;2239.0819763896807;2270.19408110121;2282.395165281202;2221.9333419997347;2222.3666255117296;2226.565819665166;2227.265002549155;2231.453293942994;2239.697640818485;2245.7305123385136;2255.07541907817;2258.8531745436494;2271.216430331533;7668.118166410878;7735.535867847947;7737.690492380298;7746.961265193694;7747.8450430991625;4695.765211739434;4778.761061946889;4815.205491093965;4818.638602104857;4827.710337379734;3033.1507177990197;3043.9086827395213;3152.763542734304;3158.699923507263;3177.7934434261697;998.4807899892015;1005.2209537608339;1016.9440680762555;1025.3284098915221;1025.3489034463096;10435.426051567161;10455.84316235257;10485.528151233137;10492.317999330095;10496.475176241158;4197.160567886435;4240.49114106303;4264.850730224427;4283.22901877665;4284.785760711952;9025;9043.77390565228;9065.818683626423;9147.817043659223;9153.267738581031;4644.396228490342;4647.302904564275;4652;4652.395188625457;4655.092257009851;4149.8962525937095;4192.203481338536;4193.18232944579;4195.895102622398;4201;3402.8468718907707;3458.56767904012;3514.806685632315;3591.694705949971;3607.404778211566;1165.9941700291613;1177.2759752752168;1177.8527684039495;1182.1901997131993;1190.9583164589199;1286.9420876060412;1290.7160424706738;1311.5081844308384;1332.4936524120772;1348;6998.720051197997;7047.894281585678;7146.964265178641;7232;7232.566046037255;1098.8516550265613;1098.9505472253768;1116.9329840209614;1118.9160812939062;1127.3799410324289;5738.856528586735;5811.215485909348;5817.447342502455;5823.980803359395;5827;8893.777655558533;9136.497492637836;9347.485888276211;9350.719478415658;9431.292653051049;9270.814583708288;9291.72124836256;9320.440773553608;9325.673601423918;9328.160465558132;7139.92860071403;7165;7199.964000179965;7292.708291668274;7294.416446684252;6994.405475534637;7041.471889608402;7048.471364647569;7050.118735158106;7053.541519801196;7968.960155199187;8340.874886876823;8375.916240837758;8439.156084391758;8448.619812108347;8100.513969161869;8161.428699990944;8315.792105197419;8318.875216871873;8320.70877519284;6584.407403333723;6841.3842754152365;6853.931460685529;6859.9314006859295;6860;6457.4511166551365;6661.966690166518;6972.477064220102;7060.576365417885;7116.786496405116;6797.864042719217;6798.932010680028;6818.522703410714;6931.133608298963;7012.859742805217;6700.664966751546;6732.596044237362;6739.629320387426;6831.863362732817;6843.349881761224;6700.162479690039;6754.155730533684;6758.324167583202;6758.459323254227;6765.594064356154;6048;6124.5712800103565;6202.906956395567;6236.469900058364;6242.781502647385;6340.207474065742;6350.301466838737;6383.6808159592765;6383.744650213939;6433.613983161025 05:23:11 INFO - PROCESS | 26958 | |4;prototype.html;331.79262960649595;332.77703938361293;335.14203638684967;344.4471623045012;347.74440786022285;5789.76840926363;5802.680852553108;5811.912821307684;5812.070068788995;5817.418258174186;5463.098588732864;5547.77808887644;5603.80386686466;5678.290213723285;5715.228444160037;4457.576530229623;4467.53090925453;4469.977650111761;4474.418325617665;4496.820127194908;4309.138172365524;4474.127545128701;4488.05750792334;4488.326750987346;4490.41624588803;4342.196693611676;4385.934210986838;4470.597646211841;4475.216837053519;4491.124230775;4454.599086082252;4461.375407442961;4463.152001119777;4464.709793863389;4477;3965.2267807777494;3976.2445135424464;3979.4826672532386;3982.3230050891416;3983.960160398388;5413.945860541423;5432.022235997519;5505.284313039279;5511.724413779335;5513.145462453326;5182.196759502283;5188.584913206934;5189.195674670432;5191.714455704935;5192.065428222918;6037.275526936795;6048.1834952281315;6051.727672254759;6053.909191362133;6057.394260573951;4374.4094547236355;4393.055493068973;4393.29707246839;4407.427034485497;4422.248217802981;6205.627662340274;6342.302346741854;6350.142730731338;6350.23797144341;6366.490680745529;4442.8667139985855;4444.2000439920475;4445.955540444619;4446.710963787344;4447.533009034069;4491.011977364975;4493.28107502798;4494.483134439516;4495.168393847149;4503.189425903303;5134.435212126663;5136.383633963948;5147.794088236428;5148.742562871841;5150.304708864331;5945.7621695132575;6123.418275263843;6126.142340072393;6131.63210207389;6132.908006379907;1563.1793308512895;1578.9842101579068;1580.123031717385;1580.446843604752;1580.5179420276927;1061.230607809332;1063.6064656077147;1064.180580952662;1069;1076.278893141597;5760.107183386582;5773.624714393551;5774.884502310014;5781.88436231273;5784.1034639630925;6262.68686565679;6268.529860260499;6269.185005949197;6279.717412716439;6286.371362863677;5608.915866262009;5673.120666296731;5752.165935939265;5834.854128646818;5844.912326315109;3382.374260761767;3389.474631432132;3407.6251612322626;3410.5736782902136;3417.0773891049275;6622.4039836413995;6623.30455302196;6623.370779775913;6632.668366581652;6635.303293154246;6277.435030847154;6474.125992990886;6488.416042556099;6495.7076931538195;6497.610143391412;6632.336766323329;6636.634985075771;6644.103046088813;6647.135872336566;6647.833804154838;6358.90461643085;6409.935900640934;6411.134496843053;6415.422611964946;6438.3883531064475;6132.908006379818;6275.466585340298;6276.780312689034;6288.748450061947;6296.244450665949;6623.304553022056;6631.767888124085;6633.402993730394;6634.33656634352;6634.5024123191915;4393.209222339881;4445.110977804517;4445.977770111129;4450.376947227326;4453.398791163151;6159;6329.841753956004;6330.272018717722;6352.174217351715;6364.268109167505;6165.321814600301;6171.290301615371;6172.135900973777;6172.9074063889975;6175;6150.907736384047;6152.630842149485;6160.383961603804;6160.537959652955;6160.661163635864;5893.2044174035955;6052.061930400619;6061.272647282354;6063.423974722395;6064;6184.876302474016;6187.84530386744;6189.257289125334;6189.473894718819;6195.721192546436;6037.0642550404755;6043.214382130295;6061.605995610271;6063.939360606338;6065.120557519223 05:23:11 INFO - PROCESS | 26958 | |5;yui.html;708.228031445724;740.981475463113;832.3507664022061;834.440924580531;840.7645859159434;12813.679658008554;12887.226766394011;12942.288174150419;12957.805632915513;12962.74074518509;11816.704582385444;11829.231099978495;11831.822522662145;11836.053115750741;11839.70400739982;663.2339647706895;665.8514063240895;792.3779832831228;794.3010151067053;800.4876878797575;793.896793416855;798.6805277888833;798.9081255655586;799.2007992007992;799.9280064794167;857.5926434943383;858.8582883824162;858.9484630922134;859.4542465534399;859.6174702257498;842.0568962761715;845.7589586967746;849.2738708404318;851.8594431918726;852.9872051919226;626.1828314050163;627.0625415004597;627.2567008095422;627.4353082225988;628.2241431831684;13147.342632868318;13217.867821321759;13230.66923326915;13247.138935969131;13252.46990120394;12919.289439080847;12925.285182457015;13052.21686698801;13359.398827052806;13394.129381590166;10342.120919721832;10364.740881477948;10522;10659.733506662318;10665.520051597698;3568.429051351797;3590.263995880864;3623.3296840084668;3674.393725035366;3731.477593136963;43110.13779724388;43355.56644433578;45231.547684523066;48939.755301223624;49049.75475122637;9807.558659860324;10016.849747253651;10188.286819922683;10242.180625549938;10321.483925803679;15704.607384815243;17593;17785.911070444825;17991.73012404789;18006.009669468043;6515.934840651627;7602.42981776369;7747.2640099190485;7862.606869656494;7890.053193616803;4197.622214000755;4236.894077648083;4273.252180868336;4323.178596066738;4329.307310830252;3056.1442796016704;3097.3650401667605;3100.5969224000737;3105.3478769458666;3107.285324375406;561.1106396361731;569.4618585436805;583.1049339264209;584.3484514766005;590.8936391449495;532.0768466710255;563.3296377311069;576.4725276372156;612.7303986246127;661.0909998751716;8923;8945.865812012826;8981.955090224506;9000.952138822795;9426.340156189139;638.237306418825;655.1941112431736;670.1355251725317;671.0404122105436;673.7069374821968;3848.0956975110826;4011.3782363733667;4115.444415003996;4117.835286588503;4132.752034877917;54381.45618543843;55612.443875560726;55818.44181558213;56510.152347714815;56838.147427788615;47504.28743568849;48004;48063.519364806605;48173;48343.75828120907;42467;42589.57410425856;43147.78426107912;43387.34918976218;45241.773791130836;7892.565908875067;8042.477238979448;8088.71689490865;8108.351331893552;8270.751877443687;30345.393092138474;37780.811095944344;38872;39892.40161397639;41672.79163604163;42391.36412953746;42615.360769589104;42803.78598107114;43253.7837310824;43664.12671746484;11005.229633925868;11955.64133076009;12008.75982480363;12293.75412491763;12629.557965471531;12193.756124877631;12495.750084998068;12525.812112818132;12627.431765570387;12694.111412201057;11409.543618255177;11984.520619175135;12073.39633018328;12208.877911221129;12534.059945503941;11373.658790236306;11969.461374238354;12001.63995080149;12301.876981230072;12403.62789116328;11645.59240426581;11821.349825759666;12094.274343539415;12532.436040378023;12553.246805191719;9634;9905;9974.20206383502;9997.500124993576;10340.27618066728;9585.281103917094;9600.183984361407;9606;9846.677007516992;10189.133923616575 05:23:11 INFO - PROCESS | 26958 | __end_tp_report 05:23:11 INFO - PROCESS | 26958 | __start_cc_report 05:23:11 INFO - PROCESS | 26958 | _x_x_mozilla_cycle_collect,892 05:23:11 INFO - PROCESS | 26958 | __end_cc_report 05:23:11 INFO - PROCESS | 26958 | __startTimestamp1453123391259__endTimestamp 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | ------- Summary: start ------- 05:23:11 INFO - PROCESS | 26958 | Number of tests: 6 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#0] dojo.html Cycles:165 Average:5000.14 Median:5187.58 stddev:529.35 (10.2%) stddev-sans-first:507.80 05:23:11 INFO - PROCESS | 26958 | Values: 3025.2 3043.9 3073.7 3095.7 3123.2 4907.8 4989.8 5030.2 5061.6 5098.3 4949.3 5018.1 5067.3 5087.7 5103.9 4566.6 4582.8 4594.9 4647.3 4747.0 4574.7 4652.8 4702.8 4703.1 4704.8 4536.1 4611.3 4618.3 4641.3 4683.9 4572.6 4578.2 4585.7 4588.8 4589.5 4541.8 4567.6 4569.3 4569.8 4569.9 4863.9 4872.1 4887.9 4890.9 4906.1 5373.8 5376.9 5382.4 5386.5 5431.9 5243.8 5319.1 5413.9 5436.8 5446.6 4978.1 4983.2 5012.7 5020.3 5024.1 5498.0 5503.8 5612.2 5612.9 5618.9 5323.3 5359.1 5359.2 5367.4 5372.0 5266.8 5406.9 5422.3 5430.8 5485.2 5271.4 5273.3 5309.0 5423.8 5474.1 5323.4 5327.1 5337.7 5344.8 5345.1 4125.5 4226.1 4227.0 4247.7 4273.3 3748.9 3755.1 3801.9 3839.5 3843.8 4977.2 4982.5 4986.5 4991.4 5037.8 5256.2 5340.5 5376.6 5383.8 5385.2 4896.3 4995.1 5000.3 5001.3 5044.9 4618.1 4628.5 4628.8 4630.1 4649.2 5469.5 5552.4 5567.3 5568.1 5631.6 5307.6 5404.7 5405.9 5433.3 5448.1 5528.0 5530.0 5532.4 5534.2 5542.4 5127.8 5232.4 5249.1 5272.7 5299.0 5248.8 5266.8 5268.3 5274.9 5324.9 5208.8 5225.7 5268.7 5281.0 5302.4 5095.7 5187.6 5206.4 5260.0 5261.4 5181.5 5217.2 5219.3 5223.5 5224.1 5299.9 5325.4 5368.9 5374.9 5377.3 5065.9 5122.3 5132.1 5176.3 5201.8 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#1] ext.html Cycles:180 Average:47896.06 Median:35692.38 stddev:86266.39 (241.7%) stddev-sans-first:86435.03 05:23:11 INFO - PROCESS | 26958 | Values: 514.3 534.5 537.1 541.6 550.6 27933.6 28524.7 28530.1 28542.0 28552.0 36990.0 37623.2 37673.6 37710.6 37795.6 8401.0 8623.3 8625.8 8627.1 8628.1 8234.5 8284.5 8363.8 8370.5 8370.8 8315.7 8370.9 8395.0 8563.9 8627.0 8498.2 8564.8 8573.3 8577.1 8582.4 8456.3 8561.9 8586.5 8588.1 8594.6 38827.2 39294.6 39304.8 39323.4 39335.8 3193.2 3299.7 3315.0 3558.6 3814.7 29598.7 29703.9 30225.0 31174.4 31204.4 3847.9 3850.2 3877.8 3891.5 3902.7 276462.0 277041.0 277082.0 277247.0 277268.0 51171.0 52528.0 55265.7 57205.4 58487.4 53065.5 53084.0 53318.2 53404.0 53459.5 12256.8 12676.9 12854.2 12855.6 12861.1 8909.2 9546.9 9694.8 9707.9 9737.8 18404.2 18503.6 18619.4 18622.0 18652.1 7280.9 7398.1 7506.2 7524.9 7640.2 961.2 1003.9 1019.4 1041.9 1101.7 28362.4 28523.7 28728.9 29000.9 29158.4 1013.0 1101.6 1102.3 1121.4 1142.9 14057.7 14097.7 14277.8 14372.1 14521.8 332185.0 335336.0 335908.0 335983.0 336551.0 49112.0 49778.0 49926.3 49930.0 49958.5 1304.1 1325.9 1345.2 1351.1 1356.2 26445.7 27286.7 27737.6 27792.6 27896.3 45040.5 45094.8 45351.8 45361.0 45404.3 281438.0 285503.3 405073.0 413611.0 415091.0 30445.4 30491.4 30602.2 30602.5 30619.7 40916.8 41249.8 41491.0 41916.8 42277.4 35069.8 35203.5 35433.8 35544.3 36082.6 35438.1 35622.8 35727.5 36477.8 36502.8 34663.0 35538.0 35642.0 35651.8 35657.3 29243.6 31935.0 31951.4 32082.0 32320.4 24519.0 31439.4 31462.2 31516.0 31942.0 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#2] jquery.html Cycles:180 Average:26814.50 Median:42182.20 stddev:80404.33 (190.6%) stddev-sans-first:80605.34 05:23:11 INFO - PROCESS | 26958 | Values: 359.7 359.9 360.2 361.6 364.2 13642.5 13714.2 15754.4 16863.0 18275.7 15271.2 15961.3 16142.3 16150.9 17013.7 5303.2 5510.2 5515.0 5515.6 5522.7 4031.4 4114.0 5366.5 5470.4 5693.2 5671.6 5855.5 5879.2 5900.5 5905.5 5872.5 5923.2 5930.9 5949.1 5949.3 5247.4 5261.5 6167.7 6455.8 6462.2 20449.0 21092.8 22217.9 23007.4 23301.9 2049.0 2062.4 2076.9 2173.2 2257.6 13457.9 13458.1 13563.0 13624.9 13919.9 1895.5 2000.9 2011.3 2035.6 2061.2 65332.4 65749.7 68295.0 68441.3 69130.7 15201.8 15290.6 15304.9 15308.9 15327.2 23042.3 23060.7 23272.7 23368.2 23440.9 7913.8 7968.9 7986.5 8063.2 8079.5 6544.0 6567.6 6621.7 6644.2 6665.5 7529.3 7529.6 7532.2 7545.7 7546.4 2596.3 2951.1 3034.2 3043.6 3049.8 828.0 895.2 895.5 1010.0 1066.2 15969.8 16644.0 16759.5 17036.6 17112.1 904.8 914.9 974.4 980.9 993.2 9127.2 9587.8 9829.6 9893.1 10090.1 381856.0 470538.0 509500.0 539521.0 543049.0 60974.1 60980.0 63355.7 64562.0 65213.0 1122.6 1128.4 1145.8 1150.1 1153.5 11697.3 13877.9 14651.7 15299.5 15497.5 30722.8 32355.2 32982.5 33413.7 34297.3 39781.0 40138.8 40992.8 41608.8 42755.6 7168.8 7284.3 7307.5 7325.6 7424.7 10428.1 10535.9 10991.4 11005.9 11288.4 9329.8 9683.8 9796.0 9943.0 10240.6 9888.7 10105.1 10244.4 10442.7 10552.8 9295.8 9590.9 9653.2 9688.4 10029.2 7427.9 7662.2 7676.1 7744.8 7775.3 9192.6 9433.3 9452.4 9694.6 9704.8 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#3] mootools.html Cycles:180 Average:5351.49 Median:6163.74 stddev:2750.93 (44.6%) stddev-sans-first:2741.55 05:23:11 INFO - PROCESS | 26958 | Values: 1271.8 1449.3 1463.6 1599.1 1775.4 6808.0 7384.0 7453.9 7500.8 7514.1 7316.3 7508.2 7509.7 7514.2 7526.4 1957.3 1999.7 2001.5 2270.2 2276.4 1998.2 2227.4 2273.8 2288.2 2289.4 2193.4 2238.0 2239.1 2270.2 2282.4 2221.9 2222.4 2226.6 2227.3 2231.5 2239.7 2245.7 2255.1 2258.9 2271.2 7668.1 7735.5 7737.7 7747.0 7747.8 4695.8 4778.8 4815.2 4818.6 4827.7 3033.2 3043.9 3152.8 3158.7 3177.8 998.5 1005.2 1016.9 1025.3 1025.3 10435.4 10455.8 10485.5 10492.3 10496.5 4197.2 4240.5 4264.9 4283.2 4284.8 9025.0 9043.8 9065.8 9147.8 9153.3 4644.4 4647.3 4652.0 4652.4 4655.1 4149.9 4192.2 4193.2 4195.9 4201.0 3402.8 3458.6 3514.8 3591.7 3607.4 1166.0 1177.3 1177.9 1182.2 1191.0 1286.9 1290.7 1311.5 1332.5 1348.0 6998.7 7047.9 7147.0 7232.0 7232.6 1098.9 1099.0 1116.9 1118.9 1127.4 5738.9 5811.2 5817.4 5824.0 5827.0 8893.8 9136.5 9347.5 9350.7 9431.3 9270.8 9291.7 9320.4 9325.7 9328.2 7139.9 7165.0 7200.0 7292.7 7294.4 6994.4 7041.5 7048.5 7050.1 7053.5 7969.0 8340.9 8375.9 8439.2 8448.6 8100.5 8161.4 8315.8 8318.9 8320.7 6584.4 6841.4 6853.9 6859.9 6860.0 6457.5 6662.0 6972.5 7060.6 7116.8 6797.9 6798.9 6818.5 6931.1 7012.9 6700.7 6732.6 6739.6 6831.9 6843.3 6700.2 6754.2 6758.3 6758.5 6765.6 6048.0 6124.6 6202.9 6236.5 6242.8 6340.2 6350.3 6383.7 6383.7 6433.6 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#4] prototype.html Cycles:180 Average:5148.42 Median:5778.38 stddev:1531.59 (26.5%) stddev-sans-first:1492.61 05:23:11 INFO - PROCESS | 26958 | Values: 331.8 332.8 335.1 344.4 347.7 5789.8 5802.7 5811.9 5812.1 5817.4 5463.1 5547.8 5603.8 5678.3 5715.2 4457.6 4467.5 4470.0 4474.4 4496.8 4309.1 4474.1 4488.1 4488.3 4490.4 4342.2 4385.9 4470.6 4475.2 4491.1 4454.6 4461.4 4463.2 4464.7 4477.0 3965.2 3976.2 3979.5 3982.3 3984.0 5413.9 5432.0 5505.3 5511.7 5513.1 5182.2 5188.6 5189.2 5191.7 5192.1 6037.3 6048.2 6051.7 6053.9 6057.4 4374.4 4393.1 4393.3 4407.4 4422.2 6205.6 6342.3 6350.1 6350.2 6366.5 4442.9 4444.2 4446.0 4446.7 4447.5 4491.0 4493.3 4494.5 4495.2 4503.2 5134.4 5136.4 5147.8 5148.7 5150.3 5945.8 6123.4 6126.1 6131.6 6132.9 1563.2 1579.0 1580.1 1580.4 1580.5 1061.2 1063.6 1064.2 1069.0 1076.3 5760.1 5773.6 5774.9 5781.9 5784.1 6262.7 6268.5 6269.2 6279.7 6286.4 5608.9 5673.1 5752.2 5834.9 5844.9 3382.4 3389.5 3407.6 3410.6 3417.1 6622.4 6623.3 6623.4 6632.7 6635.3 6277.4 6474.1 6488.4 6495.7 6497.6 6632.3 6636.6 6644.1 6647.1 6647.8 6358.9 6409.9 6411.1 6415.4 6438.4 6132.9 6275.5 6276.8 6288.7 6296.2 6623.3 6631.8 6633.4 6634.3 6634.5 4393.2 4445.1 4446.0 4450.4 4453.4 6159.0 6329.8 6330.3 6352.2 6364.3 6165.3 6171.3 6172.1 6172.9 6175.0 6150.9 6152.6 6160.4 6160.5 6160.7 5893.2 6052.1 6061.3 6063.4 6064.0 6184.9 6187.8 6189.3 6189.5 6195.7 6037.1 6043.2 6061.6 6063.9 6065.1 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - PROCESS | 26958 | [#5] yui.html Cycles:180 Average:13598.72 Median:23735.48 stddev:15332.68 (64.6%) stddev-sans-first:15345.13 05:23:11 INFO - PROCESS | 26958 | Values: 708.2 741.0 832.4 834.4 840.8 12813.7 12887.2 12942.3 12957.8 12962.7 11816.7 11829.2 11831.8 11836.1 11839.7 663.2 665.9 792.4 794.3 800.5 793.9 798.7 798.9 799.2 799.9 857.6 858.9 858.9 859.5 859.6 842.1 845.8 849.3 851.9 853.0 626.2 627.1 627.3 627.4 628.2 13147.3 13217.9 13230.7 13247.1 13252.5 12919.3 12925.3 13052.2 13359.4 13394.1 10342.1 10364.7 10522.0 10659.7 10665.5 3568.4 3590.3 3623.3 3674.4 3731.5 43110.1 43355.6 45231.5 48939.8 49049.8 9807.6 10016.8 10188.3 10242.2 10321.5 15704.6 17593.0 17785.9 17991.7 18006.0 6515.9 7602.4 7747.3 7862.6 7890.1 4197.6 4236.9 4273.3 4323.2 4329.3 3056.1 3097.4 3100.6 3105.3 3107.3 561.1 569.5 583.1 584.3 590.9 532.1 563.3 576.5 612.7 661.1 8923.0 8945.9 8982.0 9001.0 9426.3 638.2 655.2 670.1 671.0 673.7 3848.1 4011.4 4115.4 4117.8 4132.8 54381.5 55612.4 55818.4 56510.2 56838.1 47504.3 48004.0 48063.5 48173.0 48343.8 42467.0 42589.6 43147.8 43387.3 45241.8 7892.6 8042.5 8088.7 8108.4 8270.8 30345.4 37780.8 38872.0 39892.4 41672.8 42391.4 42615.4 42803.8 43253.8 43664.1 11005.2 11955.6 12008.8 12293.8 12629.6 12193.8 12495.8 12525.8 12627.4 12694.1 11409.5 11984.5 12073.4 12208.9 12534.1 11373.7 11969.5 12001.6 12301.9 12403.6 11645.6 11821.3 12094.3 12532.4 12553.2 9634.0 9905.0 9974.2 9997.5 10340.3 9585.3 9600.2 9606.0 9846.7 10189.1 05:23:11 INFO - PROCESS | 26958 | -------- Summary: end -------- 05:23:11 INFO - PROCESS | 26958 | 05:23:11 INFO - TEST-INFO | 26958: exit 0 05:23:11 INFO - TEST-OK | dromaeo_css | took 1112540ms 05:23:11 INFO - TEST-START | kraken 05:23:11 INFO - operating with platform_type : linux_ 05:23:11 INFO - Initialising browser for kraken test... 05:23:11 INFO - TEST-INFO | started process 27163 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk93HxA/profile http://localhost:60718/getInfo.html) 05:23:16 INFO - PROCESS | 27163 | __metrics Screen width/height:1600/1200 05:23:16 INFO - PROCESS | 27163 | colorDepth:24 05:23:16 INFO - PROCESS | 27163 | Browser inner width/height: 1024/697 05:23:16 INFO - PROCESS | 27163 | __metrics 05:23:16 INFO - PROCESS | 27163 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:23:16 INFO - PROCESS | 27163 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:17 INFO - TEST-INFO | 27163: exit 0 05:23:17 INFO - Browser initialized. 05:23:17 INFO - Running cycle 1/1 for kraken test... 05:23:17 INFO - TEST-INFO | started process 27247 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk93HxA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:28 INFO - PROCESS | 27247 | RSS: Main: 149860352 05:23:28 INFO - PROCESS | 27247 | 05:23:31 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60718/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:31 INFO - PROCESS | 27247 | RSS: Main: 187510784 05:23:31 INFO - PROCESS | 27247 | 05:23:34 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60718/tests/kraken/driver.html?testName=audio-dft) 05:23:35 INFO - PROCESS | 27247 | RSS: Main: 178651136 05:23:35 INFO - PROCESS | 27247 | 05:23:38 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60718/tests/kraken/driver.html?testName=audio-fft) 05:23:38 INFO - PROCESS | 27247 | RSS: Main: 162091008 05:23:38 INFO - PROCESS | 27247 | 05:23:40 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60718/tests/kraken/driver.html?testName=audio-oscillator) 05:23:41 INFO - PROCESS | 27247 | RSS: Main: 163688448 05:23:41 INFO - PROCESS | 27247 | 05:23:43 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:43 INFO - PROCESS | 27247 | RSS: Main: 165998592 05:23:43 INFO - PROCESS | 27247 | 05:23:46 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60718/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:47 INFO - PROCESS | 27247 | RSS: Main: 166793216 05:23:47 INFO - PROCESS | 27247 | 05:23:50 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60718/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:51 INFO - PROCESS | 27247 | RSS: Main: 168128512 05:23:51 INFO - PROCESS | 27247 | 05:23:54 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60718/tests/kraken/driver.html?testName=json-parse-financial) 05:23:54 INFO - PROCESS | 27247 | RSS: Main: 168079360 05:23:54 INFO - PROCESS | 27247 | 05:23:56 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:56 INFO - PROCESS | 27247 | RSS: Main: 185229312 05:23:56 INFO - PROCESS | 27247 | 05:23:58 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:59 INFO - PROCESS | 27247 | RSS: Main: 182288384 05:23:59 INFO - PROCESS | 27247 | 05:24:01 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:24:01 INFO - PROCESS | 27247 | RSS: Main: 189517824 05:24:01 INFO - PROCESS | 27247 | 05:24:04 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:24:04 INFO - PROCESS | 27247 | RSS: Main: 197578752 05:24:04 INFO - PROCESS | 27247 | 05:24:07 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:24:07 INFO - PROCESS | 27247 | RSS: Main: 193720320 05:24:07 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | Cycle 1(1): loaded http://localhost:60718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60718/tests/kraken/driver.html?testName=ai-astar) 05:24:09 INFO - PROCESS | 27247 | RSS: Main: 253267968 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | __start_tp_report 05:24:09 INFO - PROCESS | 27247 | _x_x_mozilla_page_load 05:24:09 INFO - PROCESS | 27247 | _x_x_mozilla_page_load_details 05:24:09 INFO - PROCESS | 27247 | |i|pagename|runs| 05:24:09 INFO - PROCESS | 27247 | |0;ai-astar;111;110;106;109;110;111;112;110;103;110 05:24:09 INFO - PROCESS | 27247 | |1;audio-beat-detection;152;124;154;167;127;156;181;127;163;126 05:24:09 INFO - PROCESS | 27247 | |2;audio-dft;165;160;161;162;161;163;161;161;161;162 05:24:09 INFO - PROCESS | 27247 | |3;audio-fft;71;73;96;99;72;73;72;116;93;73 05:24:09 INFO - PROCESS | 27247 | |4;audio-oscillator;97;94;139;96;95;95;141;95;96;141 05:24:09 INFO - PROCESS | 27247 | |5;imaging-gaussian-blur;110;108;109;109;109;109;110;109;110;110 05:24:09 INFO - PROCESS | 27247 | |6;imaging-darkroom;147;146;145;146;145;146;146;145;145;145 05:24:09 INFO - PROCESS | 27247 | |7;imaging-desaturate;95;96;96;96;95;95;95;96;96;95 05:24:09 INFO - PROCESS | 27247 | |8;json-parse-financial;57;56;55;55;56;56;55;56;66;53 05:24:09 INFO - PROCESS | 27247 | |9;json-stringify-tinderbox;69;68;68;68;68;68;68;68;69;69 05:24:09 INFO - PROCESS | 27247 | |10;stanford-crypto-aes;81;81;81;82;82;83;81;83;82;84 05:24:09 INFO - PROCESS | 27247 | |11;stanford-crypto-ccm;115;119;130;133;122;116;123;117;118;117 05:24:09 INFO - PROCESS | 27247 | |12;stanford-crypto-pbkdf2;149;135;145;149;142;134;134;143;142;150 05:24:09 INFO - PROCESS | 27247 | |13;stanford-crypto-sha256-iterative;65;66;68;66;67;67;68;67;68;67 05:24:09 INFO - PROCESS | 27247 | __end_tp_report 05:24:09 INFO - PROCESS | 27247 | __start_cc_report 05:24:09 INFO - PROCESS | 27247 | _x_x_mozilla_cycle_collect,945 05:24:09 INFO - PROCESS | 27247 | __end_cc_report 05:24:09 INFO - PROCESS | 27247 | __startTimestamp1453123449733__endTimestamp 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | ------- Summary: start ------- 05:24:09 INFO - PROCESS | 27247 | Number of tests: 14 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:2.70 (2.5%) stddev-sans-first:2.78 05:24:09 INFO - PROCESS | 27247 | Values: 111.0 110.0 106.0 109.0 110.0 111.0 112.0 110.0 103.0 110.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:155.00 stddev:20.36 (13.1%) stddev-sans-first:21.54 05:24:09 INFO - PROCESS | 27247 | Values: 152.0 124.0 154.0 167.0 127.0 156.0 181.0 127.0 163.0 126.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.42 (0.9%) stddev-sans-first:0.87 05:24:09 INFO - PROCESS | 27247 | Values: 165.0 160.0 161.0 162.0 161.0 163.0 161.0 161.0 161.0 162.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#3] audio-fft Cycles:10 Average:83.80 Median:73.00 stddev:15.96 (21.9%) stddev-sans-first:16.25 05:24:09 INFO - PROCESS | 27247 | Values: 71.0 73.0 96.0 99.0 72.0 73.0 72.0 116.0 93.0 73.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:21.71 (22.9%) stddev-sans-first:22.60 05:24:09 INFO - PROCESS | 27247 | Values: 97.0 94.0 139.0 96.0 95.0 95.0 141.0 95.0 96.0 141.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 05:24:09 INFO - PROCESS | 27247 | Values: 110.0 108.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:24:09 INFO - PROCESS | 27247 | Values: 147.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:24:09 INFO - PROCESS | 27247 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.50 (6.3%) stddev-sans-first:3.71 05:24:09 INFO - PROCESS | 27247 | Values: 57.0 56.0 55.0 55.0 56.0 56.0 55.0 56.0 66.0 53.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 05:24:09 INFO - PROCESS | 27247 | Values: 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 05:24:09 INFO - PROCESS | 27247 | Values: 81.0 81.0 81.0 82.0 82.0 83.0 81.0 83.0 82.0 84.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:6.11 (5.1%) stddev-sans-first:6.08 05:24:09 INFO - PROCESS | 27247 | Values: 115.0 119.0 130.0 133.0 122.0 116.0 123.0 117.0 118.0 117.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.00 stddev:6.22 (4.3%) stddev-sans-first:6.11 05:24:09 INFO - PROCESS | 27247 | Values: 149.0 135.0 145.0 149.0 142.0 134.0 134.0 143.0 142.0 150.0 05:24:09 INFO - PROCESS | 27247 | 05:24:09 INFO - PROCESS | 27247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.78 05:24:09 INFO - PROCESS | 27247 | Values: 65.0 66.0 68.0 66.0 67.0 67.0 68.0 67.0 68.0 67.0 05:24:09 INFO - PROCESS | 27247 | -------- Summary: end -------- 05:24:09 INFO - PROCESS | 27247 | 05:24:10 INFO - TEST-INFO | 27247: exit 0 05:24:10 INFO - TEST-OK | kraken | took 58666ms 05:24:10 INFO - TEST-START | v8_7 05:24:10 INFO - operating with platform_type : linux_ 05:24:10 INFO - Initialising browser for v8_7 test... 05:24:10 INFO - TEST-INFO | started process 27495 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0sjAay/profile http://localhost:60718/getInfo.html) 05:24:14 INFO - PROCESS | 27495 | __metrics Screen width/height:1600/1200 05:24:14 INFO - PROCESS | 27495 | colorDepth:24 05:24:14 INFO - PROCESS | 27495 | Browser inner width/height: 1024/697 05:24:14 INFO - PROCESS | 27495 | __metrics 05:24:14 INFO - PROCESS | 27495 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:24:15 INFO - PROCESS | 27495 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:15 INFO - TEST-INFO | 27495: exit 0 05:24:15 INFO - Browser initialized. 05:24:15 INFO - Running cycle 1/1 for v8_7 test... 05:24:15 INFO - TEST-INFO | started process 27579 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0sjAay/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:27 INFO - PROCESS | 27579 | RSS: Main: 150036480 05:24:27 INFO - PROCESS | 27579 | 05:24:49 INFO - PROCESS | 27579 | Cycle 1(1): loaded http://localhost:60718/tests/v8_7/run.html (next: http://localhost:60718/tests/v8_7/run.html) 05:24:50 INFO - PROCESS | 27579 | RSS: Main: 599937024 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | __start_tp_report 05:24:50 INFO - PROCESS | 27579 | _x_x_mozilla_page_load 05:24:50 INFO - PROCESS | 27579 | _x_x_mozilla_page_load_details 05:24:50 INFO - PROCESS | 27579 | |i|pagename|runs| 05:24:50 INFO - PROCESS | 27579 | |0;Richards;170.1837985023826 05:24:50 INFO - PROCESS | 27579 | |1;DeltaBlue;188.5014137606032 05:24:50 INFO - PROCESS | 27579 | |2;Encrypt;279.2516056967328 05:24:50 INFO - PROCESS | 27579 | |3;Decrypt;5229.166666666667 05:24:50 INFO - PROCESS | 27579 | |4;RayTrace;1107.4197120708748 05:24:50 INFO - PROCESS | 27579 | |5;Earley;780.811232449298 05:24:50 INFO - PROCESS | 27579 | |6;Boyer;12207.317073170732 05:24:50 INFO - PROCESS | 27579 | |7;RegExp;42770.833333333336 05:24:50 INFO - PROCESS | 27579 | |8;Splay;587.5440658049354 05:24:50 INFO - PROCESS | 27579 | |9;NavierStokes;4826.923076923077 05:24:50 INFO - PROCESS | 27579 | __end_tp_report 05:24:50 INFO - PROCESS | 27579 | __startTimestamp1453123490209__endTimestamp 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | ------- Summary: start ------- 05:24:50 INFO - PROCESS | 27579 | Number of tests: 10 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#0] Richards Cycles:1 Average:170.18 Median:170.18 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 170.2 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 188.5 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 279.3 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 5229.2 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#4] RayTrace Cycles:1 Average:1107.42 Median:1107.42 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 1107.4 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#5] Earley Cycles:1 Average:780.81 Median:780.81 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 780.8 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 12207.3 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#7] RegExp Cycles:1 Average:42770.83 Median:42770.83 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 42770.8 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#8] Splay Cycles:1 Average:587.54 Median:587.54 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 587.5 05:24:50 INFO - PROCESS | 27579 | 05:24:50 INFO - PROCESS | 27579 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:24:50 INFO - PROCESS | 27579 | Values: 4826.9 05:24:50 INFO - PROCESS | 27579 | -------- Summary: end -------- 05:24:50 INFO - PROCESS | 27579 | 05:24:51 INFO - TEST-INFO | 27579: exit 0 05:24:51 INFO - TEST-OK | v8_7 | took 40461ms 05:24:51 INFO - SUITE-END | took 1211s 05:24:51 INFO - Completed test suite (00:20:11) 05:24:51 INFO - Working with test: dromaeo_css 05:24:51 INFO - Generating results file: dromaeo_css 05:24:51 INFO - Working with test: kraken 05:24:51 INFO - Generating results file: kraken 05:24:51 INFO - javascript benchmark 05:24:51 INFO - Working with test: v8_7 05:24:51 INFO - Generating results file: v8_7 05:24:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:24:51 INFO - process_Request line: dromaeo_css 6829.82 graph.html#tests=[[72,64,35]] 05:24:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:51 INFO - process_Request line: kraken 1498.70 graph.html#tests=[[232,64,35]] 05:24:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:51 INFO - process_Request line: v8_7 20060.60 graph.html#tests=[[230,64,35]] 05:24:51 INFO - RETURN: dromaeo_css: 6829.82 05:24:51 INFO - RETURN: kraken: 1498.70 05:24:51 INFO - RETURN: v8_7: 20060.60 05:24:51 INFO - javascript benchmark 05:24:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3025.1832005358556, 3043.9239019024535, 3073.738732207762, 3095.6749541298163, 3123.203583086313, 4907.82822601209, 4989.825356112537, 5030.1951687729925, 5061.595072394213, 5098.31172791673, 4949.28235405866, 5018.071656743505, 5067.290579318889, 5087.694738315704, 5103.923441148377, 4566.566176213263, 4582.793774280149, 4594.885127871797, 4647.34937108805, 4746.952530474703, 4574.6569007324415, 4652.790624421909, 4702.8118875244945, 4703.059388122372, 4704.788284527187, 4536.115457485775, 4611.262198048296, 4618.261078227468, 4641.303804429329, 4683.90632187356, 4572.611328037121, 4578.198815207325, 4585.679002469828, 4588.839390621346, 4589.495155532889, 4541.8410355637725, 4567.634589232886, 4569.337446070301, 4569.817207311704, 4569.862904112882, 4863.927041094386, 4872.147374209535, 4887.926681099786, 4890.926636100461, 4906.067847109038, 5373.75818088183, 5376.865578360533, 5382.407935127133, 5386.542143917772, 5431.945680543184, 5243.79024839006, 5319.148936170232, 5413.945860541423, 5436.782528698887, 5446.564274858041, 4978.054169707781, 4983.202687569971, 5012.699238045765, 5020.322256495363, 5024.145895197825, 5497.972510137423, 5503.807366742225, 5612.158176273591, 5612.85967850807, 5618.943810561924, 5323.30796996388, 5359.08895487768, 5359.249705041298, 5367.355917289872, 5372.0, 5266.7629956652045, 5406.864828379244, 5422.267993820863, 5430.809921652803, 5485.177223416519, 5271.367435907716, 5273.261743355856, 5309.0, 5423.755930983115, 5474.09677403224, 5323.387810401776, 5327.147656374961, 5337.706426146521, 5344.759485823147, 5345.118055520873, 4125.463689720317, 4226.091390351089, 4227.0, 4247.681423893158, 4273.337632666941, 3748.925021499609, 3755.061234691327, 3801.885943421702, 3839.500864887547, 3843.7885916274313, 4977.178765503651, 4982.526659967298, 4986.501349864984, 4991.425986011655, 5037.7733002014265, 5256.159014557652, 5340.519353258225, 5376.569874410116, 5383.78464861409, 5385.246065550826, 4896.290037944549, 4995.075910956485, 5000.299958005882, 5001.349824522788, 5044.873878153002, 4618.076384723069, 4628.490866004737, 4628.814847406066, 4630.143423466669, 4649.18639238132, 5469.453054694499, 5552.41699621542, 5567.331920169606, 5568.109102543654, 5631.633943793722, 5307.57539396855, 5404.72976351173, 5405.918911216414, 5433.320834895638, 5448.101063324507, 5528.0, 5530.0, 5532.391436941853, 5534.1975413565615, 5542.3903370628395, 5127.846164615067, 5232.372115346183, 5249.133892907627, 5272.736363181903, 5298.97350513245, 5248.790048398021, 5266.8419947401635, 5268.2624432578705, 5274.920876186783, 5324.946750532445, 5208.8437346879655, 5225.686458812484, 5268.710220937732, 5281.049411105884, 5302.416734159317, 5095.745212739423, 5187.58499320061, 5206.375234971828, 5259.973700131475, 5261.421243663118, 5181.53366197044, 5217.243499692448, 5219.2953951216095, 5223.4776522347465, 5224.138017227115, 5299.894002120013, 5325.414204437431, 5368.919466208088, 5374.865628359166, 5377.300950876361, 5065.898682026413, 5122.334096567422, 5132.050570644443, 5176.275321454924, 5201.817936372209], "unit": "score", "name": "dojo.html", "value": 4967.660364668341}, {"lowerIsBetter": false, "replicates": [514.3108234965146, 534.48689258312, 537.1405750798722, 541.5640409470375, 550.6448340820172, 27933.580996285073, 28524.714752852466, 28530.14409567711, 28542.0, 28552.0, 36990.0, 37623.24753504928, 37673.62326376735, 37710.622893771055, 37795.62204377956, 8401.033881103675, 8623.310135189202, 8625.784355391103, 8627.094155113686, 8628.09405012474, 8234.464759790595, 8284.46151000186, 8363.83272334553, 8370.53962032088, 8370.790730231762, 8315.66737330509, 8370.874436883452, 8394.958025209866, 8563.914360856405, 8626.956865215665, 8498.235158835703, 8564.82870342596, 8573.314134869195, 8577.099404562556, 8582.442141260799, 8456.323494120517, 8561.871571926426, 8586.527740974245, 8588.098249683755, 8594.613242404106, 38827.22345553073, 39294.60705392966, 39304.80347598244, 39323.41014884779, 39335.8033209835, 3193.1697758582704, 3299.7268438043207, 3314.950275745866, 3558.6085530591613, 3814.7329686921926, 29598.70401295981, 29703.851480742458, 30225.0, 31174.37651246985, 31204.375912481624, 3847.903802404934, 3850.191459793447, 3877.84971843913, 3891.4746509221177, 3902.6682731967817, 276462.0, 277041.0, 277082.0, 277247.0, 277268.0, 51171.0, 52528.0, 55265.72367138219, 57205.42794572084, 58487.415125849046, 53065.469345306825, 53084.0, 53318.200226996625, 53404.0, 53459.46540534623, 12256.81614775779, 12676.87323126757, 12854.228746275254, 12855.550055748005, 12861.099723019299, 8909.1536304051, 9546.856797148048, 9694.806103878023, 9707.90292097084, 9737.756556086013, 18404.17181226848, 18503.629927401376, 18619.44141675752, 18622.0, 18652.067396630115, 7280.854382912312, 7398.11222653285, 7506.249375062559, 7524.9247507525315, 7640.159582445926, 961.1974001708652, 1003.8996100390049, 1019.4240254256322, 1041.9479026048666, 1101.6639924822846, 28362.43275134527, 28523.71476285252, 28728.856355718086, 29000.85499572531, 29158.41683166325, 1012.9949350253202, 1101.5924108080062, 1102.2835157147917, 1121.4168632311153, 1142.87999760024, 14057.71884562303, 14097.71804563903, 14277.78583321251, 14372.137671739729, 14521.78217326741, 332185.0, 335336.0, 335908.0, 335983.0, 336551.0, 49112.0, 49778.0, 49926.25110623344, 49930.0, 49958.50041499611, 1304.1132030219542, 1325.9337033148304, 1345.1861623717705, 1351.0880155894731, 1356.1930651262483, 26445.73554264433, 27286.727132728418, 27737.583936240568, 27792.58311125294, 27896.302592435353, 45040.54959450495, 45094.77452612716, 45351.77324113358, 45361.0, 45404.318935215335, 281438.0, 285503.30470257776, 405073.0, 413611.0, 415091.0, 30445.39109217759, 30491.426286057267, 30602.234944126576, 30602.540961886036, 30619.693803061684, 40916.79541602273, 41249.79375103105, 41491.0, 41916.79041604773, 42277.36583951182, 35069.82465087658, 35203.471947921316, 35433.82283088568, 35544.28911421809, 36082.63917360898, 35438.11404714903, 35622.82188589144, 35727.46408803922, 36477.81761091178, 36502.8174859124, 34663.0, 35538.0, 35642.0, 35651.82174089113, 35657.28685426225, 29243.561346580245, 31935.0, 31951.36097277995, 32082.0, 32320.35359292754, 24519.0, 31439.371212575163, 31462.213444664067, 31516.0, 31942.0], "unit": "score", "name": "ext.html", "value": 17939.774509855793}, {"lowerIsBetter": false, "replicates": [359.6870722471452, 359.9100224943765, 360.1572320769399, 361.6239111324223, 364.21693359277566, 13642.454301827915, 13714.24571648559, 15754.369825206992, 16863.0, 18275.725864112017, 15271.236438178075, 15961.281742321595, 16142.273597688103, 16150.919245403786, 17013.659726805457, 5303.23103150043, 5510.201020851974, 5514.972425137868, 5515.641483303592, 5522.6686398816, 4031.3751368537924, 4114.012636967122, 5366.4633536646215, 5470.370907345667, 5693.174489699012, 5671.62538289719, 5855.531557475413, 5879.176915231871, 5900.527957763368, 5905.527557795387, 5872.530197584183, 5923.17075609415, 5930.851728706773, 5949.107633854935, 5949.3158286796925, 5247.39654939683, 5261.500157485033, 6167.660778657172, 6455.806325810233, 6462.192225971754, 20449.0, 21092.789072109237, 22217.888910555343, 23007.389482736216, 23301.883490582437, 2048.9692654610194, 2062.391594479632, 2076.8546201765885, 2173.217641649005, 2257.559775843711, 13457.932710336385, 13458.057935944487, 13563.0, 13624.93187534056, 13919.860801391958, 1895.5261184703825, 2000.8999550022586, 2011.3463124484601, 2035.5827055453597, 2061.165228082614, 65332.366690832634, 65749.67125164343, 68295.0, 68441.315586844, 69130.65434672845, 15201.771973420407, 15290.617734556503, 15304.923475382775, 15308.923455382874, 15327.157006364534, 23042.313229883475, 23060.654090188662, 23272.65091023636, 23368.182113625942, 23440.882795586254, 7913.841723165505, 7968.920310796933, 7986.480878742863, 8063.233992770677, 8079.515229086156, 6543.967280163569, 6567.605943643397, 6621.702023408958, 6644.169478815148, 6665.533412661164, 7529.284717951786, 7529.58587277705, 7532.154622117616, 7545.660445279976, 7546.434017448713, 2596.2730435478097, 2951.099914526047, 3034.24143964009, 3043.5738996540504, 3049.771267154928, 827.995860020696, 895.1540793949786, 895.4537731983485, 1009.9949500252452, 1066.2323127348297, 15969.840301596836, 16644.0, 16759.497215083567, 17036.574085647957, 17112.144392780312, 904.7783293093235, 914.9130832570895, 974.4396971741277, 980.9068138526828, 993.2451336983944, 9127.22418594427, 9587.808243835085, 9829.55766990487, 9893.109620134222, 10090.142337901214, 381856.0, 470538.0, 509500.0, 539521.0, 543049.0, 60974.085388719206, 60980.0, 63355.68322158452, 64562.031569526494, 65213.0, 1122.5958654884234, 1128.4132251229314, 1145.7593905279984, 1150.0971737186435, 1153.4636394076795, 11697.2981621103, 13877.889768818268, 14651.70696586041, 15299.541013769605, 15497.5350739478, 30722.846385767927, 32355.19112022124, 32982.50526242156, 33413.66586334203, 34297.31405371929, 39781.0, 40138.79930600328, 40992.79503602463, 41608.82967087552, 42755.572444276404, 7168.820779480555, 7284.344409003215, 7307.488475806643, 7325.560466372035, 7424.740134095281, 10428.113610343205, 10535.947320263656, 10991.395473249047, 11005.944970275097, 11288.435578220891, 9329.766755831159, 9683.757906052406, 9796.0, 9942.950285248528, 10240.641577545048, 9888.703338899844, 10105.141063009432, 10244.436555989492, 10442.738931526772, 10552.84170737455, 9295.814083718424, 9590.856137157809, 9653.1794797443, 9688.41869487833, 10029.247806414402, 7427.925720742724, 7662.195469475625, 7676.117246516722, 7744.806379840549, 7775.339096176888, 9192.632294708137, 9433.29250306216, 9452.385594936308, 9694.612215511583, 9704.805903882025], "unit": "score", "name": "jquery.html", "value": 8794.766402005116}, {"lowerIsBetter": false, "replicates": [1271.790154624487, 1449.268119599602, 1463.6414078550754, 1599.1284749811352, 1775.405239244852, 6808.046873437723, 7384.0, 7453.925460745391, 7500.774976750693, 7514.098308203023, 7316.341529262365, 7508.211637778037, 7509.662065207065, 7514.211007844166, 7526.36025937796, 1957.3345062678686, 1999.7100420439028, 2001.5096301406177, 2270.2281224383705, 2276.4422716434497, 1998.1607724755565, 2227.387468446174, 2273.818094552432, 2288.1533832481923, 2289.416198869286, 2193.363924461912, 2237.966430503544, 2239.0819763896807, 2270.19408110121, 2282.395165281202, 2221.9333419997347, 2222.3666255117296, 2226.565819665166, 2227.265002549155, 2231.453293942994, 2239.697640818485, 2245.7305123385136, 2255.07541907817, 2258.8531745436494, 2271.216430331533, 7668.118166410878, 7735.535867847947, 7737.690492380298, 7746.961265193694, 7747.8450430991625, 4695.765211739434, 4778.761061946889, 4815.205491093965, 4818.638602104857, 4827.710337379734, 3033.1507177990197, 3043.9086827395213, 3152.763542734304, 3158.699923507263, 3177.7934434261697, 998.4807899892015, 1005.2209537608339, 1016.9440680762555, 1025.3284098915221, 1025.3489034463096, 10435.426051567161, 10455.84316235257, 10485.528151233137, 10492.317999330095, 10496.475176241158, 4197.160567886435, 4240.49114106303, 4264.850730224427, 4283.22901877665, 4284.785760711952, 9025.0, 9043.77390565228, 9065.818683626423, 9147.817043659223, 9153.267738581031, 4644.396228490342, 4647.302904564275, 4652.0, 4652.395188625457, 4655.092257009851, 4149.8962525937095, 4192.203481338536, 4193.18232944579, 4195.895102622398, 4201.0, 3402.8468718907707, 3458.56767904012, 3514.806685632315, 3591.694705949971, 3607.404778211566, 1165.9941700291613, 1177.2759752752168, 1177.8527684039495, 1182.1901997131993, 1190.9583164589199, 1286.9420876060412, 1290.7160424706738, 1311.5081844308384, 1332.4936524120772, 1348.0, 6998.720051197997, 7047.894281585678, 7146.964265178641, 7232.0, 7232.566046037255, 1098.8516550265613, 1098.9505472253768, 1116.9329840209614, 1118.9160812939062, 1127.3799410324289, 5738.856528586735, 5811.215485909348, 5817.447342502455, 5823.980803359395, 5827.0, 8893.777655558533, 9136.497492637836, 9347.485888276211, 9350.719478415658, 9431.292653051049, 9270.814583708288, 9291.72124836256, 9320.440773553608, 9325.673601423918, 9328.160465558132, 7139.92860071403, 7165.0, 7199.964000179965, 7292.708291668274, 7294.416446684252, 6994.405475534637, 7041.471889608402, 7048.471364647569, 7050.118735158106, 7053.541519801196, 7968.960155199187, 8340.874886876823, 8375.916240837758, 8439.156084391758, 8448.619812108347, 8100.513969161869, 8161.428699990944, 8315.792105197419, 8318.875216871873, 8320.70877519284, 6584.407403333723, 6841.3842754152365, 6853.931460685529, 6859.9314006859295, 6860.0, 6457.4511166551365, 6661.966690166518, 6972.477064220102, 7060.576365417885, 7116.786496405116, 6797.864042719217, 6798.932010680028, 6818.522703410714, 6931.133608298963, 7012.859742805217, 6700.664966751546, 6732.596044237362, 6739.629320387426, 6831.863362732817, 6843.349881761224, 6700.162479690039, 6754.155730533684, 6758.324167583202, 6758.459323254227, 6765.594064356154, 6048.0, 6124.5712800103565, 6202.906956395567, 6236.469900058364, 6242.781502647385, 6340.207474065742, 6350.301466838737, 6383.6808159592765, 6383.744650213939, 6433.613983161025], "unit": "score", "name": "mootools.html", "value": 4420.875801743036}, {"lowerIsBetter": false, "replicates": [331.79262960649595, 332.77703938361293, 335.14203638684967, 344.4471623045012, 347.74440786022285, 5789.76840926363, 5802.680852553108, 5811.912821307684, 5812.070068788995, 5817.418258174186, 5463.098588732864, 5547.77808887644, 5603.80386686466, 5678.290213723285, 5715.228444160037, 4457.576530229623, 4467.53090925453, 4469.977650111761, 4474.418325617665, 4496.820127194908, 4309.138172365524, 4474.127545128701, 4488.05750792334, 4488.326750987346, 4490.41624588803, 4342.196693611676, 4385.934210986838, 4470.597646211841, 4475.216837053519, 4491.124230775, 4454.599086082252, 4461.375407442961, 4463.152001119777, 4464.709793863389, 4477.0, 3965.2267807777494, 3976.2445135424464, 3979.4826672532386, 3982.3230050891416, 3983.960160398388, 5413.945860541423, 5432.022235997519, 5505.284313039279, 5511.724413779335, 5513.145462453326, 5182.196759502283, 5188.584913206934, 5189.195674670432, 5191.714455704935, 5192.065428222918, 6037.275526936795, 6048.1834952281315, 6051.727672254759, 6053.909191362133, 6057.394260573951, 4374.4094547236355, 4393.055493068973, 4393.29707246839, 4407.427034485497, 4422.248217802981, 6205.627662340274, 6342.302346741854, 6350.142730731338, 6350.23797144341, 6366.490680745529, 4442.8667139985855, 4444.2000439920475, 4445.955540444619, 4446.710963787344, 4447.533009034069, 4491.011977364975, 4493.28107502798, 4494.483134439516, 4495.168393847149, 4503.189425903303, 5134.435212126663, 5136.383633963948, 5147.794088236428, 5148.742562871841, 5150.304708864331, 5945.7621695132575, 6123.418275263843, 6126.142340072393, 6131.63210207389, 6132.908006379907, 1563.1793308512895, 1578.9842101579068, 1580.123031717385, 1580.446843604752, 1580.5179420276927, 1061.230607809332, 1063.6064656077147, 1064.180580952662, 1069.0, 1076.278893141597, 5760.107183386582, 5773.624714393551, 5774.884502310014, 5781.88436231273, 5784.1034639630925, 6262.68686565679, 6268.529860260499, 6269.185005949197, 6279.717412716439, 6286.371362863677, 5608.915866262009, 5673.120666296731, 5752.165935939265, 5834.854128646818, 5844.912326315109, 3382.374260761767, 3389.474631432132, 3407.6251612322626, 3410.5736782902136, 3417.0773891049275, 6622.4039836413995, 6623.30455302196, 6623.370779775913, 6632.668366581652, 6635.303293154246, 6277.435030847154, 6474.125992990886, 6488.416042556099, 6495.7076931538195, 6497.610143391412, 6632.336766323329, 6636.634985075771, 6644.103046088813, 6647.135872336566, 6647.833804154838, 6358.90461643085, 6409.935900640934, 6411.134496843053, 6415.422611964946, 6438.3883531064475, 6132.908006379818, 6275.466585340298, 6276.780312689034, 6288.748450061947, 6296.244450665949, 6623.304553022056, 6631.767888124085, 6633.402993730394, 6634.33656634352, 6634.5024123191915, 4393.209222339881, 4445.110977804517, 4445.977770111129, 4450.376947227326, 4453.398791163151, 6159.0, 6329.841753956004, 6330.272018717722, 6352.174217351715, 6364.268109167505, 6165.321814600301, 6171.290301615371, 6172.135900973777, 6172.9074063889975, 6175.0, 6150.907736384047, 6152.630842149485, 6160.383961603804, 6160.537959652955, 6160.661163635864, 5893.2044174035955, 6052.061930400619, 6061.272647282354, 6063.423974722395, 6064.0, 6184.876302474016, 6187.84530386744, 6189.257289125334, 6189.473894718819, 6195.721192546436, 6037.0642550404755, 6043.214382130295, 6061.605995610271, 6063.939360606338, 6065.120557519223], "unit": "score", "name": "prototype.html", "value": 4655.743382015311}, {"lowerIsBetter": false, "replicates": [708.228031445724, 740.981475463113, 832.3507664022061, 834.440924580531, 840.7645859159434, 12813.679658008554, 12887.226766394011, 12942.288174150419, 12957.805632915513, 12962.74074518509, 11816.704582385444, 11829.231099978495, 11831.822522662145, 11836.053115750741, 11839.70400739982, 663.2339647706895, 665.8514063240895, 792.3779832831228, 794.3010151067053, 800.4876878797575, 793.896793416855, 798.6805277888833, 798.9081255655586, 799.2007992007992, 799.9280064794167, 857.5926434943383, 858.8582883824162, 858.9484630922134, 859.4542465534399, 859.6174702257498, 842.0568962761715, 845.7589586967746, 849.2738708404318, 851.8594431918726, 852.9872051919226, 626.1828314050163, 627.0625415004597, 627.2567008095422, 627.4353082225988, 628.2241431831684, 13147.342632868318, 13217.867821321759, 13230.66923326915, 13247.138935969131, 13252.46990120394, 12919.289439080847, 12925.285182457015, 13052.21686698801, 13359.398827052806, 13394.129381590166, 10342.120919721832, 10364.740881477948, 10522.0, 10659.733506662318, 10665.520051597698, 3568.429051351797, 3590.263995880864, 3623.3296840084668, 3674.393725035366, 3731.477593136963, 43110.13779724388, 43355.56644433578, 45231.547684523066, 48939.755301223624, 49049.75475122637, 9807.558659860324, 10016.849747253651, 10188.286819922683, 10242.180625549938, 10321.483925803679, 15704.607384815243, 17593.0, 17785.911070444825, 17991.73012404789, 18006.009669468043, 6515.934840651627, 7602.42981776369, 7747.2640099190485, 7862.606869656494, 7890.053193616803, 4197.622214000755, 4236.894077648083, 4273.252180868336, 4323.178596066738, 4329.307310830252, 3056.1442796016704, 3097.3650401667605, 3100.5969224000737, 3105.3478769458666, 3107.285324375406, 561.1106396361731, 569.4618585436805, 583.1049339264209, 584.3484514766005, 590.8936391449495, 532.0768466710255, 563.3296377311069, 576.4725276372156, 612.7303986246127, 661.0909998751716, 8923.0, 8945.865812012826, 8981.955090224506, 9000.952138822795, 9426.340156189139, 638.237306418825, 655.1941112431736, 670.1355251725317, 671.0404122105436, 673.7069374821968, 3848.0956975110826, 4011.3782363733667, 4115.444415003996, 4117.835286588503, 4132.752034877917, 54381.45618543843, 55612.443875560726, 55818.44181558213, 56510.152347714815, 56838.147427788615, 47504.28743568849, 48004.0, 48063.519364806605, 48173.0, 48343.75828120907, 42467.0, 42589.57410425856, 43147.78426107912, 43387.34918976218, 45241.773791130836, 7892.565908875067, 8042.477238979448, 8088.71689490865, 8108.351331893552, 8270.751877443687, 30345.393092138474, 37780.811095944344, 38872.0, 39892.40161397639, 41672.79163604163, 42391.36412953746, 42615.360769589104, 42803.78598107114, 43253.7837310824, 43664.12671746484, 11005.229633925868, 11955.64133076009, 12008.75982480363, 12293.75412491763, 12629.557965471531, 12193.756124877631, 12495.750084998068, 12525.812112818132, 12627.431765570387, 12694.111412201057, 11409.543618255177, 11984.520619175135, 12073.39633018328, 12208.877911221129, 12534.059945503941, 11373.658790236306, 11969.461374238354, 12001.63995080149, 12301.876981230072, 12403.62789116328, 11645.59240426581, 11821.349825759666, 12094.274343539415, 12532.436040378023, 12553.246805191719, 9634.0, 9905.0, 9974.20206383502, 9997.500124993576, 10340.27618066728, 9585.281103917094, 9600.183984361407, 9606.0, 9846.677007516992, 10189.133923616575], "unit": "score", "name": "yui.html", "value": 6291.089602103379}], "name": "dromaeo_css", "value": 6829.822314360036}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 106.0, 109.0, 110.0, 111.0, 112.0, 110.0, 103.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 154.0, 167.0, 127.0, 156.0, 181.0, 127.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [165.0, 160.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 96.0, 99.0, 72.0, 73.0, 72.0, 116.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [97.0, 94.0, 139.0, 96.0, 95.0, 95.0, 141.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 66.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 82.0, 82.0, 83.0, 81.0, 83.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 130.0, 133.0, 122.0, 116.0, 123.0, 117.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [149.0, 135.0, 145.0, 149.0, 142.0, 134.0, 134.0, 143.0, 142.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 68.0, 66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1498.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.1837985023826], "unit": "score", "name": "Richards", "value": 207.4345519999999}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1107.4197120708748], "unit": "score", "name": "RayTrace", "value": 668.2100670000003}, {"lowerIsBetter": false, "replicates": [780.811232449298], "unit": "score", "name": "Earley", "value": 853.5520139860142}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [42770.833333333336], "unit": "score", "name": "RegExp", "value": 21.29921091086215}, {"lowerIsBetter": false, "replicates": [587.5440658049354], "unit": "score", "name": "Splay", "value": 138.69768199999996}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20060.596264917443}]} 05:24:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20060.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6829.82"}}} 05:24:51 INFO - Return code: 0 05:24:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:24:51 INFO - # TBPL SUCCESS # 05:24:51 INFO - Running post-action listener: _resource_record_post_action 05:24:51 INFO - Running post-run listener: _resource_record_post_run 05:24:52 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 539873280; Read time: 0; Write time: 505716 05:24:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237289472; Read time: 0; Write time: 269228 05:24:52 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 302583808; Read time: 0; Write time: 236488 05:24:52 INFO - Running post-run listener: _upload_blobber_files 05:24:52 INFO - Blob upload gear active. 05:24:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:24:52 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 05:24:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:24:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:24:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:53 INFO - (blobuploader) - INFO - Done attempting. 05:24:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:54 INFO - (blobuploader) - INFO - Done attempting. 05:24:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:54 INFO - Return code: 0 05:24:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:24:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1929237c72189e3317f0cd87b49a2a2a829b2fd069854af142febf176eaedf417b28097c9e64dcd1508d389e150ef49371d6fe09069df1bc4aba021fb93bdaf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ceedd34c4c748311f69b9a611b7c514864a2bf9f43727c50170ce5508d3ad097fb332e144260da1fe86a79c2a0cc8a2fab488f47fcf477a4a6e974445792ecc"} 05:24:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:24:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:24:54 INFO - Contents: 05:24:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1929237c72189e3317f0cd87b49a2a2a829b2fd069854af142febf176eaedf417b28097c9e64dcd1508d389e150ef49371d6fe09069df1bc4aba021fb93bdaf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ceedd34c4c748311f69b9a611b7c514864a2bf9f43727c50170ce5508d3ad097fb332e144260da1fe86a79c2a0cc8a2fab488f47fcf477a4a6e974445792ecc"} 05:24:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:24:54 INFO - Copying logs to upload dir... 05:24:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:24:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.311625 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-18 05:24:54.461995) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 05:24:54.466083) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1929237c72189e3317f0cd87b49a2a2a829b2fd069854af142febf176eaedf417b28097c9e64dcd1508d389e150ef49371d6fe09069df1bc4aba021fb93bdaf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ceedd34c4c748311f69b9a611b7c514864a2bf9f43727c50170ce5508d3ad097fb332e144260da1fe86a79c2a0cc8a2fab488f47fcf477a4a6e974445792ecc"} build_url:https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011595 build_url: 'https://queue.taskcluster.net/v1/task/UMnd30LbS2q_0SvaqtZDeQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1929237c72189e3317f0cd87b49a2a2a829b2fd069854af142febf176eaedf417b28097c9e64dcd1508d389e150ef49371d6fe09069df1bc4aba021fb93bdaf2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6ceedd34c4c748311f69b9a611b7c514864a2bf9f43727c50170ce5508d3ad097fb332e144260da1fe86a79c2a0cc8a2fab488f47fcf477a4a6e974445792ecc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 05:24:54.496326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:24:54.497106) ========= 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=232498196343f89f466a4a9a000001c8-1453120944.652416-2036389143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 05:24:54.582625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 05:24:54.583362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 05:24:54.584047) ========= ========= Total master_lag: 0.28 =========