builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1453359071.36 results: success (0) buildid: 20160120203347 builduid: 8b4c3409f64540258455a3eb7ec5d31c revision: e1f6239bfa33d8d26852f107df61f1a6cc0f2308 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.359720) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.360206) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.360831) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006301 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.391333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.391622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.421392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.421769) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.474640) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.474910) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.475275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.475764) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 22:51:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.0M=0s 2016-01-20 22:51:12 (35.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.589221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.589623) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022449 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.644514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:11.644908) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1f6239bfa33d8d26852f107df61f1a6cc0f2308 --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 e1f6239bfa33d8d26852f107df61f1a6cc0f2308 --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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 22:51:12,512 truncating revision to first 12 chars 2016-01-20 22:51:12,512 Setting DEBUG logging. 2016-01-20 22:51:12,512 attempt 1/10 2016-01-20 22:51:12,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1f6239bfa33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 22:51:12,781 unpacking tar archive at: fx-team-e1f6239bfa33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.232896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.233250) ========= echo e1f6239bfa33d8d26852f107df61f1a6cc0f2308 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1f6239bfa33d8d26852f107df61f1a6cc0f2308'] 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e1f6239bfa33d8d26852f107df61f1a6cc0f2308 program finished with exit code 0 elapsedTime=0.003776 script_repo_revision: 'e1f6239bfa33d8d26852f107df61f1a6cc0f2308' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.285938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.286396) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.302211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.302726) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/e1f6239bfa33d8d26852f107df61f1a6cc0f2308 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 22:51:12.303250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-20 22:51:12.303883) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:51:13 INFO - MultiFileLogger online at 20160120 22:51:13 in /builds/slave/test-pgo 22:51:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:51:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:51:13 INFO - {'append_to_log': False, 22:51:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:51:13 INFO - 'blob_upload_branch': 'Fx-Team', 22:51:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:51:13 INFO - 'branch': 'Fx-Team', 22:51:13 INFO - 'buildbot_json_path': 'buildprops.json', 22:51:13 INFO - 'config_files': ('talos/linux_config.py',), 22:51:13 INFO - 'default_actions': ('clobber', 22:51:13 INFO - 'read-buildbot-config', 22:51:13 INFO - 'download-and-extract', 22:51:13 INFO - 'populate-webroot', 22:51:13 INFO - 'create-virtualenv', 22:51:13 INFO - 'install', 22:51:13 INFO - 'run-tests'), 22:51:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:51:13 INFO - 'download_minidump_stackwalk': True, 22:51:13 INFO - 'download_symbols': 'ondemand', 22:51:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:51:13 INFO - 'tooltool.py': '/tools/tooltool.py', 22:51:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:51:13 INFO - '/tools/misc-python/virtualenv.py')}, 22:51:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:51:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:51:13 INFO - 'installer_path': 'installer.exe', 22:51:13 INFO - 'log_level': 'info', 22:51:13 INFO - 'log_name': 'talos', 22:51:13 INFO - 'log_to_console': True, 22:51:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:51:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:51:13 INFO - 'opt_config_files': (), 22:51:13 INFO - 'pip_index': False, 22:51:13 INFO - 'sps_profile': False, 22:51:13 INFO - 'sps_profile_interval': 0, 22:51:13 INFO - 'suite': 'dromaeojs-e10s', 22:51:13 INFO - 'system_bits': '32', 22:51:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:51:13 INFO - 'title': 'talos-linux64-ix-044', 22:51:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:51:13 INFO - 'use_talos_json': True, 22:51:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:51:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:51:13 INFO - 'work_dir': 'build'} 22:51:13 INFO - ##### 22:51:13 INFO - ##### Running clobber step. 22:51:13 INFO - ##### 22:51:13 INFO - Running pre-action listener: _resource_record_pre_action 22:51:13 INFO - Running main action method: clobber 22:51:13 INFO - rmtree: /builds/slave/test-pgo/build 22:51:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:51:14 INFO - Running post-action listener: _resource_record_post_action 22:51:14 INFO - ##### 22:51:14 INFO - ##### Running read-buildbot-config step. 22:51:14 INFO - ##### 22:51:14 INFO - Running pre-action listener: _resource_record_pre_action 22:51:14 INFO - Running main action method: read_buildbot_config 22:51:14 INFO - Using buildbot properties: 22:51:14 INFO - { 22:51:14 INFO - "project": "", 22:51:14 INFO - "product": "firefox", 22:51:14 INFO - "script_repo_revision": "production", 22:51:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:51:14 INFO - "repository": "", 22:51:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:51:14 INFO - "buildid": "20160120203347", 22:51:14 INFO - "pgo_build": "True", 22:51:14 INFO - "basedir": "/builds/slave/test-pgo", 22:51:14 INFO - "buildnumber": 229, 22:51:14 INFO - "slavename": "talos-linux64-ix-044", 22:51:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:51:14 INFO - "platform": "ubuntu64_hw", 22:51:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:51:14 INFO - "branch": "fx-team", 22:51:14 INFO - "repo_path": "integration/fx-team", 22:51:14 INFO - "revision": "e1f6239bfa33d8d26852f107df61f1a6cc0f2308", 22:51:14 INFO - "stage_platform": "linux64-pgo", 22:51:14 INFO - "builduid": "8b4c3409f64540258455a3eb7ec5d31c", 22:51:14 INFO - "slavebuilddir": "test" 22:51:14 INFO - } 22:51:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:51:14 INFO - Running post-action listener: _resource_record_post_action 22:51:14 INFO - ##### 22:51:14 INFO - ##### Running download-and-extract step. 22:51:14 INFO - ##### 22:51:14 INFO - Running pre-action listener: _resource_record_pre_action 22:51:14 INFO - Running main action method: download_and_extract 22:51:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:14 INFO - https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:51:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/test_packages.json 22:51:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/test_packages.json 22:51:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:51:18 INFO - Downloaded 1448 bytes. 22:51:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:51:18 INFO - Using the following test package requirements: 22:51:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:51:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:51:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'jsshell-linux-x86_64.zip'], 22:51:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:51:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:51:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:51:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:51:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:51:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:51:18 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')]} 22:51:18 INFO - https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:28 INFO - Downloaded 22486116 bytes. 22:51:28 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'] 22:51:28 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 22:51:30 INFO - Return code: 0 22:51:30 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 22:51:30 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')]} 22:51:30 INFO - https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:33 INFO - Downloaded 22486116 bytes. 22:51:33 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'] 22:51:33 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 22:51:35 INFO - Return code: 0 22:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:35 INFO - https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:36 INFO - Downloaded 11132144 bytes. 22:51:36 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'] 22:51:36 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 22:51:36 INFO - Return code: 0 22:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:36 INFO - https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BrJ30WcIRs-0sM_jh6DAtA/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 22:51:37 INFO - Downloaded 55970432 bytes. 22:51:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:37 INFO - mkdir: /builds/slave/test-pgo/properties 22:51:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:51:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:51:37 INFO - Contents: 22:51:37 INFO - build_url:https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:37 INFO - Running post-action listener: _resource_record_post_action 22:51:37 INFO - Running post-action listener: set_extra_try_arguments 22:51:37 INFO - ##### 22:51:37 INFO - ##### Running populate-webroot step. 22:51:37 INFO - ##### 22:51:37 INFO - Running pre-action listener: _resource_record_pre_action 22:51:37 INFO - Running main action method: populate_webroot 22:51:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:51:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:51:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:51:37 INFO - '--tppagecycles', 22:51:37 INFO - '7'], 22:51:37 INFO - 'tests': ['tsvgm']}}, 22:51:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:51:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:51:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'tests': ['damp', 'tps']}, 22:51:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['damp', 'tps']}, 22:51:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:51:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:51:37 INFO - 'other': {'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'other_l64': {'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'other_nol64': {'tests': ['a11yr', 22:51:37 INFO - 'ts_paint', 22:51:37 INFO - 'tpaint', 22:51:37 INFO - 'sessionrestore', 22:51:37 INFO - 'sessionrestore_no_auto_restore']}, 22:51:37 INFO - 'svgr': {'tests': ['tsvgx', 22:51:37 INFO - 'tsvgr_opacity', 22:51:37 INFO - 'tart', 22:51:37 INFO - 'tscrollx', 22:51:37 INFO - 'cart']}, 22:51:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['tsvgx', 22:51:37 INFO - 'tsvgr_opacity', 22:51:37 INFO - 'tart', 22:51:37 INFO - 'tscrollx', 22:51:37 INFO - 'cart']}, 22:51:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'tests': ['tp5o']}, 22:51:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'talos_options': ['--e10s'], 22:51:37 INFO - 'tests': ['tp5o']}, 22:51:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'talos_options': ['--xperf_path', 22:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:37 INFO - 'tests': ['tp5n']}, 22:51:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:37 INFO - 'talos_options': ['--e10s', 22:51:37 INFO - '--xperf_path', 22:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:37 INFO - 'tests': ['tp5n']}}, 22:51:37 INFO - 'talos.zip': {'path': '', 22:51:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:51:37 INFO - Running post-action listener: _resource_record_post_action 22:51:37 INFO - ##### 22:51:37 INFO - ##### Running create-virtualenv step. 22:51:37 INFO - ##### 22:51:37 INFO - Running pre-action listener: _resource_record_pre_action 22:51:37 INFO - Running main action method: create_virtualenv 22:51:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:51:37 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 22:51:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:51:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:51:37 INFO - Using real prefix '/usr' 22:51:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:51:38 INFO - Installing distribute.............................................................................................................................................................................................done. 22:51:40 INFO - Installing pip.................done. 22:51:40 INFO - Return code: 0 22:51:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:51:40 INFO - Using env: {'DISPLAY': ':0', 22:51:40 INFO - 'HOME': '/home/cltbld', 22:51:40 INFO - 'LANG': 'en_US.UTF-8', 22:51:40 INFO - 'LANGUAGE': 'en_US:en', 22:51:40 INFO - 'LOGNAME': 'cltbld', 22:51:40 INFO - 'MAIL': '/var/mail/cltbld', 22:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:40 INFO - 'MOZ_NO_REMOTE': '1', 22:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:40 INFO - 'NO_EM_RESTART': '1', 22:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:40 INFO - 'SHELL': '/bin/bash', 22:51:40 INFO - 'SHLVL': '1', 22:51:40 INFO - 'TERM': 'linux', 22:51:40 INFO - 'TMOUT': '86400', 22:51:40 INFO - 'USER': 'cltbld', 22:51:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:40 INFO - '_': '/tools/buildbot/bin/python'} 22:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:40 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 22:51:40 INFO - Cleaning up... 22:51:40 INFO - Return code: 0 22:51:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:51:40 INFO - Using env: {'DISPLAY': ':0', 22:51:40 INFO - 'HOME': '/home/cltbld', 22:51:40 INFO - 'LANG': 'en_US.UTF-8', 22:51:40 INFO - 'LANGUAGE': 'en_US:en', 22:51:40 INFO - 'LOGNAME': 'cltbld', 22:51:40 INFO - 'MAIL': '/var/mail/cltbld', 22:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:40 INFO - 'MOZ_NO_REMOTE': '1', 22:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:40 INFO - 'NO_EM_RESTART': '1', 22:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:40 INFO - 'SHELL': '/bin/bash', 22:51:40 INFO - 'SHLVL': '1', 22:51:40 INFO - 'TERM': 'linux', 22:51:40 INFO - 'TMOUT': '86400', 22:51:40 INFO - 'USER': 'cltbld', 22:51:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:40 INFO - '_': '/tools/buildbot/bin/python'} 22:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:40 INFO - Downloading/unpacking psutil>=0.7.1 22:51:40 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 22:51:40 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 22:51:40 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 22:51:40 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 22:51:40 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 22:51:40 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 22:51:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:51:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:42 INFO - Installing collected packages: psutil 22:51:42 INFO - Running setup.py install for psutil 22:51:42 INFO - building 'psutil._psutil_linux' extension 22:51:42 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 22:51:42 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 22:51:42 INFO - building 'psutil._psutil_posix' extension 22:51:42 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 22:51:43 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 22:51:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:43 INFO - Successfully installed psutil 22:51:43 INFO - Cleaning up... 22:51:43 INFO - Return code: 0 22:51:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:51:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:51:43 INFO - Using env: {'DISPLAY': ':0', 22:51:43 INFO - 'HOME': '/home/cltbld', 22:51:43 INFO - 'LANG': 'en_US.UTF-8', 22:51:43 INFO - 'LANGUAGE': 'en_US:en', 22:51:43 INFO - 'LOGNAME': 'cltbld', 22:51:43 INFO - 'MAIL': '/var/mail/cltbld', 22:51:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:43 INFO - 'MOZ_NO_REMOTE': '1', 22:51:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:43 INFO - 'NO_EM_RESTART': '1', 22:51:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:43 INFO - 'SHELL': '/bin/bash', 22:51:43 INFO - 'SHLVL': '1', 22:51:43 INFO - 'TERM': 'linux', 22:51:43 INFO - 'TMOUT': '86400', 22:51:43 INFO - 'USER': 'cltbld', 22:51:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:43 INFO - '_': '/tools/buildbot/bin/python'} 22:51:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:51:43 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 22:51:43 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 22:51:43 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 22:51:43 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 22:51:43 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 22:51:43 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 22:51:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:51:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:51:45 INFO - Installing collected packages: mozsystemmonitor 22:51:45 INFO - Running setup.py install for mozsystemmonitor 22:51:45 INFO - Successfully installed mozsystemmonitor 22:51:45 INFO - Cleaning up... 22:51:45 INFO - Return code: 0 22:51:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:51:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:51:45 INFO - Using env: {'DISPLAY': ':0', 22:51:45 INFO - 'HOME': '/home/cltbld', 22:51:45 INFO - 'LANG': 'en_US.UTF-8', 22:51:45 INFO - 'LANGUAGE': 'en_US:en', 22:51:45 INFO - 'LOGNAME': 'cltbld', 22:51:45 INFO - 'MAIL': '/var/mail/cltbld', 22:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:45 INFO - 'MOZ_NO_REMOTE': '1', 22:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:45 INFO - 'NO_EM_RESTART': '1', 22:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:45 INFO - 'SHELL': '/bin/bash', 22:51:45 INFO - 'SHLVL': '1', 22:51:45 INFO - 'TERM': 'linux', 22:51:45 INFO - 'TMOUT': '86400', 22:51:45 INFO - 'USER': 'cltbld', 22:51:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:45 INFO - '_': '/tools/buildbot/bin/python'} 22:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:45 INFO - Downloading/unpacking blobuploader==1.2.4 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:47 INFO - Downloading blobuploader-1.2.4.tar.gz 22:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:51:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:51:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:48 INFO - Downloading docopt-0.6.1.tar.gz 22:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:51:48 INFO - Installing collected packages: blobuploader, requests, docopt 22:51:48 INFO - Running setup.py install for blobuploader 22:51:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:51:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:51:48 INFO - Running setup.py install for requests 22:51:48 INFO - Running setup.py install for docopt 22:51:48 INFO - Successfully installed blobuploader requests docopt 22:51:48 INFO - Cleaning up... 22:51:48 INFO - Return code: 0 22:51:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:51:48 INFO - Using env: {'DISPLAY': ':0', 22:51:48 INFO - 'HOME': '/home/cltbld', 22:51:48 INFO - 'LANG': 'en_US.UTF-8', 22:51:48 INFO - 'LANGUAGE': 'en_US:en', 22:51:48 INFO - 'LOGNAME': 'cltbld', 22:51:48 INFO - 'MAIL': '/var/mail/cltbld', 22:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:48 INFO - 'MOZ_NO_REMOTE': '1', 22:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:48 INFO - 'NO_EM_RESTART': '1', 22:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:48 INFO - 'SHELL': '/bin/bash', 22:51:48 INFO - 'SHLVL': '1', 22:51:48 INFO - 'TERM': 'linux', 22:51:48 INFO - 'TMOUT': '86400', 22:51:48 INFO - 'USER': 'cltbld', 22:51:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:48 INFO - '_': '/tools/buildbot/bin/python'} 22:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:48 INFO - Running setup.py (path:/tmp/pip-cSMTpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:49 INFO - Running setup.py (path:/tmp/pip-vszgfS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:49 INFO - Running setup.py (path:/tmp/pip-h0VXc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:49 INFO - Running setup.py (path:/tmp/pip-UV6EHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:49 INFO - Running setup.py (path:/tmp/pip-akMdVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:49 INFO - Running setup.py (path:/tmp/pip-H0jmtz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:49 INFO - Running setup.py (path:/tmp/pip-jqageZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:49 INFO - Running setup.py (path:/tmp/pip-WCa2ao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:49 INFO - Running setup.py (path:/tmp/pip-IV5tdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:49 INFO - Running setup.py (path:/tmp/pip-5rOpDI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:49 INFO - Running setup.py (path:/tmp/pip-wpye56-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:49 INFO - Running setup.py (path:/tmp/pip-dwUkkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:49 INFO - Running setup.py (path:/tmp/pip-_QdlO_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:49 INFO - Running setup.py (path:/tmp/pip-sa4AZB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:49 INFO - Running setup.py (path:/tmp/pip-J1PvzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:50 INFO - Running setup.py (path:/tmp/pip-k_ShoR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:50 INFO - Running setup.py (path:/tmp/pip-TepDvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:51:50 INFO - Running setup.py install for manifestparser 22:51:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Running setup.py install for mozcrash 22:51:50 INFO - Running setup.py install for mozdebug 22:51:50 INFO - Running setup.py install for mozdevice 22:51:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Running setup.py install for mozfile 22:51:50 INFO - Running setup.py install for mozhttpd 22:51:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Running setup.py install for mozinfo 22:51:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Running setup.py install for mozInstall 22:51:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Running setup.py install for mozleak 22:51:51 INFO - Running setup.py install for mozlog 22:51:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Running setup.py install for moznetwork 22:51:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Running setup.py install for mozprocess 22:51:51 INFO - Running setup.py install for mozprofile 22:51:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Running setup.py install for mozrunner 22:51:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Running setup.py install for mozscreenshot 22:51:51 INFO - Running setup.py install for moztest 22:51:51 INFO - Running setup.py install for mozversion 22:51:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:51:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:51:51 INFO - Cleaning up... 22:51:51 INFO - Return code: 0 22:51:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:51:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:51:51 INFO - Using env: {'DISPLAY': ':0', 22:51:51 INFO - 'HOME': '/home/cltbld', 22:51:51 INFO - 'LANG': 'en_US.UTF-8', 22:51:51 INFO - 'LANGUAGE': 'en_US:en', 22:51:51 INFO - 'LOGNAME': 'cltbld', 22:51:51 INFO - 'MAIL': '/var/mail/cltbld', 22:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:51 INFO - 'MOZ_NO_REMOTE': '1', 22:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:51 INFO - 'NO_EM_RESTART': '1', 22:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:51 INFO - 'SHELL': '/bin/bash', 22:51:51 INFO - 'SHLVL': '1', 22:51:51 INFO - 'TERM': 'linux', 22:51:51 INFO - 'TMOUT': '86400', 22:51:51 INFO - 'USER': 'cltbld', 22:51:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:51 INFO - '_': '/tools/buildbot/bin/python'} 22:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:52 INFO - Running setup.py (path:/tmp/pip-GWS2om-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:52 INFO - Running setup.py (path:/tmp/pip-9TqbHc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:52 INFO - Running setup.py (path:/tmp/pip-78Y7lN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:52 INFO - Running setup.py (path:/tmp/pip-wJ9_oF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:52 INFO - Running setup.py (path:/tmp/pip-C_OQqg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:52 INFO - Running setup.py (path:/tmp/pip-qbO67f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:52 INFO - Running setup.py (path:/tmp/pip-guDpXQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:52 INFO - Running setup.py (path:/tmp/pip-IfZTUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:52 INFO - Running setup.py (path:/tmp/pip-Ctx4jX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:52 INFO - Running setup.py (path:/tmp/pip-m68y81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:52 INFO - Running setup.py (path:/tmp/pip-LkIH5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:52 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)) 22:51:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:52 INFO - Running setup.py (path:/tmp/pip-H2kZAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:53 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)) 22:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:53 INFO - Running setup.py (path:/tmp/pip-HIRvDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:53 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)) 22:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:53 INFO - Running setup.py (path:/tmp/pip-faiJDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:53 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)) 22:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:53 INFO - Running setup.py (path:/tmp/pip-mM4MSf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:53 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)) 22:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:53 INFO - Running setup.py (path:/tmp/pip-dKbZA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:53 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)) 22:51:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:53 INFO - Running setup.py (path:/tmp/pip-vz_QBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:53 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)) 22:51:53 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)) 22:51:53 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)) 22:51:53 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)) 22:51:53 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)) 22:51:53 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)) 22:51:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:51:53 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 22:51:53 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 22:51:53 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 22:51:53 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 22:51:53 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 22:51:53 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 22:51:55 INFO - Downloading blessings-1.6.tar.gz 22:51:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:51:55 INFO - Installing collected packages: blessings 22:51:55 INFO - Running setup.py install for blessings 22:51:55 INFO - Successfully installed blessings 22:51:55 INFO - Cleaning up... 22:51:55 INFO - Return code: 0 22:51:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:51:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:55 INFO - Reading from file tmpfile_stdout 22:51:55 INFO - Current package versions: 22:51:55 INFO - argparse == 1.2.1 22:51:55 INFO - blessings == 1.6 22:51:55 INFO - blobuploader == 1.2.4 22:51:55 INFO - docopt == 0.6.1 22:51:55 INFO - manifestparser == 1.1 22:51:55 INFO - mozInstall == 1.12 22:51:55 INFO - mozcrash == 0.16 22:51:55 INFO - mozdebug == 0.1 22:51:55 INFO - mozdevice == 0.48 22:51:55 INFO - mozfile == 1.2 22:51:55 INFO - mozhttpd == 0.7 22:51:55 INFO - mozinfo == 0.9 22:51:55 INFO - mozleak == 0.1 22:51:55 INFO - mozlog == 3.1 22:51:55 INFO - moznetwork == 0.27 22:51:55 INFO - mozprocess == 0.22 22:51:55 INFO - mozprofile == 0.28 22:51:55 INFO - mozrunner == 6.11 22:51:55 INFO - mozscreenshot == 0.1 22:51:55 INFO - mozsystemmonitor == 0.0 22:51:55 INFO - moztest == 0.7 22:51:55 INFO - mozversion == 1.4 22:51:55 INFO - psutil == 3.1.1 22:51:55 INFO - requests == 1.2.3 22:51:55 INFO - wsgiref == 0.1.2 22:51:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:51:55 INFO - Using env: {'DISPLAY': ':0', 22:51:55 INFO - 'HOME': '/home/cltbld', 22:51:55 INFO - 'LANG': 'en_US.UTF-8', 22:51:55 INFO - 'LANGUAGE': 'en_US:en', 22:51:55 INFO - 'LOGNAME': 'cltbld', 22:51:55 INFO - 'MAIL': '/var/mail/cltbld', 22:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:55 INFO - 'MOZ_NO_REMOTE': '1', 22:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:55 INFO - 'NO_EM_RESTART': '1', 22:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:55 INFO - 'SHELL': '/bin/bash', 22:51:55 INFO - 'SHLVL': '1', 22:51:55 INFO - 'TERM': 'linux', 22:51:55 INFO - 'TMOUT': '86400', 22:51:55 INFO - 'USER': 'cltbld', 22:51:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:55 INFO - '_': '/tools/buildbot/bin/python'} 22:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 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)) 22:51:55 INFO - Cleaning up... 22:51:55 INFO - Return code: 0 22:51:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:51:55 INFO - Using env: {'DISPLAY': ':0', 22:51:55 INFO - 'HOME': '/home/cltbld', 22:51:55 INFO - 'LANG': 'en_US.UTF-8', 22:51:55 INFO - 'LANGUAGE': 'en_US:en', 22:51:55 INFO - 'LOGNAME': 'cltbld', 22:51:55 INFO - 'MAIL': '/var/mail/cltbld', 22:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:55 INFO - 'MOZ_NO_REMOTE': '1', 22:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:55 INFO - 'NO_EM_RESTART': '1', 22:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:55 INFO - 'SHELL': '/bin/bash', 22:51:55 INFO - 'SHLVL': '1', 22:51:55 INFO - 'TERM': 'linux', 22:51:55 INFO - 'TMOUT': '86400', 22:51:55 INFO - 'USER': 'cltbld', 22:51:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:55 INFO - '_': '/tools/buildbot/bin/python'} 22:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:56 INFO - Downloading/unpacking jsonschema 22:51:56 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 22:51:56 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 22:51:56 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 22:51:56 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 22:51:56 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 22:51:56 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 22:51:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:51:57 INFO - Downloading/unpacking functools32 (from jsonschema) 22:51:57 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 22:51:57 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 22:51:57 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 22:51:57 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 22:51:57 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 22:51:57 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 22:51:57 INFO - Downloading functools32-3.2.3-2.tar.gz 22:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:51:57 INFO - warning: no files found matching '*.txt' 22:51:57 INFO - no previously-included directories found matching 'build' 22:51:57 INFO - no previously-included directories found matching 'dist' 22:51:57 INFO - no previously-included directories found matching '.git*' 22:51:57 INFO - Installing collected packages: jsonschema, functools32 22:51:58 INFO - Running setup.py install for functools32 22:51:58 INFO - warning: no files found matching '*.txt' 22:51:58 INFO - no previously-included directories found matching 'build' 22:51:58 INFO - no previously-included directories found matching 'dist' 22:51:58 INFO - no previously-included directories found matching '.git*' 22:51:58 INFO - Successfully installed jsonschema functools32 22:51:58 INFO - Cleaning up... 22:51:58 INFO - Return code: 0 22:51:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8b2fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, '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': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', '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 22:51:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:51:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:51:58 INFO - Using env: {'DISPLAY': ':0', 22:51:58 INFO - 'HOME': '/home/cltbld', 22:51:58 INFO - 'LANG': 'en_US.UTF-8', 22:51:58 INFO - 'LANGUAGE': 'en_US:en', 22:51:58 INFO - 'LOGNAME': 'cltbld', 22:51:58 INFO - 'MAIL': '/var/mail/cltbld', 22:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:58 INFO - 'MOZ_NO_REMOTE': '1', 22:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:58 INFO - 'NO_EM_RESTART': '1', 22:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:58 INFO - 'SHELL': '/bin/bash', 22:51:58 INFO - 'SHLVL': '1', 22:51:58 INFO - 'TERM': 'linux', 22:51:58 INFO - 'TMOUT': '86400', 22:51:58 INFO - 'USER': 'cltbld', 22:51:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:58 INFO - '_': '/tools/buildbot/bin/python'} 22:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:58 INFO - Downloading/unpacking flake8 22:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:52:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:52:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:52:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:00 INFO - no previously-included directories found matching 'docs/_build' 22:52:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:52:01 INFO - Running setup.py install for pep8 22:52:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:52:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:52:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:52:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:52:01 INFO - no previously-included directories found matching 'docs/_build' 22:52:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:52:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:52:01 INFO - Cleaning up... 22:52:01 INFO - Return code: 0 22:52:01 INFO - Running post-action listener: _resource_record_post_action 22:52:01 INFO - Running post-action listener: _start_resource_monitoring 22:52:01 INFO - Starting resource monitoring. 22:52:01 INFO - ##### 22:52:01 INFO - ##### Running install step. 22:52:01 INFO - ##### 22:52:01 INFO - Running pre-action listener: _resource_record_pre_action 22:52:01 INFO - Running main action method: install 22:52:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:52:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:52:01 INFO - Reading from file tmpfile_stdout 22:52:01 INFO - Detecting whether we're running mozinstall >=1.0... 22:52:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:52:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:52:01 INFO - Reading from file tmpfile_stdout 22:52:01 INFO - Output received: 22:52:01 INFO - Usage: mozinstall [options] installer 22:52:01 INFO - Options: 22:52:01 INFO - -h, --help show this help message and exit 22:52:01 INFO - -d DEST, --destination=DEST 22:52:01 INFO - Directory to install application into. [default: 22:52:01 INFO - "/builds/slave/test-pgo"] 22:52:01 INFO - --app=APP Application being installed. [default: firefox] 22:52:01 INFO - mkdir: /builds/slave/test-pgo/build/application 22:52:01 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'] 22:52:01 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 22:52:17 INFO - Reading from file tmpfile_stdout 22:52:17 INFO - Output received: 22:52:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:52:17 INFO - Running post-action listener: _resource_record_post_action 22:52:17 INFO - ##### 22:52:17 INFO - ##### Running run-tests step. 22:52:17 INFO - ##### 22:52:17 INFO - Running pre-action listener: _resource_record_pre_action 22:52:17 INFO - Running main action method: run_tests 22:52:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:52:17 INFO - Python 2.7.3 22:52:17 INFO - Return code: 0 22:52:17 INFO - grabbing minidump binary from tooltool 22:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:17 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 0x2be0840>, '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 0x2b4d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:52:17 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 22:52:17 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 22:52:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:52:17 INFO - Return code: 0 22:52:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:52:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:52:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:52:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:52:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:52:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:52:18 INFO - Return code: 0 22:52:18 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:52:18 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:52:18 INFO - Using env: {'DISPLAY': ':0', 22:52:18 INFO - 'HOME': '/home/cltbld', 22:52:18 INFO - 'LANG': 'en_US.UTF-8', 22:52:18 INFO - 'LANGUAGE': 'en_US:en', 22:52:18 INFO - 'LOGNAME': 'cltbld', 22:52:18 INFO - 'MAIL': '/var/mail/cltbld', 22:52:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:52:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:18 INFO - 'MOZ_NO_REMOTE': '1', 22:52:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:52:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:18 INFO - 'NO_EM_RESTART': '1', 22:52:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:18 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:52:18 INFO - 'SHELL': '/bin/bash', 22:52:18 INFO - 'SHLVL': '1', 22:52:18 INFO - 'TERM': 'linux', 22:52:18 INFO - 'TMOUT': '86400', 22:52:18 INFO - 'USER': 'cltbld', 22:52:18 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344', 22:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:18 INFO - '_': '/tools/buildbot/bin/python'} 22:52:18 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:52:18 INFO - mozversion application_buildid: 20160120203347 22:52:18 INFO - mozversion application_changeset: e1f6239bfa33d8d26852f107df61f1a6cc0f2308 22:52:18 INFO - mozversion application_display_name: Nightly 22:52:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:52:18 INFO - mozversion application_name: Firefox 22:52:18 INFO - mozversion application_remotingname: firefox 22:52:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:52:18 INFO - mozversion application_vendor: Mozilla 22:52:18 INFO - mozversion application_version: 46.0a1 22:52:18 INFO - mozversion platform_buildid: 20160120203347 22:52:18 INFO - mozversion platform_changeset: e1f6239bfa33d8d26852f107df61f1a6cc0f2308 22:52:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:52:18 INFO - mozversion platform_version: 46.0a1 22:52:18 INFO - using testdate: 1453359138 22:52:18 INFO - actual date: 1453359138 22:52:18 INFO - starting webserver on 'localhost:58626' 22:52:18 INFO - SUITE-START | Running 3 tests 22:52:18 INFO - TEST-START | dromaeo_css 22:52:18 INFO - operating with platform_type : linux_ 22:52:18 INFO - Initialising browser for dromaeo_css test... 22:52:18 INFO - TEST-INFO | started process 899 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7kkkZC/profile http://localhost:58626/getInfo.html) 22:52:22 INFO - PROCESS | 899 | -- checkerboarding starts below -- 22:52:22 INFO - PROCESS | 899 | RENDERTRACE 0.034481 rect red 0 0 1024 768 // viewport 22:52:22 INFO - PROCESS | 899 | RENDERTRACE 9.39965 rect brown 0 0 1024 768 // page 22:52:22 INFO - PROCESS | 899 | RENDERTRACE 9.41719 rect lightgreen 0 0 1024 768 // painted displayport (this layertree updated) 22:52:22 INFO - PROCESS | 899 | Checkerboarded for 1 frames (16.9791 ms), 786432 peak, 10201 severity. 22:52:22 INFO - PROCESS | 899 | 22:52:22 INFO - PROCESS | 899 | (process:981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:52:23 INFO - PROCESS | 899 | __metrics Screen width/height:1600/1200 22:52:23 INFO - PROCESS | 899 | colorDepth:24 22:52:23 INFO - PROCESS | 899 | Browser inner width/height: 1024/697 22:52:23 INFO - PROCESS | 899 | __metrics 22:52:23 INFO - PROCESS | 899 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:52:24 INFO - TEST-INFO | 899: exit 0 22:52:24 INFO - Browser initialized. 22:52:24 INFO - Running cycle 1/1 for dromaeo_css test... 22:52:24 INFO - TEST-INFO | started process 1030 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7kkkZC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:25 INFO - PROCESS | 1030 | -- checkerboarding starts below -- 22:52:25 INFO - PROCESS | 1030 | RENDERTRACE 0.038063 rect red 0 0 10 10 // viewport 22:52:25 INFO - PROCESS | 1030 | RENDERTRACE 72.6185 rect brown 0 0 10 10 // page 22:52:25 INFO - PROCESS | 1030 | RENDERTRACE 72.645 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 22:52:25 INFO - PROCESS | 1030 | Checkerboarded for 1 frames (73.7174 ms), 100 peak, 1 severity. 22:52:25 INFO - PROCESS | 1030 | 22:52:25 INFO - PROCESS | 1030 | (process:1093): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:52:36 INFO - PROCESS | 1030 | RSS: Main: 150093824 22:52:36 INFO - PROCESS | 1030 | 22:53:26 INFO - PROCESS | 1030 | 1453359206038 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] 22:55:34 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58626/tests/dromaeo/cssquery-ext.html) 22:55:36 INFO - PROCESS | 1030 | RSS: Main: 155156480 22:55:36 INFO - PROCESS | 1030 | 22:58:38 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-ext.html (next: http://localhost:58626/tests/dromaeo/cssquery-jquery.html) 22:58:38 INFO - PROCESS | 1030 | RSS: Main: 152313856 22:58:38 INFO - PROCESS | 1030 | 23:01:40 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58626/tests/dromaeo/cssquery-mootools.html) 23:01:41 INFO - PROCESS | 1030 | RSS: Main: 150908928 23:01:41 INFO - PROCESS | 1030 | 23:04:42 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58626/tests/dromaeo/cssquery-prototype.html) 23:04:43 INFO - PROCESS | 1030 | RSS: Main: 150196224 23:04:43 INFO - PROCESS | 1030 | 23:07:45 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58626/tests/dromaeo/cssquery-yui.html) 23:07:46 INFO - PROCESS | 1030 | RSS: Main: 150700032 23:07:46 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | Cycle 1(1): loaded http://localhost:58626/tests/dromaeo/cssquery-yui.html (next: http://localhost:58626/tests/dromaeo/cssquery-dojo.html) 23:10:49 INFO - PROCESS | 1030 | RSS: Main: 153456640 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | __start_tp_report 23:10:49 INFO - PROCESS | 1030 | _x_x_mozilla_page_load 23:10:49 INFO - PROCESS | 1030 | _x_x_mozilla_page_load_details 23:10:49 INFO - PROCESS | 1030 | |i|pagename|runs| 23:10:49 INFO - PROCESS | 1030 | |0;dojo.html;3182.1090094773463;3212.8714851405944;3232.2404235004783;3250.463673493873;3260.576125103736;5183.688978661283;5224.2163675448655;5235.7120358380325;5305.416404195545;5322.92015619766;5275.024120537693;5290.470952904717;5307.2569840222395;5310.92033619496;5352.678839269646;4912.435069966964;4940.283658869462;4962.007598480301;4978.775955082012;4990.6007519398545;4936.160852655039;4986.326845875797;5006.824761133361;5021.623378246628;5071.974640126794;4627.097715945375;4794.640401969848;4926.802927882881;4929.433115191763;4932.482089380635;4923.58149557288;4929.556339929388;4931.7780699868235;4955.058538877602;4984.82553110643;4809.2305231162845;4886.780094895703;4902.2156454967035;4904.509549045067;4954;5108.386993560759;5170.353705786777;5170.405403378584;5178.948210517884;5205.6616319939085;5767.826965191051;5771.076627739583;5778.451047150514;5780.104083867007;5794.101914203306;5680.488756011938;5769.711514424262;5812.360640329561;5815.040518314473;5823.53411727065;5376.758045887945;5428.104362780097;5430.864228394283;5436.483534064297;5476.561875049986;5944.464998150187;5961.672108034013;5970.044792833126;5972.193753843262;5977.940220597825;5535.418781028015;5600.551955843523;5714.457126572969;5734.827955161351;5735.082386818172;5622.044252477089;5687.914681279784;5691.089425691869;5701.116326969326;5753.223314852525;5617.466340697627;5635.5773317001385;5664.178694089334;5674.914876276859;5719.742611582489;5581.441855814386;5653.038983372754;5653.943460565424;5720.885582288331;5742.425757424224;4419.624331931822;4421.049474363027;4445.199864024442;4481.529439408815;4531.909361812745;3965.2466031453932;3965.7818819965178;3983.5817239190046;3992.86024989124;4040.313146765057;5229.267902493654;5311.787528498817;5338.172583249602;5378.7041712705395;5394.352677678625;5690.601657883908;5730.169125476783;5741.827745167651;5773.566982476247;5805.303363596396;5286.1806420004195;5349.5720342372515;5356.517913387814;5363.275957745733;5380.677159370451;4846.321514987904;4875.07373599015;4886.902261954741;4900.142475066849;4919.950800492021;5837.854053648693;5914.260717410324;5936.614120082181;5990.6705131218205;6018.6990650467305;5787.739551720267;5788.392218817132;5821.679807610622;5822.301323840997;5827.76688932438;5820.73806678692;5946.464818166386;6029.668368239789;6032.638041717511;6033.12519684652;5593.468620481048;5623.803166889303;5645.096784514458;5677.120046392815;5729.169270455677;5760.107183386582;5783.103618939072;5815.9709201453725;5830.154627579062;5832.679202643895;5433.266509021231;5556.72216389187;5669.4047125051275;5681;5691.430856914276;5497.312835895513;5552.056150454352;5572.60991730575;5592.440755924375;5633.295838020247;5527.2538207341495;5559.27729395176;5564.137558678412;5568.721563921868;5593.07714227148;5462.20797984298;5665.178549110438;5676.914846277226;5722.542196624343;5734.913976290442;5458.645188062763;5478.178273259043;5492.340919089735;5512.310961129859;5564.10974244119 23:10:49 INFO - PROCESS | 1030 | |1;ext.html;530.1226470191834;555.4501043966474;555.525026102682;570.3469527391137;576.2105914896591;35000;35353.82323088387;35492.46761298583;35502.46746298801;35604.64395356046;38973.805130974375;39305.8034709826;39321.606783932155;39447.40828887562;39470.40794388086;8402.873956890651;8584.656613735444;8587;8590.785230369229;8597.054324024351;8249.515087284286;8360.372972027091;8417.410781245315;8621.870671939925;8648.35137364697;8609.655613775441;8618.525981071038;8658.740237792876;8676.826463470758;8703;8487.151284871525;8586.699465518677;8611.397202195849;8611.827763444759;8621.31029517637;8527.488350698977;8617.65529378824;8623.698170564063;8670.959484861794;8673.219410253045;36961.63038369609;37496;37508.43737343942;37528;37682.62317376819;3285.4250506161325;3301.1087006508346;3301.240714635623;3309.5697559317377;3401.557797486336;29113.85443072771;29406.558901616492;29518;29525.261868453246;29951.251218719488;3846.6345697159004;3886.514185726784;3929.096307849211;3998.900027499307;4035.59644035597;264280;265590;268092.659536703;269052;269901;49851.50148498541;50667;54184.45815541794;54370.72814635901;54379.72810135924;58503.70748146232;59593.70203148956;59663;59736.402635973085;59938;13122;13404.530841420503;13434.596962091153;13435.462581496826;13443.86556134426;9977.501124943723;10064.748381290527;10082.949585252027;10117.848232276521;10157;18252.178651960694;18706.81293187078;18723.812761872206;18730;18838.24647014104;7369.668364923591;7665.770026899202;7689.846203075907;7752.496087754278;7752.922470775333;928.3176865004217;949.8147861167006;1019.4647809899861;1031.097789434245;1051.321897376188;24887.751122488906;25170;25237.495250094897;28310;29291;1024.7335692719946;1046.576136664652;1122.9438528073563;1164.0861923390266;1201.765655697148;13479.86520134786;13522.797158042637;13636.727265454834;13737.725245495234;13807.51673691416;319172;321378;323185;323190;324219;48030;48206.27690584644;48222.5177748225;48307.75846120747;48389.75805121022;1343.9987209528963;1347.8045683376051;1348.534755509328;1350.4328182163515;1352.6280272925023;26040.60939085877;26970.32574185661;27000;27239.59140612853;29710.702892971658;45263;45337.31994020158;45668.77165614151;45687.08625827531;45746.31380529361;244683;247165;247185;247632;248213;30659.846700766353;31046.689533105284;31435.685643143275;31456.528152078194;31456.685433146293;39308.2138357237;39418.802905985285;40048.79975600103;40356.1928761429;40555.39166912558;33278.00331980089;33786.662133378355;34703;36982;38026.429603555414;33900;34527.4820877682;34549.48175777315;35074.82462587671;35201.82399087988;33915.66084339125;34183.145421364665;34315.65684343124;34694.65305346914;34830;30768;31541.21146971252;31617.683823161475;31933;32117.1970700725;24102;24298.75701242965;24334.63498047495;24521;24814.503709926063 23:10:49 INFO - PROCESS | 1030 | |2;jquery.html;354.9520814690016;365.2876890064374;367.329623437227;368.69582594359645;368.9299033183693;15347.846521534795;16705.164741762925;16714;17309;17909.462716118538;10920.672379828598;11013.724656883582;11466.254693444942;11488.13838962077;11531.423428828566;4820.662553621248;4865.708057516543;5005.074061298653;5026.070177017245;5051.924221136667;4920.3357546731095;4993.500649934996;5010.849674509753;5022.321986531826;5022.573081288095;4885.9511404886025;4936.30891675164;4994.775235114428;5081.212412076134;5372.0330340538685;5034.748262586856;5049.242613607951;5050.747462626854;5061.266116413118;5098.643094983334;5126.154184559543;5144.279800827887;5158.97420512895;5160.664556803796;5180.430152683201;12920.353982300941;15730.528084157493;18679.813201867943;19555.217791288473;19569.706454403196;2090.874547527153;2095.6227878981776;2117.4494631395796;2150.7956744109283;2214.0368939511363;9132.817343653156;9359.438433694;9369.016253293374;9624.663136790248;10953.561857525689;1758.4900378890234;1771.5748220427133;1926.8651194416395;1969.6060787842346;2027.28031548801;54114;56005.15992260079;56568.717156414365;56998.71500642512;57965;10189;10193.847092293474;10194.980501949745;10225.43760093202;10277;13170.539031133865;13186.472541098441;13265.336733163304;13296.534621288209;13328.733425331438;7054.788356349318;7106.182788979334;7125.3230943060325;7193.352598266181;7219.241979592172;6486.67566621667;6626.9337306627285;6773.9322606774285;6796.52424330302;6797.626130562768;4365.454318210223;4485.304777759453;4488.192125417456;4522.932156017662;4526.95473045272;1785.5982403959006;1797.6764182447284;1845.3817970979603;1868.8131186881476;1872.3914727713548;824.1428913929566;861.0356400831109;891.4740303221131;1004.7186787699455;1066.7493139112303;14738.705225895423;14745.336459859333;16111.597210069842;16206.75689864653;16308.184590770414;947.1097168661436;947.4978261521404;950.5437390052813;995.8356871116184;1010.4796030044533;9368.578413971387;9399.295052871063;9500.477473738873;9596.376235544667;9763.218942484584;484476;496053;507935;508208;530028.5481443694;51575.484245157815;70302.2969770306;71385.64307178535;71396.28603714;71518;1089.809283375406;1095.4686976816079;1097.4074000040048;1114.4817659788237;1118.2619471149003;14449.688049911963;14660.56018319452;14705.779413308595;14841.183734894685;14958.177300248592;31476.37047259088;32012.359752805278;32186.517202242452;32509.18727031843;32793.83603082065;40379.798101009306;41652.16695666009;41920.16159676851;42013.36979945364;45003.549964499936;7204.3155900189395;7231.927680723125;7250.38371738387;7385.003024591611;7416.666250018654;10571.577136914437;10646.574137034431;10750.784984300426;10797.838032429363;11182.66452006441;3206.7113959743733;9111.954440227757;9234.968306972456;9587;9604.423734575948;9497.14525692691;10018.899811001796;10098.697039088838;10219.284650074424;10353.119984801377;9306.906930930603;9675.661351852652;9738.318317717692;10286.382817030702;10406.58373665045;7219.60292183935;7277.053982982178;7370.63146842645;7387.261273872785;7586.658600362886;4056.9797151014054;7640.961795190989;10080.243981701255;10256;10407.427591482237 23:10:49 INFO - PROCESS | 1030 | |3;mootools.html;1437.9928100359496;1447.1172584723317;1605.5504458751545;1759.9472015839528;1773.6896043192446;7592.27873352032;7778.299953004229;7831.373490120784;7862.174471680477;8016.078151012635;7921;7947.28474437302;7960.442769006172;7965.402594805384;8029;2303.539292141574;2324.32594547581;2332.1021406758437;2333.241696448661;2333.894974726133;2333.708286464192;2355.5877721398774;2362.6456031595226;2363.5391098735668;2371.3715865295712;2260;2309.226409152936;2327.5112226432384;2355.387599224197;2358.8230882683783;2309.4111001694546;2321.303608917318;2328.289871589173;2333.638286065654;2334.708161479815;2355.787979081891;2362.83460157789;2367.8105751539833;2368.301351101429;2368.9052437902465;7948.602569871483;7966.123726390092;8018.318442932357;8027.879581806277;8034.558099304536;4693.319468677057;4772.976135119302;4787.305840653121;4794.424669039738;4813.205821039524;3052.2064263291704;3053.114596766935;3121.2821051158135;3123.6407813101555;3130.718235358806;1000.4147573669412;1028.5371582787775;1040.9427481488515;1044.8537204791335;1062.8086944350014;10957.83563246552;10990.230683852054;11055.889441105566;11056.723581910435;11081.445927703664;4194.496660400771;4223.049813791872;4318.244307246219;4321.135772845443;4390.824367025347;8852.601632926533;8913.465192088495;8917.509536975529;8943.686970955985;8984.910150898539;4835.081334546495;4882.194437917704;4886.65793394459;4910.140725373117;4917.58200552957;4477.306017567283;4497.100579884036;4498.662600304925;4516.119356725473;4519.276915693474;3466.878659246914;3529.4705794131087;3564.518789963374;3566.3580555500257;3574.5174401455993;1023.3041531758475;1046.4663021858908;1056.1603525197486;1070.6680928912062;1078.703356576932;1056.5140035583718;1089.5097206257217;1171.6777886081225;1269.289198049077;1359.136948038003;7115.466340024519;7230.313120253568;7278.927210727931;7287.198408175096;7292;631.2992578238152;640.9679516024273;641.7817941899683;646.3988490703597;782.5304817109688;5656.066748986454;5679.858003549944;5751.022326204556;5761.366249712528;5819.330776960704;9564.426134431957;9838.458884761263;9869.901300986898;9875.209983201326;9929.50352482373;9092.954535227282;9223.76940576491;9231.261499080058;9276.90723092774;9419.717408477756;7462.589557574385;7488.775336739797;7526.6989320427665;7605.049368828896;7669.964554785144;7213.531120477152;7305.744298949511;7315.670794814139;7343.155537113087;7349.30181632744;8327.04239012497;8493.362997775315;8648.567571621268;8685.348598854986;8753.25597324209;8835.20483156519;8936.195742383217;8974.596143173703;9001.099890011208;9122.908770912207;6991.161060672752;7003.124609423822;7110.32451917067;7293.598852063187;7342.632868356454;7639.350655194371;7706.576138312223;7716.92283077162;7717.6141192939;7718.768436946901;6458.418742313214;7090.149182098181;7357.889631655637;7441.888371674538;7473.103227612722;6939.791806245821;6941.618210998444;6995.055667485028;7058.400035996998;7060.152781666233;7024.929750702428;7079.221285658677;7091.361777440055;7091.751788687371;7103.680334385069;6515.413612774873;6539.836504087436;6546.0508226307875;6546.705398256994;6551.6069035858;6426.710798014007;6615.4046135848;6650.301718319701;6682.131322928182;6702.463802895659 23:10:49 INFO - PROCESS | 1030 | |4;prototype.html;332.9816860072695;334.9179451034496;343.2893909607111;343.86245501799283;349.08887802834596;6152.354002829706;6243.71903264353;6261.186045814049;6276.811695649132;6329.398707122816;6073.301570319403;6188.566800323979;6194.442500174983;6204.286507051679;6218.1916350874435;4757.8096876125;4790.9520904791025;4791.760411979404;4798.7840547175465;4811.783469743852;4773.57037866592;4778.808847646107;4791.640626952975;4795.784189711454;4798.472168061528;4624.237000894848;4698;4729.716217026972;4748.8575342739605;4761.976190119045;4730.455997560273;4736.218523943545;4741.19399702048;4754.833580824655;4759.833405830814;4161.958380416218;4187.078842654611;4195.937060944088;4204;4204.831806727727;5938.198343223653;5938.406159384071;5959.791407300767;5960.910586341209;5969.91045134319;5461.863453413656;5538.086215774432;5551.944480555183;5557.444255574451;5586.664800112007;6609.438197753197;6609.702563384659;6617.437517810992;6623.403893649546;6643.701033453458;4651.372064771246;4656.092062047902;4660.766961651904;4662.300654901758;4669.369635099252;6694.866102677968;6913.930860691379;6955.791326260271;6957.686904089328;6967.989641501954;4773.307870358779;4778.211595086841;4779.665423420397;4782.880427989258;4784.755963449528;4835.226363781778;4837.806487740451;4838.104950584153;4840.370751802314;4845.5881250093435;5539.390667026624;5543.445655434505;5546.584006199551;5549.750261238254;5556.944430555724;6563.606183628997;6680.198376194888;6683.465322774166;6686.465082793365;6711.932880671228;1631.9673606527804;1675.798904131512;1683.7137686593308;1687.3756710017371;1700.0649642696467;1079.4117206122683;1101.091599430473;1115.5203262597;1117.804384232756;1122.9831552526718;6238.688065596702;6263.874722505616;6264.467520260738;6281.340459251713;6304.085907543472;6738.764143254963;6768.289329620417;6772.8984065239065;6788.355106264897;6807.931920680829;6135.877282454326;6259.6870156492;6277.7175027123885;6281;6282;3693.390590552529;3696.7412281140064;3704.481372607837;3708.980030491636;3714.275716235308;7103.218645948941;7110.582401983351;7112.324329188718;7125.75059872902;7139.107611548557;6871.518993670495;6882.931170688329;6897.448204143657;6953.965230173817;6955.826104347432;7303.233160518175;7303.817404564928;7311.341979221896;7332.780016599404;7342.302481264272;6951.617661028692;6970.302969702989;6970.477214208853;6974.755883544051;6989.161300643752;6750.527463077734;6877.89683154763;6889.379955804002;6895;6915.89626155598;7290.270972902667;7291.890621640574;7306.59813710251;7313.195548489555;7332.30343117403;4686.6016388605985;4753.429588449269;4762.214234651244;4765.642576806823;4770.880727981828;6836.55562388463;6982.266861979622;6985.720571177096;6988.475864310299;6995.650217489207;6785.1518560179975;6789.15135608049;6796.082528858541;6804.6257455840405;6805.9659701701175;6737.73049078051;6781.982702594453;6785.457163426815;6785.9660701696175;6795.592264464148;6524.902126468011;6596.967015165085;6654;6654.933450665431;6655.068290439439;6799.5920244785475;6829.4877884157895;6829.931700683128;6832.692528836314;6838.589684618939;6617.974213996838;6621.271660117287;6647.169103862017;6661.566998145105;6667.899981500184 23:10:49 INFO - PROCESS | 1030 | |5;yui.html;824.1387749801461;832.9875051874222;836.6778790165785;838.501091850349;874.462205743468;13724.931375343122;13737.519186828464;13794.10338328008;13812.378442970064;13908.582742517729;12600.495980160782;13003.08978371512;13034.240377549051;13044.217346959165;13046.086773925828;777.2266594738215;786.1313248860013;798.9560574168419;802.8314054048627;808.0424696734389;793.821390187209;799.5962039170211;803.3813963248296;814.226484839402;814.3770015937812;833.649867055835;835.7994081420446;837.736113124367;839.8278352937664;842.5702891525304;831.3266254334009;833.3708050421893;834.870595057767;835.4527784301323;842.6713581703141;613.2579578709766;613.2640831002815;615.3231445410058;617.0281806155323;620.1318154583619;12943.288119153443;12996.415161317764;12996.610101696964;13003.154794938393;13375.665608359868;12476.81284780729;12541.811872821914;12548.937255313665;12632.621021369374;13107.344632768323;10640.94679526605;10732.409717465614;10772.138228941665;10805.945970270177;10964.17768667345;3601.8199090045655;3668.944965825515;3682.1346983459134;3684.355237833395;3729.4965179700666;45590.31614525785;45709.857253568596;45940.08119837618;46018.30972535415;46102.077958440976;9545.474998875128;9569.501816553084;9616.08647178517;9768.90231097694;10192.490375481197;16955.660886782196;17588.472345829647;17612.20745066475;17623.647527049387;17628.647427051386;7064.964675176694;7109.253528379446;7114.430845532345;7224.819379515554;7265.382442492447;3988.3219852625125;4131.235721391552;4191.643710284599;4270.572942705705;4272.807723652443;3245.870165193413;3288.7040166384663;3293.045016945059;3298.274379636524;3301.422251106047;565.4006752842;580.4978693430237;587.5035594922284;601.6871226962043;602.3735315272155;548.7942021741846;555.5638823523515;605.1799811255773;631.311870061635;668.5019660353069;8822.602982865787;9151.954240228757;9308.767280818034;9335.626574936927;9493.525323733786;569.291232415637;657.5298661456985;666.3270097201861;678.9660516974131;726.7056841979007;4019.658329042006;4025.7383270087353;4195.349720793282;4232.449781528381;4244.087521182961;59086.704566476896;59959.70020149959;60253;60426.69786651039;60567.69716151479;52093.73953130286;52170.21744673833;52637.47362526326;52922.20616690753;53048.73475632597;45236.773816130706;46438.76780616143;46988.7650561745;48058.519414806105;48064.5193548067;7992.6802927884555;8273.586320683822;8422.789430264293;8449.197326253996;8528.68966063442;33533.16167095842;33694.66305336915;33769;33933.830330849174;34076.14809629779;45491.772541137085;46946.29580556226;47032.52967470281;47286.527134729586;47329;10260.692179234635;10290.485475726035;10329.741756455847;10380.221483388927;10516.316439431412;11173.832392513956;11327.773444530898;11356.716082098013;11383.373914434786;11782.038284632737;10004.449755263531;10260.12788912921;10463.372197667859;10473.9476302618;10494.317869338469;10274.075333220046;10310.43292618913;10472.214583906085;10982.341059536453;11096.44517774092;9832.508374581384;9951.452670103214;10166.745831354276;10225.642102526375;10234.130098941674;8748.077209348534;8933.553322333728;9012.41419307743;9140.542972851197;9209.079092090737;8497.447665901696;8529.87205191935;8774.429662071945;9339.252859771337;9528.475933823705 23:10:49 INFO - PROCESS | 1030 | __end_tp_report 23:10:49 INFO - PROCESS | 1030 | __start_cc_report 23:10:49 INFO - PROCESS | 1030 | _x_x_mozilla_cycle_collect,313 23:10:49 INFO - PROCESS | 1030 | __end_cc_report 23:10:49 INFO - PROCESS | 1030 | __startTimestamp1453360249300__endTimestamp 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | ------- Summary: start ------- 23:10:49 INFO - PROCESS | 1030 | Number of tests: 6 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#0] dojo.html Cycles:165 Average:5335.46 Median:5527.25 stddev:585.43 (10.6%) stddev-sans-first:562.33 23:10:49 INFO - PROCESS | 1030 | Values: 3182.1 3212.9 3232.2 3250.5 3260.6 5183.7 5224.2 5235.7 5305.4 5322.9 5275.0 5290.5 5307.3 5310.9 5352.7 4912.4 4940.3 4962.0 4978.8 4990.6 4936.2 4986.3 5006.8 5021.6 5072.0 4627.1 4794.6 4926.8 4929.4 4932.5 4923.6 4929.6 4931.8 4955.1 4984.8 4809.2 4886.8 4902.2 4904.5 4954.0 5108.4 5170.4 5170.4 5178.9 5205.7 5767.8 5771.1 5778.5 5780.1 5794.1 5680.5 5769.7 5812.4 5815.0 5823.5 5376.8 5428.1 5430.9 5436.5 5476.6 5944.5 5961.7 5970.0 5972.2 5977.9 5535.4 5600.6 5714.5 5734.8 5735.1 5622.0 5687.9 5691.1 5701.1 5753.2 5617.5 5635.6 5664.2 5674.9 5719.7 5581.4 5653.0 5653.9 5720.9 5742.4 4419.6 4421.0 4445.2 4481.5 4531.9 3965.2 3965.8 3983.6 3992.9 4040.3 5229.3 5311.8 5338.2 5378.7 5394.4 5690.6 5730.2 5741.8 5773.6 5805.3 5286.2 5349.6 5356.5 5363.3 5380.7 4846.3 4875.1 4886.9 4900.1 4920.0 5837.9 5914.3 5936.6 5990.7 6018.7 5787.7 5788.4 5821.7 5822.3 5827.8 5820.7 5946.5 6029.7 6032.6 6033.1 5593.5 5623.8 5645.1 5677.1 5729.2 5760.1 5783.1 5816.0 5830.2 5832.7 5433.3 5556.7 5669.4 5681.0 5691.4 5497.3 5552.1 5572.6 5592.4 5633.3 5527.3 5559.3 5564.1 5568.7 5593.1 5462.2 5665.2 5676.9 5722.5 5734.9 5458.6 5478.2 5492.3 5512.3 5564.1 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#1] ext.html Cycles:180 Average:44089.43 Median:34698.83 stddev:73361.88 (211.4%) stddev-sans-first:73494.78 23:10:49 INFO - PROCESS | 1030 | Values: 530.1 555.5 555.5 570.3 576.2 35000.0 35353.8 35492.5 35502.5 35604.6 38973.8 39305.8 39321.6 39447.4 39470.4 8402.9 8584.7 8587.0 8590.8 8597.1 8249.5 8360.4 8417.4 8621.9 8648.4 8609.7 8618.5 8658.7 8676.8 8703.0 8487.2 8586.7 8611.4 8611.8 8621.3 8527.5 8617.7 8623.7 8671.0 8673.2 36961.6 37496.0 37508.4 37528.0 37682.6 3285.4 3301.1 3301.2 3309.6 3401.6 29113.9 29406.6 29518.0 29525.3 29951.3 3846.6 3886.5 3929.1 3998.9 4035.6 264280.0 265590.0 268092.7 269052.0 269901.0 49851.5 50667.0 54184.5 54370.7 54379.7 58503.7 59593.7 59663.0 59736.4 59938.0 13122.0 13404.5 13434.6 13435.5 13443.9 9977.5 10064.7 10082.9 10117.8 10157.0 18252.2 18706.8 18723.8 18730.0 18838.2 7369.7 7665.8 7689.8 7752.5 7752.9 928.3 949.8 1019.5 1031.1 1051.3 24887.8 25170.0 25237.5 28310.0 29291.0 1024.7 1046.6 1122.9 1164.1 1201.8 13479.9 13522.8 13636.7 13737.7 13807.5 319172.0 321378.0 323185.0 323190.0 324219.0 48030.0 48206.3 48222.5 48307.8 48389.8 1344.0 1347.8 1348.5 1350.4 1352.6 26040.6 26970.3 27000.0 27239.6 29710.7 45263.0 45337.3 45668.8 45687.1 45746.3 244683.0 247165.0 247185.0 247632.0 248213.0 30659.8 31046.7 31435.7 31456.5 31456.7 39308.2 39418.8 40048.8 40356.2 40555.4 33278.0 33786.7 34703.0 36982.0 38026.4 33900.0 34527.5 34549.5 35074.8 35201.8 33915.7 34183.1 34315.7 34694.7 34830.0 30768.0 31541.2 31617.7 31933.0 32117.2 24102.0 24298.8 24334.6 24521.0 24814.5 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#2] jquery.html Cycles:180 Average:26012.79 Median:4486.75 stddev:82605.53 (1841.1%) stddev-sans-first:82814.79 23:10:49 INFO - PROCESS | 1030 | Values: 355.0 365.3 367.3 368.7 368.9 15347.8 16705.2 16714.0 17309.0 17909.5 10920.7 11013.7 11466.3 11488.1 11531.4 4820.7 4865.7 5005.1 5026.1 5051.9 4920.3 4993.5 5010.8 5022.3 5022.6 4886.0 4936.3 4994.8 5081.2 5372.0 5034.7 5049.2 5050.7 5061.3 5098.6 5126.2 5144.3 5159.0 5160.7 5180.4 12920.4 15730.5 18679.8 19555.2 19569.7 2090.9 2095.6 2117.4 2150.8 2214.0 9132.8 9359.4 9369.0 9624.7 10953.6 1758.5 1771.6 1926.9 1969.6 2027.3 54114.0 56005.2 56568.7 56998.7 57965.0 10189.0 10193.8 10195.0 10225.4 10277.0 13170.5 13186.5 13265.3 13296.5 13328.7 7054.8 7106.2 7125.3 7193.4 7219.2 6486.7 6626.9 6773.9 6796.5 6797.6 4365.5 4485.3 4488.2 4522.9 4527.0 1785.6 1797.7 1845.4 1868.8 1872.4 824.1 861.0 891.5 1004.7 1066.7 14738.7 14745.3 16111.6 16206.8 16308.2 947.1 947.5 950.5 995.8 1010.5 9368.6 9399.3 9500.5 9596.4 9763.2 484476.0 496053.0 507935.0 508208.0 530028.5 51575.5 70302.3 71385.6 71396.3 71518.0 1089.8 1095.5 1097.4 1114.5 1118.3 14449.7 14660.6 14705.8 14841.2 14958.2 31476.4 32012.4 32186.5 32509.2 32793.8 40379.8 41652.2 41920.2 42013.4 45003.5 7204.3 7231.9 7250.4 7385.0 7416.7 10571.6 10646.6 10750.8 10797.8 11182.7 3206.7 9112.0 9235.0 9587.0 9604.4 9497.1 10018.9 10098.7 10219.3 10353.1 9306.9 9675.7 9738.3 10286.4 10406.6 7219.6 7277.1 7370.6 7387.3 7586.7 4057.0 7641.0 10080.2 10256.0 10407.4 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#3] mootools.html Cycles:180 Average:5548.91 Median:3580.91 stddev:2905.01 (81.1%) stddev-sans-first:2896.72 23:10:49 INFO - PROCESS | 1030 | Values: 1438.0 1447.1 1605.6 1759.9 1773.7 7592.3 7778.3 7831.4 7862.2 8016.1 7921.0 7947.3 7960.4 7965.4 8029.0 2303.5 2324.3 2332.1 2333.2 2333.9 2333.7 2355.6 2362.6 2363.5 2371.4 2260.0 2309.2 2327.5 2355.4 2358.8 2309.4 2321.3 2328.3 2333.6 2334.7 2355.8 2362.8 2367.8 2368.3 2368.9 7948.6 7966.1 8018.3 8027.9 8034.6 4693.3 4773.0 4787.3 4794.4 4813.2 3052.2 3053.1 3121.3 3123.6 3130.7 1000.4 1028.5 1040.9 1044.9 1062.8 10957.8 10990.2 11055.9 11056.7 11081.4 4194.5 4223.0 4318.2 4321.1 4390.8 8852.6 8913.5 8917.5 8943.7 8984.9 4835.1 4882.2 4886.7 4910.1 4917.6 4477.3 4497.1 4498.7 4516.1 4519.3 3466.9 3529.5 3564.5 3566.4 3574.5 1023.3 1046.5 1056.2 1070.7 1078.7 1056.5 1089.5 1171.7 1269.3 1359.1 7115.5 7230.3 7278.9 7287.2 7292.0 631.3 641.0 641.8 646.4 782.5 5656.1 5679.9 5751.0 5761.4 5819.3 9564.4 9838.5 9869.9 9875.2 9929.5 9093.0 9223.8 9231.3 9276.9 9419.7 7462.6 7488.8 7526.7 7605.0 7670.0 7213.5 7305.7 7315.7 7343.2 7349.3 8327.0 8493.4 8648.6 8685.3 8753.3 8835.2 8936.2 8974.6 9001.1 9122.9 6991.2 7003.1 7110.3 7293.6 7342.6 7639.4 7706.6 7716.9 7717.6 7718.8 6458.4 7090.1 7357.9 7441.9 7473.1 6939.8 6941.6 6995.1 7058.4 7060.2 7024.9 7079.2 7091.4 7091.8 7103.7 6515.4 6539.8 6546.1 6546.7 6551.6 6426.7 6615.4 6650.3 6682.1 6702.5 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#4] prototype.html Cycles:180 Average:5587.12 Median:6262.53 stddev:1698.03 (27.1%) stddev-sans-first:1656.36 23:10:49 INFO - PROCESS | 1030 | Values: 333.0 334.9 343.3 343.9 349.1 6152.4 6243.7 6261.2 6276.8 6329.4 6073.3 6188.6 6194.4 6204.3 6218.2 4757.8 4791.0 4791.8 4798.8 4811.8 4773.6 4778.8 4791.6 4795.8 4798.5 4624.2 4698.0 4729.7 4748.9 4762.0 4730.5 4736.2 4741.2 4754.8 4759.8 4162.0 4187.1 4195.9 4204.0 4204.8 5938.2 5938.4 5959.8 5960.9 5969.9 5461.9 5538.1 5551.9 5557.4 5586.7 6609.4 6609.7 6617.4 6623.4 6643.7 4651.4 4656.1 4660.8 4662.3 4669.4 6694.9 6913.9 6955.8 6957.7 6968.0 4773.3 4778.2 4779.7 4782.9 4784.8 4835.2 4837.8 4838.1 4840.4 4845.6 5539.4 5543.4 5546.6 5549.8 5556.9 6563.6 6680.2 6683.5 6686.5 6711.9 1632.0 1675.8 1683.7 1687.4 1700.1 1079.4 1101.1 1115.5 1117.8 1123.0 6238.7 6263.9 6264.5 6281.3 6304.1 6738.8 6768.3 6772.9 6788.4 6807.9 6135.9 6259.7 6277.7 6281.0 6282.0 3693.4 3696.7 3704.5 3709.0 3714.3 7103.2 7110.6 7112.3 7125.8 7139.1 6871.5 6882.9 6897.4 6954.0 6955.8 7303.2 7303.8 7311.3 7332.8 7342.3 6951.6 6970.3 6970.5 6974.8 6989.2 6750.5 6877.9 6889.4 6895.0 6915.9 7290.3 7291.9 7306.6 7313.2 7332.3 4686.6 4753.4 4762.2 4765.6 4770.9 6836.6 6982.3 6985.7 6988.5 6995.7 6785.2 6789.2 6796.1 6804.6 6806.0 6737.7 6782.0 6785.5 6786.0 6795.6 6524.9 6597.0 6654.0 6654.9 6655.1 6799.6 6829.5 6829.9 6832.7 6838.6 6618.0 6621.3 6647.2 6661.6 6667.9 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - PROCESS | 1030 | [#5] yui.html Cycles:180 Average:13718.50 Median:47307.76 stddev:16236.19 (34.3%) stddev-sans-first:16252.87 23:10:49 INFO - PROCESS | 1030 | Values: 824.1 833.0 836.7 838.5 874.5 13724.9 13737.5 13794.1 13812.4 13908.6 12600.5 13003.1 13034.2 13044.2 13046.1 777.2 786.1 799.0 802.8 808.0 793.8 799.6 803.4 814.2 814.4 833.6 835.8 837.7 839.8 842.6 831.3 833.4 834.9 835.5 842.7 613.3 613.3 615.3 617.0 620.1 12943.3 12996.4 12996.6 13003.2 13375.7 12476.8 12541.8 12548.9 12632.6 13107.3 10640.9 10732.4 10772.1 10805.9 10964.2 3601.8 3668.9 3682.1 3684.4 3729.5 45590.3 45709.9 45940.1 46018.3 46102.1 9545.5 9569.5 9616.1 9768.9 10192.5 16955.7 17588.5 17612.2 17623.6 17628.6 7065.0 7109.3 7114.4 7224.8 7265.4 3988.3 4131.2 4191.6 4270.6 4272.8 3245.9 3288.7 3293.0 3298.3 3301.4 565.4 580.5 587.5 601.7 602.4 548.8 555.6 605.2 631.3 668.5 8822.6 9152.0 9308.8 9335.6 9493.5 569.3 657.5 666.3 679.0 726.7 4019.7 4025.7 4195.3 4232.4 4244.1 59086.7 59959.7 60253.0 60426.7 60567.7 52093.7 52170.2 52637.5 52922.2 53048.7 45236.8 46438.8 46988.8 48058.5 48064.5 7992.7 8273.6 8422.8 8449.2 8528.7 33533.2 33694.7 33769.0 33933.8 34076.1 45491.8 46946.3 47032.5 47286.5 47329.0 10260.7 10290.5 10329.7 10380.2 10516.3 11173.8 11327.8 11356.7 11383.4 11782.0 10004.4 10260.1 10463.4 10473.9 10494.3 10274.1 10310.4 10472.2 10982.3 11096.4 9832.5 9951.5 10166.7 10225.6 10234.1 8748.1 8933.6 9012.4 9140.5 9209.1 8497.4 8529.9 8774.4 9339.3 9528.5 23:10:49 INFO - PROCESS | 1030 | -------- Summary: end -------- 23:10:49 INFO - PROCESS | 1030 | 23:10:49 INFO - TEST-INFO | 1030: exit 0 23:10:49 INFO - TEST-OK | dromaeo_css | took 1111089ms 23:10:49 INFO - TEST-START | kraken 23:10:49 INFO - operating with platform_type : linux_ 23:10:49 INFO - Initialising browser for kraken test... 23:10:49 INFO - TEST-INFO | started process 1349 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprSUUFw/profile http://localhost:58626/getInfo.html) 23:10:53 INFO - PROCESS | 1349 | 23:10:53 INFO - PROCESS | 1349 | (process:1421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:54 INFO - PROCESS | 1349 | __metrics Screen width/height:1600/1200 23:10:54 INFO - PROCESS | 1349 | colorDepth:24 23:10:54 INFO - PROCESS | 1349 | Browser inner width/height: 1024/697 23:10:54 INFO - PROCESS | 1349 | __metrics 23:10:54 INFO - PROCESS | 1349 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:55 INFO - TEST-INFO | 1349: exit 0 23:10:55 INFO - Browser initialized. 23:10:55 INFO - Running cycle 1/1 for kraken test... 23:10:55 INFO - TEST-INFO | started process 1471 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprSUUFw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:56 INFO - PROCESS | 1471 | -- checkerboarding starts below -- 23:10:56 INFO - PROCESS | 1471 | RENDERTRACE 0.040706 rect red 0 0 10 10 // viewport 23:10:56 INFO - PROCESS | 1471 | RENDERTRACE 23.8914 rect brown 0 0 10 10 // page 23:10:56 INFO - PROCESS | 1471 | RENDERTRACE 23.9105 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 23:10:56 INFO - PROCESS | 1471 | Checkerboarded for 1 frames (23.9754 ms), 100 peak, 1 severity. 23:10:56 INFO - PROCESS | 1471 | 23:10:56 INFO - PROCESS | 1471 | (process:1530): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:11:07 INFO - PROCESS | 1471 | RSS: Main: 149966848 23:11:07 INFO - PROCESS | 1471 | 23:11:09 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58626/tests/kraken/driver.html?testName=audio-beat-detection) 23:11:10 INFO - PROCESS | 1471 | RSS: Main: 151199744 23:11:10 INFO - PROCESS | 1471 | 23:11:13 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58626/tests/kraken/driver.html?testName=audio-dft) 23:11:13 INFO - PROCESS | 1471 | RSS: Main: 153833472 23:11:13 INFO - PROCESS | 1471 | 23:11:16 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58626/tests/kraken/driver.html?testName=audio-fft) 23:11:17 INFO - PROCESS | 1471 | RSS: Main: 148750336 23:11:17 INFO - PROCESS | 1471 | 23:11:19 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58626/tests/kraken/driver.html?testName=audio-oscillator) 23:11:19 INFO - PROCESS | 1471 | RSS: Main: 147161088 23:11:19 INFO - PROCESS | 1471 | 23:11:22 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:11:22 INFO - PROCESS | 1471 | RSS: Main: 149094400 23:11:22 INFO - PROCESS | 1471 | 23:11:25 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58626/tests/kraken/driver.html?testName=imaging-darkroom) 23:11:26 INFO - PROCESS | 1471 | RSS: Main: 148094976 23:11:26 INFO - PROCESS | 1471 | 23:11:29 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58626/tests/kraken/driver.html?testName=imaging-desaturate) 23:11:30 INFO - PROCESS | 1471 | RSS: Main: 148881408 23:11:30 INFO - PROCESS | 1471 | 23:11:33 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58626/tests/kraken/driver.html?testName=json-parse-financial) 23:11:33 INFO - PROCESS | 1471 | RSS: Main: 149245952 23:11:33 INFO - PROCESS | 1471 | 23:11:35 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:11:35 INFO - PROCESS | 1471 | RSS: Main: 150155264 23:11:35 INFO - PROCESS | 1471 | 23:11:37 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:11:38 INFO - PROCESS | 1471 | RSS: Main: 149573632 23:11:38 INFO - PROCESS | 1471 | 23:11:40 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:11:41 INFO - PROCESS | 1471 | RSS: Main: 149147648 23:11:41 INFO - PROCESS | 1471 | 23:11:43 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:11:44 INFO - PROCESS | 1471 | RSS: Main: 150040576 23:11:44 INFO - PROCESS | 1471 | 23:11:46 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:11:47 INFO - PROCESS | 1471 | RSS: Main: 149733376 23:11:47 INFO - PROCESS | 1471 | 23:11:48 INFO - PROCESS | 1471 | Cycle 1(1): loaded http://localhost:58626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58626/tests/kraken/driver.html?testName=ai-astar) 23:11:49 INFO - PROCESS | 1471 | RSS: Main: 149299200 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | __start_tp_report 23:11:49 INFO - PROCESS | 1471 | _x_x_mozilla_page_load 23:11:49 INFO - PROCESS | 1471 | _x_x_mozilla_page_load_details 23:11:49 INFO - PROCESS | 1471 | |i|pagename|runs| 23:11:49 INFO - PROCESS | 1471 | |0;ai-astar;111;106;111;112;112;123;110;112;111;112 23:11:49 INFO - PROCESS | 1471 | |1;audio-beat-detection;155;125;152;165;127;156;155;132;163;139 23:11:49 INFO - PROCESS | 1471 | |2;audio-dft;163;164;163;164;164;164;162;166;171;161 23:11:49 INFO - PROCESS | 1471 | |3;audio-fft;72;74;76;74;74;74;143;77;74;75 23:11:49 INFO - PROCESS | 1471 | |4;audio-oscillator;96;96;138;96;96;97;146;96;97;138 23:11:49 INFO - PROCESS | 1471 | |5;imaging-gaussian-blur;111;110;109;109;110;109;110;110;110;109 23:11:49 INFO - PROCESS | 1471 | |6;imaging-darkroom;147;147;147;147;146;148;146;147;148;146 23:11:49 INFO - PROCESS | 1471 | |7;imaging-desaturate;98;98;97;99;97;97;96;97;97;97 23:11:49 INFO - PROCESS | 1471 | |8;json-parse-financial;61;62;61;61;61;61;68;63;73;66 23:11:49 INFO - PROCESS | 1471 | |9;json-stringify-tinderbox;68;69;68;68;67;67;66;68;68;67 23:11:49 INFO - PROCESS | 1471 | |10;stanford-crypto-aes;81;82;83;85;82;83;83;92;83;82 23:11:49 INFO - PROCESS | 1471 | |11;stanford-crypto-ccm;116;116;125;117;113;117;123;113;124;130 23:11:49 INFO - PROCESS | 1471 | |12;stanford-crypto-pbkdf2;143;144;141;143;145;138;139;140;143;140 23:11:49 INFO - PROCESS | 1471 | |13;stanford-crypto-sha256-iterative;67;69;73;68;65;67;68;66;67;67 23:11:49 INFO - PROCESS | 1471 | __end_tp_report 23:11:49 INFO - PROCESS | 1471 | __start_cc_report 23:11:49 INFO - PROCESS | 1471 | _x_x_mozilla_cycle_collect,725 23:11:49 INFO - PROCESS | 1471 | __end_cc_report 23:11:49 INFO - PROCESS | 1471 | __startTimestamp1453360309156__endTimestamp 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | ------- Summary: start ------- 23:11:49 INFO - PROCESS | 1471 | Number of tests: 14 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.27 (3.8%) stddev-sans-first:4.51 23:11:49 INFO - PROCESS | 1471 | Values: 111.0 106.0 111.0 112.0 112.0 123.0 110.0 112.0 111.0 112.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:155.00 stddev:14.86 (9.6%) stddev-sans-first:15.47 23:11:49 INFO - PROCESS | 1471 | Values: 155.0 125.0 152.0 165.0 127.0 156.0 155.0 132.0 163.0 139.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.74 (1.7%) stddev-sans-first:2.87 23:11:49 INFO - PROCESS | 1471 | Values: 163.0 164.0 163.0 164.0 164.0 164.0 162.0 166.0 171.0 161.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:21.72 (29.4%) stddev-sans-first:22.78 23:11:49 INFO - PROCESS | 1471 | Values: 72.0 74.0 76.0 74.0 74.0 74.0 143.0 77.0 74.0 75.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.55 (22.5%) stddev-sans-first:22.29 23:11:49 INFO - PROCESS | 1471 | Values: 96.0 96.0 138.0 96.0 96.0 97.0 146.0 96.0 97.0 138.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 23:11:49 INFO - PROCESS | 1471 | Values: 111.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 109.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 23:11:49 INFO - PROCESS | 1471 | Values: 147.0 147.0 147.0 147.0 146.0 148.0 146.0 147.0 148.0 146.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 23:11:49 INFO - PROCESS | 1471 | Values: 98.0 98.0 97.0 99.0 97.0 97.0 96.0 97.0 97.0 97.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:62.50 stddev:4.08 (6.5%) stddev-sans-first:4.21 23:11:49 INFO - PROCESS | 1471 | Values: 61.0 62.0 61.0 61.0 61.0 61.0 68.0 63.0 73.0 66.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 23:11:49 INFO - PROCESS | 1471 | Values: 68.0 69.0 68.0 68.0 67.0 67.0 66.0 68.0 68.0 67.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:3.13 (3.8%) stddev-sans-first:3.18 23:11:49 INFO - PROCESS | 1471 | Values: 81.0 82.0 83.0 85.0 82.0 83.0 83.0 92.0 83.0 82.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:120.00 stddev:5.72 (4.8%) stddev-sans-first:5.93 23:11:49 INFO - PROCESS | 1471 | Values: 116.0 116.0 125.0 117.0 113.0 117.0 123.0 113.0 124.0 130.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.60 Median:143.00 stddev:2.32 (1.6%) stddev-sans-first:2.40 23:11:49 INFO - PROCESS | 1471 | Values: 143.0 144.0 141.0 143.0 145.0 138.0 139.0 140.0 143.0 140.0 23:11:49 INFO - PROCESS | 1471 | 23:11:49 INFO - PROCESS | 1471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.16 (3.2%) stddev-sans-first:2.28 23:11:49 INFO - PROCESS | 1471 | Values: 67.0 69.0 73.0 68.0 65.0 67.0 68.0 66.0 67.0 67.0 23:11:49 INFO - PROCESS | 1471 | -------- Summary: end -------- 23:11:49 INFO - PROCESS | 1471 | 23:11:50 INFO - TEST-INFO | 1471: exit 0 23:11:50 INFO - TEST-OK | kraken | took 60118ms 23:11:50 INFO - TEST-START | v8_7 23:11:50 INFO - operating with platform_type : linux_ 23:11:50 INFO - Initialising browser for v8_7 test... 23:11:50 INFO - TEST-INFO | started process 1759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprsqQ4w/profile http://localhost:58626/getInfo.html) 23:11:53 INFO - PROCESS | 1759 | 23:11:53 INFO - PROCESS | 1759 | (process:1830): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:11:54 INFO - PROCESS | 1759 | __metrics Screen width/height:1600/1200 23:11:54 INFO - PROCESS | 1759 | colorDepth:24 23:11:54 INFO - PROCESS | 1759 | Browser inner width/height: 1024/697 23:11:54 INFO - PROCESS | 1759 | __metrics 23:11:54 INFO - PROCESS | 1759 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:11:55 INFO - TEST-INFO | 1759: exit 0 23:11:55 INFO - Browser initialized. 23:11:55 INFO - Running cycle 1/1 for v8_7 test... 23:11:55 INFO - TEST-INFO | started process 1879 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprsqQ4w/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:56 INFO - PROCESS | 1879 | -- checkerboarding starts below -- 23:11:56 INFO - PROCESS | 1879 | RENDERTRACE 0.030986 rect red 0 0 10 10 // viewport 23:11:56 INFO - PROCESS | 1879 | RENDERTRACE 32.5143 rect brown 0 0 10 10 // page 23:11:56 INFO - PROCESS | 1879 | RENDERTRACE 32.538 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 23:11:56 INFO - PROCESS | 1879 | Checkerboarded for 1 frames (32.5923 ms), 100 peak, 1 severity. 23:11:56 INFO - PROCESS | 1879 | 23:11:56 INFO - PROCESS | 1879 | (process:1938): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:12:07 INFO - PROCESS | 1879 | RSS: Main: 150589440 23:12:07 INFO - PROCESS | 1879 | 23:12:29 INFO - PROCESS | 1879 | Cycle 1(1): loaded http://localhost:58626/tests/v8_7/run.html (next: http://localhost:58626/tests/v8_7/run.html) 23:12:30 INFO - PROCESS | 1879 | RSS: Main: 145391616 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | __start_tp_report 23:12:30 INFO - PROCESS | 1879 | _x_x_mozilla_page_load 23:12:30 INFO - PROCESS | 1879 | _x_x_mozilla_page_load_details 23:12:30 INFO - PROCESS | 1879 | |i|pagename|runs| 23:12:30 INFO - PROCESS | 1879 | |0;Richards;166.11295681063123 23:12:30 INFO - PROCESS | 1879 | |1;DeltaBlue;187.79342723004694 23:12:30 INFO - PROCESS | 1879 | |2;Encrypt;281.928390188892 23:12:30 INFO - PROCESS | 1879 | |3;Decrypt;5240.837696335078 23:12:30 INFO - PROCESS | 1879 | |4;RayTrace;1078.7486515641856 23:12:30 INFO - PROCESS | 1879 | |5;Earley;704.7216349541931 23:12:30 INFO - PROCESS | 1879 | |6;Boyer;12268.292682926829 23:12:30 INFO - PROCESS | 1879 | |7;RegExp;42645.833333333336 23:12:30 INFO - PROCESS | 1879 | |8;Splay;632.9113924050633 23:12:30 INFO - PROCESS | 1879 | |9;NavierStokes;4835.748792270531 23:12:30 INFO - PROCESS | 1879 | __end_tp_report 23:12:30 INFO - PROCESS | 1879 | __startTimestamp1453360350159__endTimestamp 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | ------- Summary: start ------- 23:12:30 INFO - PROCESS | 1879 | Number of tests: 10 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 166.1 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 187.8 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 281.9 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 5240.8 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 1078.7 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 704.7 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 12268.3 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#7] RegExp Cycles:1 Average:42645.83 Median:42645.83 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 42645.8 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#8] Splay Cycles:1 Average:632.91 Median:632.91 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 632.9 23:12:30 INFO - PROCESS | 1879 | 23:12:30 INFO - PROCESS | 1879 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:12:30 INFO - PROCESS | 1879 | Values: 4835.7 23:12:30 INFO - PROCESS | 1879 | -------- Summary: end -------- 23:12:30 INFO - PROCESS | 1879 | 23:12:31 INFO - TEST-INFO | 1879: exit 0 23:12:31 INFO - TEST-OK | v8_7 | took 40980ms 23:12:31 INFO - SUITE-END | took 1212s 23:12:31 INFO - Completed test suite (00:20:12) 23:12:31 INFO - Working with test: dromaeo_css 23:12:31 INFO - Generating results file: dromaeo_css 23:12:31 INFO - Working with test: kraken 23:12:31 INFO - Generating results file: kraken 23:12:31 INFO - javascript benchmark 23:12:31 INFO - Working with test: v8_7 23:12:31 INFO - Generating results file: v8_7 23:12:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:12:31 INFO - process_Request line: dromaeo_css 6858.30 graph.html#tests=[[72,64,43]] 23:12:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:31 INFO - process_Request line: kraken 1511.50 graph.html#tests=[[232,64,43]] 23:12:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:31 INFO - process_Request line: v8_7 20196.12 graph.html#tests=[[230,64,43]] 23:12:31 INFO - RETURN: dromaeo_css: 6858.30 23:12:31 INFO - RETURN: kraken: 1511.50 23:12:31 INFO - RETURN: v8_7: 20196.12 23:12:31 INFO - javascript benchmark 23:12:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3182.1090094773463, 3212.8714851405944, 3232.2404235004783, 3250.463673493873, 3260.576125103736, 5183.688978661283, 5224.2163675448655, 5235.7120358380325, 5305.416404195545, 5322.92015619766, 5275.024120537693, 5290.470952904717, 5307.2569840222395, 5310.92033619496, 5352.678839269646, 4912.435069966964, 4940.283658869462, 4962.007598480301, 4978.775955082012, 4990.6007519398545, 4936.160852655039, 4986.326845875797, 5006.824761133361, 5021.623378246628, 5071.974640126794, 4627.097715945375, 4794.640401969848, 4926.802927882881, 4929.433115191763, 4932.482089380635, 4923.58149557288, 4929.556339929388, 4931.7780699868235, 4955.058538877602, 4984.82553110643, 4809.2305231162845, 4886.780094895703, 4902.2156454967035, 4904.509549045067, 4954.0, 5108.386993560759, 5170.353705786777, 5170.405403378584, 5178.948210517884, 5205.6616319939085, 5767.826965191051, 5771.076627739583, 5778.451047150514, 5780.104083867007, 5794.101914203306, 5680.488756011938, 5769.711514424262, 5812.360640329561, 5815.040518314473, 5823.53411727065, 5376.758045887945, 5428.104362780097, 5430.864228394283, 5436.483534064297, 5476.561875049986, 5944.464998150187, 5961.672108034013, 5970.044792833126, 5972.193753843262, 5977.940220597825, 5535.418781028015, 5600.551955843523, 5714.457126572969, 5734.827955161351, 5735.082386818172, 5622.044252477089, 5687.914681279784, 5691.089425691869, 5701.116326969326, 5753.223314852525, 5617.466340697627, 5635.5773317001385, 5664.178694089334, 5674.914876276859, 5719.742611582489, 5581.441855814386, 5653.038983372754, 5653.943460565424, 5720.885582288331, 5742.425757424224, 4419.624331931822, 4421.049474363027, 4445.199864024442, 4481.529439408815, 4531.909361812745, 3965.2466031453932, 3965.7818819965178, 3983.5817239190046, 3992.86024989124, 4040.313146765057, 5229.267902493654, 5311.787528498817, 5338.172583249602, 5378.7041712705395, 5394.352677678625, 5690.601657883908, 5730.169125476783, 5741.827745167651, 5773.566982476247, 5805.303363596396, 5286.1806420004195, 5349.5720342372515, 5356.517913387814, 5363.275957745733, 5380.677159370451, 4846.321514987904, 4875.07373599015, 4886.902261954741, 4900.142475066849, 4919.950800492021, 5837.854053648693, 5914.260717410324, 5936.614120082181, 5990.6705131218205, 6018.6990650467305, 5787.739551720267, 5788.392218817132, 5821.679807610622, 5822.301323840997, 5827.76688932438, 5820.73806678692, 5946.464818166386, 6029.668368239789, 6032.638041717511, 6033.12519684652, 5593.468620481048, 5623.803166889303, 5645.096784514458, 5677.120046392815, 5729.169270455677, 5760.107183386582, 5783.103618939072, 5815.9709201453725, 5830.154627579062, 5832.679202643895, 5433.266509021231, 5556.72216389187, 5669.4047125051275, 5681.0, 5691.430856914276, 5497.312835895513, 5552.056150454352, 5572.60991730575, 5592.440755924375, 5633.295838020247, 5527.2538207341495, 5559.27729395176, 5564.137558678412, 5568.721563921868, 5593.07714227148, 5462.20797984298, 5665.178549110438, 5676.914846277226, 5722.542196624343, 5734.913976290442, 5458.645188062763, 5478.178273259043, 5492.340919089735, 5512.310961129859, 5564.10974244119], "unit": "score", "name": "dojo.html", "value": 5298.117347284875}, {"lowerIsBetter": false, "replicates": [530.1226470191834, 555.4501043966474, 555.525026102682, 570.3469527391137, 576.2105914896591, 35000.0, 35353.82323088387, 35492.46761298583, 35502.46746298801, 35604.64395356046, 38973.805130974375, 39305.8034709826, 39321.606783932155, 39447.40828887562, 39470.40794388086, 8402.873956890651, 8584.656613735444, 8587.0, 8590.785230369229, 8597.054324024351, 8249.515087284286, 8360.372972027091, 8417.410781245315, 8621.870671939925, 8648.35137364697, 8609.655613775441, 8618.525981071038, 8658.740237792876, 8676.826463470758, 8703.0, 8487.151284871525, 8586.699465518677, 8611.397202195849, 8611.827763444759, 8621.31029517637, 8527.488350698977, 8617.65529378824, 8623.698170564063, 8670.959484861794, 8673.219410253045, 36961.63038369609, 37496.0, 37508.43737343942, 37528.0, 37682.62317376819, 3285.4250506161325, 3301.1087006508346, 3301.240714635623, 3309.5697559317377, 3401.557797486336, 29113.85443072771, 29406.558901616492, 29518.0, 29525.261868453246, 29951.251218719488, 3846.6345697159004, 3886.514185726784, 3929.096307849211, 3998.900027499307, 4035.59644035597, 264280.0, 265590.0, 268092.659536703, 269052.0, 269901.0, 49851.50148498541, 50667.0, 54184.45815541794, 54370.72814635901, 54379.72810135924, 58503.70748146232, 59593.70203148956, 59663.0, 59736.402635973085, 59938.0, 13122.0, 13404.530841420503, 13434.596962091153, 13435.462581496826, 13443.86556134426, 9977.501124943723, 10064.748381290527, 10082.949585252027, 10117.848232276521, 10157.0, 18252.178651960694, 18706.81293187078, 18723.812761872206, 18730.0, 18838.24647014104, 7369.668364923591, 7665.770026899202, 7689.846203075907, 7752.496087754278, 7752.922470775333, 928.3176865004217, 949.8147861167006, 1019.4647809899861, 1031.097789434245, 1051.321897376188, 24887.751122488906, 25170.0, 25237.495250094897, 28310.0, 29291.0, 1024.7335692719946, 1046.576136664652, 1122.9438528073563, 1164.0861923390266, 1201.765655697148, 13479.86520134786, 13522.797158042637, 13636.727265454834, 13737.725245495234, 13807.51673691416, 319172.0, 321378.0, 323185.0, 323190.0, 324219.0, 48030.0, 48206.27690584644, 48222.5177748225, 48307.75846120747, 48389.75805121022, 1343.9987209528963, 1347.8045683376051, 1348.534755509328, 1350.4328182163515, 1352.6280272925023, 26040.60939085877, 26970.32574185661, 27000.0, 27239.59140612853, 29710.702892971658, 45263.0, 45337.31994020158, 45668.77165614151, 45687.08625827531, 45746.31380529361, 244683.0, 247165.0, 247185.0, 247632.0, 248213.0, 30659.846700766353, 31046.689533105284, 31435.685643143275, 31456.528152078194, 31456.685433146293, 39308.2138357237, 39418.802905985285, 40048.79975600103, 40356.1928761429, 40555.39166912558, 33278.00331980089, 33786.662133378355, 34703.0, 36982.0, 38026.429603555414, 33900.0, 34527.4820877682, 34549.48175777315, 35074.82462587671, 35201.82399087988, 33915.66084339125, 34183.145421364665, 34315.65684343124, 34694.65305346914, 34830.0, 30768.0, 31541.21146971252, 31617.683823161475, 31933.0, 32117.1970700725, 24102.0, 24298.75701242965, 24334.63498047495, 24521.0, 24814.503709926063], "unit": "score", "name": "ext.html", "value": 17720.725257116665}, {"lowerIsBetter": false, "replicates": [354.9520814690016, 365.2876890064374, 367.329623437227, 368.69582594359645, 368.9299033183693, 15347.846521534795, 16705.164741762925, 16714.0, 17309.0, 17909.462716118538, 10920.672379828598, 11013.724656883582, 11466.254693444942, 11488.13838962077, 11531.423428828566, 4820.662553621248, 4865.708057516543, 5005.074061298653, 5026.070177017245, 5051.924221136667, 4920.3357546731095, 4993.500649934996, 5010.849674509753, 5022.321986531826, 5022.573081288095, 4885.9511404886025, 4936.30891675164, 4994.775235114428, 5081.212412076134, 5372.0330340538685, 5034.748262586856, 5049.242613607951, 5050.747462626854, 5061.266116413118, 5098.643094983334, 5126.154184559543, 5144.279800827887, 5158.97420512895, 5160.664556803796, 5180.430152683201, 12920.353982300941, 15730.528084157493, 18679.813201867943, 19555.217791288473, 19569.706454403196, 2090.874547527153, 2095.6227878981776, 2117.4494631395796, 2150.7956744109283, 2214.0368939511363, 9132.817343653156, 9359.438433694, 9369.016253293374, 9624.663136790248, 10953.561857525689, 1758.4900378890234, 1771.5748220427133, 1926.8651194416395, 1969.6060787842346, 2027.28031548801, 54114.0, 56005.15992260079, 56568.717156414365, 56998.71500642512, 57965.0, 10189.0, 10193.847092293474, 10194.980501949745, 10225.43760093202, 10277.0, 13170.539031133865, 13186.472541098441, 13265.336733163304, 13296.534621288209, 13328.733425331438, 7054.788356349318, 7106.182788979334, 7125.3230943060325, 7193.352598266181, 7219.241979592172, 6486.67566621667, 6626.9337306627285, 6773.9322606774285, 6796.52424330302, 6797.626130562768, 4365.454318210223, 4485.304777759453, 4488.192125417456, 4522.932156017662, 4526.95473045272, 1785.5982403959006, 1797.6764182447284, 1845.3817970979603, 1868.8131186881476, 1872.3914727713548, 824.1428913929566, 861.0356400831109, 891.4740303221131, 1004.7186787699455, 1066.7493139112303, 14738.705225895423, 14745.336459859333, 16111.597210069842, 16206.75689864653, 16308.184590770414, 947.1097168661436, 947.4978261521404, 950.5437390052813, 995.8356871116184, 1010.4796030044533, 9368.578413971387, 9399.295052871063, 9500.477473738873, 9596.376235544667, 9763.218942484584, 484476.0, 496053.0, 507935.0, 508208.0, 530028.5481443694, 51575.484245157815, 70302.2969770306, 71385.64307178535, 71396.28603714, 71518.0, 1089.809283375406, 1095.4686976816079, 1097.4074000040048, 1114.4817659788237, 1118.2619471149003, 14449.688049911963, 14660.56018319452, 14705.779413308595, 14841.183734894685, 14958.177300248592, 31476.37047259088, 32012.359752805278, 32186.517202242452, 32509.18727031843, 32793.83603082065, 40379.798101009306, 41652.16695666009, 41920.16159676851, 42013.36979945364, 45003.549964499936, 7204.3155900189395, 7231.927680723125, 7250.38371738387, 7385.003024591611, 7416.666250018654, 10571.577136914437, 10646.574137034431, 10750.784984300426, 10797.838032429363, 11182.66452006441, 3206.7113959743733, 9111.954440227757, 9234.968306972456, 9587.0, 9604.423734575948, 9497.14525692691, 10018.899811001796, 10098.697039088838, 10219.284650074424, 10353.119984801377, 9306.906930930603, 9675.661351852652, 9738.318317717692, 10286.382817030702, 10406.58373665045, 7219.60292183935, 7277.053982982178, 7370.63146842645, 7387.261273872785, 7586.658600362886, 4056.9797151014054, 7640.961795190989, 10080.243981701255, 10256.0, 10407.427591482237], "unit": "score", "name": "jquery.html", "value": 7874.748229801572}, {"lowerIsBetter": false, "replicates": [1437.9928100359496, 1447.1172584723317, 1605.5504458751545, 1759.9472015839528, 1773.6896043192446, 7592.27873352032, 7778.299953004229, 7831.373490120784, 7862.174471680477, 8016.078151012635, 7921.0, 7947.28474437302, 7960.442769006172, 7965.402594805384, 8029.0, 2303.539292141574, 2324.32594547581, 2332.1021406758437, 2333.241696448661, 2333.894974726133, 2333.708286464192, 2355.5877721398774, 2362.6456031595226, 2363.5391098735668, 2371.3715865295712, 2260.0, 2309.226409152936, 2327.5112226432384, 2355.387599224197, 2358.8230882683783, 2309.4111001694546, 2321.303608917318, 2328.289871589173, 2333.638286065654, 2334.708161479815, 2355.787979081891, 2362.83460157789, 2367.8105751539833, 2368.301351101429, 2368.9052437902465, 7948.602569871483, 7966.123726390092, 8018.318442932357, 8027.879581806277, 8034.558099304536, 4693.319468677057, 4772.976135119302, 4787.305840653121, 4794.424669039738, 4813.205821039524, 3052.2064263291704, 3053.114596766935, 3121.2821051158135, 3123.6407813101555, 3130.718235358806, 1000.4147573669412, 1028.5371582787775, 1040.9427481488515, 1044.8537204791335, 1062.8086944350014, 10957.83563246552, 10990.230683852054, 11055.889441105566, 11056.723581910435, 11081.445927703664, 4194.496660400771, 4223.049813791872, 4318.244307246219, 4321.135772845443, 4390.824367025347, 8852.601632926533, 8913.465192088495, 8917.509536975529, 8943.686970955985, 8984.910150898539, 4835.081334546495, 4882.194437917704, 4886.65793394459, 4910.140725373117, 4917.58200552957, 4477.306017567283, 4497.100579884036, 4498.662600304925, 4516.119356725473, 4519.276915693474, 3466.878659246914, 3529.4705794131087, 3564.518789963374, 3566.3580555500257, 3574.5174401455993, 1023.3041531758475, 1046.4663021858908, 1056.1603525197486, 1070.6680928912062, 1078.703356576932, 1056.5140035583718, 1089.5097206257217, 1171.6777886081225, 1269.289198049077, 1359.136948038003, 7115.466340024519, 7230.313120253568, 7278.927210727931, 7287.198408175096, 7292.0, 631.2992578238152, 640.9679516024273, 641.7817941899683, 646.3988490703597, 782.5304817109688, 5656.066748986454, 5679.858003549944, 5751.022326204556, 5761.366249712528, 5819.330776960704, 9564.426134431957, 9838.458884761263, 9869.901300986898, 9875.209983201326, 9929.50352482373, 9092.954535227282, 9223.76940576491, 9231.261499080058, 9276.90723092774, 9419.717408477756, 7462.589557574385, 7488.775336739797, 7526.6989320427665, 7605.049368828896, 7669.964554785144, 7213.531120477152, 7305.744298949511, 7315.670794814139, 7343.155537113087, 7349.30181632744, 8327.04239012497, 8493.362997775315, 8648.567571621268, 8685.348598854986, 8753.25597324209, 8835.20483156519, 8936.195742383217, 8974.596143173703, 9001.099890011208, 9122.908770912207, 6991.161060672752, 7003.124609423822, 7110.32451917067, 7293.598852063187, 7342.632868356454, 7639.350655194371, 7706.576138312223, 7716.92283077162, 7717.6141192939, 7718.768436946901, 6458.418742313214, 7090.149182098181, 7357.889631655637, 7441.888371674538, 7473.103227612722, 6939.791806245821, 6941.618210998444, 6995.055667485028, 7058.400035996998, 7060.152781666233, 7024.929750702428, 7079.221285658677, 7091.361777440055, 7091.751788687371, 7103.680334385069, 6515.413612774873, 6539.836504087436, 6546.0508226307875, 6546.705398256994, 6551.6069035858, 6426.710798014007, 6615.4046135848, 6650.301718319701, 6682.131322928182, 6702.463802895659], "unit": "score", "name": "mootools.html", "value": 4497.119442154835}, {"lowerIsBetter": false, "replicates": [332.9816860072695, 334.9179451034496, 343.2893909607111, 343.86245501799283, 349.08887802834596, 6152.354002829706, 6243.71903264353, 6261.186045814049, 6276.811695649132, 6329.398707122816, 6073.301570319403, 6188.566800323979, 6194.442500174983, 6204.286507051679, 6218.1916350874435, 4757.8096876125, 4790.9520904791025, 4791.760411979404, 4798.7840547175465, 4811.783469743852, 4773.57037866592, 4778.808847646107, 4791.640626952975, 4795.784189711454, 4798.472168061528, 4624.237000894848, 4698.0, 4729.716217026972, 4748.8575342739605, 4761.976190119045, 4730.455997560273, 4736.218523943545, 4741.19399702048, 4754.833580824655, 4759.833405830814, 4161.958380416218, 4187.078842654611, 4195.937060944088, 4204.0, 4204.831806727727, 5938.198343223653, 5938.406159384071, 5959.791407300767, 5960.910586341209, 5969.91045134319, 5461.863453413656, 5538.086215774432, 5551.944480555183, 5557.444255574451, 5586.664800112007, 6609.438197753197, 6609.702563384659, 6617.437517810992, 6623.403893649546, 6643.701033453458, 4651.372064771246, 4656.092062047902, 4660.766961651904, 4662.300654901758, 4669.369635099252, 6694.866102677968, 6913.930860691379, 6955.791326260271, 6957.686904089328, 6967.989641501954, 4773.307870358779, 4778.211595086841, 4779.665423420397, 4782.880427989258, 4784.755963449528, 4835.226363781778, 4837.806487740451, 4838.104950584153, 4840.370751802314, 4845.5881250093435, 5539.390667026624, 5543.445655434505, 5546.584006199551, 5549.750261238254, 5556.944430555724, 6563.606183628997, 6680.198376194888, 6683.465322774166, 6686.465082793365, 6711.932880671228, 1631.9673606527804, 1675.798904131512, 1683.7137686593308, 1687.3756710017371, 1700.0649642696467, 1079.4117206122683, 1101.091599430473, 1115.5203262597, 1117.804384232756, 1122.9831552526718, 6238.688065596702, 6263.874722505616, 6264.467520260738, 6281.340459251713, 6304.085907543472, 6738.764143254963, 6768.289329620417, 6772.8984065239065, 6788.355106264897, 6807.931920680829, 6135.877282454326, 6259.6870156492, 6277.7175027123885, 6281.0, 6282.0, 3693.390590552529, 3696.7412281140064, 3704.481372607837, 3708.980030491636, 3714.275716235308, 7103.218645948941, 7110.582401983351, 7112.324329188718, 7125.75059872902, 7139.107611548557, 6871.518993670495, 6882.931170688329, 6897.448204143657, 6953.965230173817, 6955.826104347432, 7303.233160518175, 7303.817404564928, 7311.341979221896, 7332.780016599404, 7342.302481264272, 6951.617661028692, 6970.302969702989, 6970.477214208853, 6974.755883544051, 6989.161300643752, 6750.527463077734, 6877.89683154763, 6889.379955804002, 6895.0, 6915.89626155598, 7290.270972902667, 7291.890621640574, 7306.59813710251, 7313.195548489555, 7332.30343117403, 4686.6016388605985, 4753.429588449269, 4762.214234651244, 4765.642576806823, 4770.880727981828, 6836.55562388463, 6982.266861979622, 6985.720571177096, 6988.475864310299, 6995.650217489207, 6785.1518560179975, 6789.15135608049, 6796.082528858541, 6804.6257455840405, 6805.9659701701175, 6737.73049078051, 6781.982702594453, 6785.457163426815, 6785.9660701696175, 6795.592264464148, 6524.902126468011, 6596.967015165085, 6654.0, 6654.933450665431, 6655.068290439439, 6799.5920244785475, 6829.4877884157895, 6829.931700683128, 6832.692528836314, 6838.589684618939, 6617.974213996838, 6621.271660117287, 6647.169103862017, 6661.566998145105, 6667.899981500184], "unit": "score", "name": "prototype.html", "value": 5028.509956095302}, {"lowerIsBetter": false, "replicates": [824.1387749801461, 832.9875051874222, 836.6778790165785, 838.501091850349, 874.462205743468, 13724.931375343122, 13737.519186828464, 13794.10338328008, 13812.378442970064, 13908.582742517729, 12600.495980160782, 13003.08978371512, 13034.240377549051, 13044.217346959165, 13046.086773925828, 777.2266594738215, 786.1313248860013, 798.9560574168419, 802.8314054048627, 808.0424696734389, 793.821390187209, 799.5962039170211, 803.3813963248296, 814.226484839402, 814.3770015937812, 833.649867055835, 835.7994081420446, 837.736113124367, 839.8278352937664, 842.5702891525304, 831.3266254334009, 833.3708050421893, 834.870595057767, 835.4527784301323, 842.6713581703141, 613.2579578709766, 613.2640831002815, 615.3231445410058, 617.0281806155323, 620.1318154583619, 12943.288119153443, 12996.415161317764, 12996.610101696964, 13003.154794938393, 13375.665608359868, 12476.81284780729, 12541.811872821914, 12548.937255313665, 12632.621021369374, 13107.344632768323, 10640.94679526605, 10732.409717465614, 10772.138228941665, 10805.945970270177, 10964.17768667345, 3601.8199090045655, 3668.944965825515, 3682.1346983459134, 3684.355237833395, 3729.4965179700666, 45590.31614525785, 45709.857253568596, 45940.08119837618, 46018.30972535415, 46102.077958440976, 9545.474998875128, 9569.501816553084, 9616.08647178517, 9768.90231097694, 10192.490375481197, 16955.660886782196, 17588.472345829647, 17612.20745066475, 17623.647527049387, 17628.647427051386, 7064.964675176694, 7109.253528379446, 7114.430845532345, 7224.819379515554, 7265.382442492447, 3988.3219852625125, 4131.235721391552, 4191.643710284599, 4270.572942705705, 4272.807723652443, 3245.870165193413, 3288.7040166384663, 3293.045016945059, 3298.274379636524, 3301.422251106047, 565.4006752842, 580.4978693430237, 587.5035594922284, 601.6871226962043, 602.3735315272155, 548.7942021741846, 555.5638823523515, 605.1799811255773, 631.311870061635, 668.5019660353069, 8822.602982865787, 9151.954240228757, 9308.767280818034, 9335.626574936927, 9493.525323733786, 569.291232415637, 657.5298661456985, 666.3270097201861, 678.9660516974131, 726.7056841979007, 4019.658329042006, 4025.7383270087353, 4195.349720793282, 4232.449781528381, 4244.087521182961, 59086.704566476896, 59959.70020149959, 60253.0, 60426.69786651039, 60567.69716151479, 52093.73953130286, 52170.21744673833, 52637.47362526326, 52922.20616690753, 53048.73475632597, 45236.773816130706, 46438.76780616143, 46988.7650561745, 48058.519414806105, 48064.5193548067, 7992.6802927884555, 8273.586320683822, 8422.789430264293, 8449.197326253996, 8528.68966063442, 33533.16167095842, 33694.66305336915, 33769.0, 33933.830330849174, 34076.14809629779, 45491.772541137085, 46946.29580556226, 47032.52967470281, 47286.527134729586, 47329.0, 10260.692179234635, 10290.485475726035, 10329.741756455847, 10380.221483388927, 10516.316439431412, 11173.832392513956, 11327.773444530898, 11356.716082098013, 11383.373914434786, 11782.038284632737, 10004.449755263531, 10260.12788912921, 10463.372197667859, 10473.9476302618, 10494.317869338469, 10274.075333220046, 10310.43292618913, 10472.214583906085, 10982.341059536453, 11096.44517774092, 9832.508374581384, 9951.452670103214, 10166.745831354276, 10225.642102526375, 10234.130098941674, 8748.077209348534, 8933.553322333728, 9012.41419307743, 9140.542972851197, 9209.079092090737, 8497.447665901696, 8529.87205191935, 8774.429662071945, 9339.252859771337, 9528.475933823705], "unit": "score", "name": "yui.html", "value": 6223.722534481443}], "name": "dromaeo_css", "value": 6858.297966944824}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 112.0, 112.0, 123.0, 110.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [155.0, 125.0, 152.0, 165.0, 127.0, 156.0, 155.0, 132.0, 163.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 164.0, 164.0, 162.0, 166.0, 171.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 76.0, 74.0, 74.0, 74.0, 143.0, 77.0, 74.0, 75.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 96.0, 96.0, 97.0, 146.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 97.0, 99.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 68.0, 63.0, 73.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 63.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 66.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 85.0, 82.0, 83.0, 83.0, 92.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 125.0, 117.0, 113.0, 117.0, 123.0, 113.0, 124.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 141.0, 143.0, 145.0, 138.0, 139.0, 140.0, 143.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 73.0, 68.0, 65.0, 67.0, 68.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1511.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [281.928390188892], "unit": "score", "name": "Encrypt", "value": 944.1440070000003}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [42645.833333333336], "unit": "score", "name": "RegExp", "value": 21.361641426477778}, {"lowerIsBetter": false, "replicates": [632.9113924050633], "unit": "score", "name": "Splay", "value": 128.75577999999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20196.11890504166}]} 23:12:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20196.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1511.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6858.30"}}} 23:12:31 INFO - Return code: 0 23:12:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:12:31 INFO - # TBPL SUCCESS # 23:12:31 INFO - Running post-action listener: _resource_record_post_action 23:12:31 INFO - Running post-run listener: _resource_record_post_run 23:12:32 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550248448; Read time: 204; Write time: 475540 23:12:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237109248; Read time: 0; Write time: 257320 23:12:32 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313139200; Read time: 204; Write time: 218220 23:12:32 INFO - Running post-run listener: _upload_blobber_files 23:12:32 INFO - Blob upload gear active. 23:12:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:12:32 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:12:32 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'] 23:12:32 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 23:12:32 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:33 INFO - (blobuploader) - INFO - Done attempting. 23:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:34 INFO - (blobuploader) - INFO - Done attempting. 23:12:34 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:34 INFO - Return code: 0 23:12:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:12:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60ba7197676da5de0b9d5b99b62fb8eb7239a76b927dfee788b8765a151e0fa41f74a2639cf7015c3c9d5a5fca7e2957d0fc1ba87672af32c8165886436813b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/061b9e1f45a74282e56949cbad0149371ffeb3fbd411c001e24b47092f8bdbfec8038ce1fb21db0a34663596f45b00a9f5dddf79ebb5d6d98ee3ab702896e27b"} 23:12:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:12:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:12:34 INFO - Contents: 23:12:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60ba7197676da5de0b9d5b99b62fb8eb7239a76b927dfee788b8765a151e0fa41f74a2639cf7015c3c9d5a5fca7e2957d0fc1ba87672af32c8165886436813b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/061b9e1f45a74282e56949cbad0149371ffeb3fbd411c001e24b47092f8bdbfec8038ce1fb21db0a34663596f45b00a9f5dddf79ebb5d6d98ee3ab702896e27b"} 23:12:34 INFO - Running post-run listener: copy_logs_to_upload_dir 23:12:34 INFO - Copying logs to upload dir... 23:12:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:12:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.802451 ========= master_lag: 0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-20 23:12:34.891197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 23:12:34.900081) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60ba7197676da5de0b9d5b99b62fb8eb7239a76b927dfee788b8765a151e0fa41f74a2639cf7015c3c9d5a5fca7e2957d0fc1ba87672af32c8165886436813b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/061b9e1f45a74282e56949cbad0149371ffeb3fbd411c001e24b47092f8bdbfec8038ce1fb21db0a34663596f45b00a9f5dddf79ebb5d6d98ee3ab702896e27b"} build_url:https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/BrJ30WcIRs-0sM_jh6DAtA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/60ba7197676da5de0b9d5b99b62fb8eb7239a76b927dfee788b8765a151e0fa41f74a2639cf7015c3c9d5a5fca7e2957d0fc1ba87672af32c8165886436813b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/061b9e1f45a74282e56949cbad0149371ffeb3fbd411c001e24b47092f8bdbfec8038ce1fb21db0a34663596f45b00a9f5dddf79ebb5d6d98ee3ab702896e27b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 23:12:34.925364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 23:12:34.928761) ========= 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=574dc5aafe09851ec43d388c000001b6-1453358573.795126-661022344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003211 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 23:12:34.976226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 23:12:34.976535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 23:12:34.979944) ========= ========= Total master_lag: 1.03 =========