builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1453329898.57 results: success (0) buildid: 20160120113019 builduid: 71eb64bdb67341a8babe3ea79e9c0005 revision: 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.571030) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.572044) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.572694) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004454 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.591952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.592489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.606141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.606684) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004711 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.658131) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.658870) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.659605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.659913) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-20 14:44:59-- 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% 40.3M=0s 2016-01-20 14:44:59 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156420 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.832035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.832618) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015433 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 14:44:58.884792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 14:44:58.885539) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 --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 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 --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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-20 14:44:59,719 truncating revision to first 12 chars 2016-01-20 14:44:59,719 Setting DEBUG logging. 2016-01-20 14:44:59,719 attempt 1/10 2016-01-20 14:44:59,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/63eb0ddd1cdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-20 14:45:00,535 unpacking tar archive at: fx-team-63eb0ddd1cdb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.133775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-20 14:45:00.033817) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.034248) ========= echo 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234'] 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 program finished with exit code 0 elapsedTime=0.004221 script_repo_revision: '63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.086917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.087255) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.098157) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.098484) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-20 14:45:00.098924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-20 14:45:00.099271) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:45:01 INFO - MultiFileLogger online at 20160120 14:45:01 in /builds/slave/test-pgo 14:45:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:45:01 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:45:01 INFO - {'append_to_log': False, 14:45:01 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:45:01 INFO - 'blob_upload_branch': 'Fx-Team', 14:45:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:45:01 INFO - 'branch': 'Fx-Team', 14:45:01 INFO - 'buildbot_json_path': 'buildprops.json', 14:45:01 INFO - 'config_files': ('talos/linux_config.py',), 14:45:01 INFO - 'default_actions': ('clobber', 14:45:01 INFO - 'read-buildbot-config', 14:45:01 INFO - 'download-and-extract', 14:45:01 INFO - 'populate-webroot', 14:45:01 INFO - 'create-virtualenv', 14:45:01 INFO - 'install', 14:45:01 INFO - 'run-tests'), 14:45:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:45:01 INFO - 'download_minidump_stackwalk': True, 14:45:01 INFO - 'download_symbols': 'ondemand', 14:45:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:45:01 INFO - 'tooltool.py': '/tools/tooltool.py', 14:45:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:45:01 INFO - '/tools/misc-python/virtualenv.py')}, 14:45:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:45:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:45:01 INFO - 'installer_path': 'installer.exe', 14:45:01 INFO - 'log_level': 'info', 14:45:01 INFO - 'log_name': 'talos', 14:45:01 INFO - 'log_to_console': True, 14:45:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:45:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:45:01 INFO - 'opt_config_files': (), 14:45:01 INFO - 'pip_index': False, 14:45:01 INFO - 'sps_profile': False, 14:45:01 INFO - 'sps_profile_interval': 0, 14:45:01 INFO - 'suite': 'dromaeojs', 14:45:01 INFO - 'system_bits': '32', 14:45:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:45:01 INFO - 'title': 'talos-linux64-ix-058', 14:45:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:45:01 INFO - 'use_talos_json': True, 14:45:01 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:45:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:45:01 INFO - 'work_dir': 'build'} 14:45:01 INFO - ##### 14:45:01 INFO - ##### Running clobber step. 14:45:01 INFO - ##### 14:45:01 INFO - Running pre-action listener: _resource_record_pre_action 14:45:01 INFO - Running main action method: clobber 14:45:01 INFO - rmtree: /builds/slave/test-pgo/build 14:45:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:45:01 INFO - Running post-action listener: _resource_record_post_action 14:45:01 INFO - ##### 14:45:01 INFO - ##### Running read-buildbot-config step. 14:45:01 INFO - ##### 14:45:01 INFO - Running pre-action listener: _resource_record_pre_action 14:45:01 INFO - Running main action method: read_buildbot_config 14:45:01 INFO - Using buildbot properties: 14:45:01 INFO - { 14:45:01 INFO - "project": "", 14:45:01 INFO - "product": "firefox", 14:45:01 INFO - "script_repo_revision": "production", 14:45:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:45:01 INFO - "repository": "", 14:45:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:45:01 INFO - "buildid": "20160120113019", 14:45:01 INFO - "pgo_build": "True", 14:45:01 INFO - "basedir": "/builds/slave/test-pgo", 14:45:01 INFO - "buildnumber": 902, 14:45:01 INFO - "slavename": "talos-linux64-ix-058", 14:45:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:45:01 INFO - "platform": "ubuntu64_hw", 14:45:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:45:01 INFO - "branch": "fx-team", 14:45:01 INFO - "repo_path": "integration/fx-team", 14:45:01 INFO - "revision": "63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234", 14:45:01 INFO - "stage_platform": "linux64-pgo", 14:45:01 INFO - "builduid": "71eb64bdb67341a8babe3ea79e9c0005", 14:45:01 INFO - "slavebuilddir": "test" 14:45:01 INFO - } 14:45:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:45:01 INFO - Running post-action listener: _resource_record_post_action 14:45:01 INFO - ##### 14:45:01 INFO - ##### Running download-and-extract step. 14:45:01 INFO - ##### 14:45:01 INFO - Running pre-action listener: _resource_record_pre_action 14:45:01 INFO - Running main action method: download_and_extract 14:45:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:01 INFO - https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/test_packages.json 14:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/test_packages.json 14:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:45:02 INFO - Downloaded 1448 bytes. 14:45:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:45:02 INFO - Using the following test package requirements: 14:45:02 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:02 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:45:02 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:45:02 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'jsshell-linux-x86_64.zip'], 14:45:02 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:45:02 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:02 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:45:02 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:45:02 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:45:02 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:45:02 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:45:02 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:45:02 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:45:02 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')]} 14:45:02 INFO - https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:03 INFO - Downloaded 22485865 bytes. 14:45:03 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'] 14:45:03 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 14:45:05 INFO - Return code: 0 14:45:05 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 14:45:05 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')]} 14:45:05 INFO - https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:06 INFO - Downloaded 22485865 bytes. 14:45:06 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'] 14:45:06 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 14:45:07 INFO - Return code: 0 14:45:07 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')]} 14:45:07 INFO - https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:45:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:45:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:08 INFO - Downloaded 11132144 bytes. 14:45:08 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'] 14:45:08 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 14:45:08 INFO - Return code: 0 14:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:08 INFO - https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rs9pT6FCQFSuLg1JuCwulw/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 14:45:10 INFO - Downloaded 55946971 bytes. 14:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:45:10 INFO - mkdir: /builds/slave/test-pgo/properties 14:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:45:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:45:10 INFO - Contents: 14:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:45:10 INFO - Running post-action listener: _resource_record_post_action 14:45:10 INFO - Running post-action listener: set_extra_try_arguments 14:45:10 INFO - ##### 14:45:10 INFO - ##### Running populate-webroot step. 14:45:10 INFO - ##### 14:45:10 INFO - Running pre-action listener: _resource_record_pre_action 14:45:10 INFO - Running main action method: populate_webroot 14:45:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:45:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:45:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:45:10 INFO - '--tppagecycles', 14:45:10 INFO - '7'], 14:45:10 INFO - 'tests': ['tsvgm']}}, 14:45:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:45:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:45:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:45:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:45:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:45:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'tests': ['damp', 'tps']}, 14:45:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['damp', 'tps']}, 14:45:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:45:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:45:10 INFO - 'other': {'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'other_l64': {'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'other_nol64': {'tests': ['a11yr', 14:45:10 INFO - 'ts_paint', 14:45:10 INFO - 'tpaint', 14:45:10 INFO - 'sessionrestore', 14:45:10 INFO - 'sessionrestore_no_auto_restore']}, 14:45:10 INFO - 'svgr': {'tests': ['tsvgx', 14:45:10 INFO - 'tsvgr_opacity', 14:45:10 INFO - 'tart', 14:45:10 INFO - 'tscrollx', 14:45:10 INFO - 'cart']}, 14:45:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['tsvgx', 14:45:10 INFO - 'tsvgr_opacity', 14:45:10 INFO - 'tart', 14:45:10 INFO - 'tscrollx', 14:45:10 INFO - 'cart']}, 14:45:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'tests': ['tp5o']}, 14:45:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'talos_options': ['--e10s'], 14:45:10 INFO - 'tests': ['tp5o']}, 14:45:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'talos_options': ['--xperf_path', 14:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:10 INFO - 'tests': ['tp5n']}, 14:45:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:45:10 INFO - 'talos_options': ['--e10s', 14:45:10 INFO - '--xperf_path', 14:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:45:10 INFO - 'tests': ['tp5n']}}, 14:45:10 INFO - 'talos.zip': {'path': '', 14:45:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:45:10 INFO - Running post-action listener: _resource_record_post_action 14:45:10 INFO - ##### 14:45:10 INFO - ##### Running create-virtualenv step. 14:45:10 INFO - ##### 14:45:10 INFO - Running pre-action listener: _resource_record_pre_action 14:45:10 INFO - Running main action method: create_virtualenv 14:45:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:45:10 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 14:45:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:45:10 INFO - Using real prefix '/usr' 14:45:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 14:45:12 INFO - Installing pip.................done. 14:45:12 INFO - Return code: 0 14:45:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:12 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:12 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 14:45:12 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 14:45:12 INFO - Using env: {'DISPLAY': ':0', 14:45:12 INFO - 'HOME': '/home/cltbld', 14:45:12 INFO - 'LANG': 'en_US.UTF-8', 14:45:12 INFO - 'LANGUAGE': 'en_US:en', 14:45:12 INFO - 'LOGNAME': 'cltbld', 14:45:12 INFO - 'MAIL': '/var/mail/cltbld', 14:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:12 INFO - 'MOZ_NO_REMOTE': '1', 14:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:12 INFO - 'NO_EM_RESTART': '1', 14:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:12 INFO - 'SHELL': '/bin/bash', 14:45:12 INFO - 'SHLVL': '1', 14:45:12 INFO - 'TERM': 'linux', 14:45:12 INFO - 'TMOUT': '86400', 14:45:12 INFO - 'USER': 'cltbld', 14:45:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:12 INFO - '_': '/tools/buildbot/bin/python'} 14:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:13 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 14:45:13 INFO - Cleaning up... 14:45:13 INFO - Return code: 0 14:45:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:13 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:13 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 14:45:13 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 14:45:13 INFO - Using env: {'DISPLAY': ':0', 14:45:13 INFO - 'HOME': '/home/cltbld', 14:45:13 INFO - 'LANG': 'en_US.UTF-8', 14:45:13 INFO - 'LANGUAGE': 'en_US:en', 14:45:13 INFO - 'LOGNAME': 'cltbld', 14:45:13 INFO - 'MAIL': '/var/mail/cltbld', 14:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:13 INFO - 'MOZ_NO_REMOTE': '1', 14:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:13 INFO - 'NO_EM_RESTART': '1', 14:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:13 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:13 INFO - 'SHELL': '/bin/bash', 14:45:13 INFO - 'SHLVL': '1', 14:45:13 INFO - 'TERM': 'linux', 14:45:13 INFO - 'TMOUT': '86400', 14:45:13 INFO - 'USER': 'cltbld', 14:45:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:13 INFO - '_': '/tools/buildbot/bin/python'} 14:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:13 INFO - Downloading/unpacking psutil>=0.7.1 14:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:15 INFO - Installing collected packages: psutil 14:45:15 INFO - Running setup.py install for psutil 14:45:15 INFO - building 'psutil._psutil_linux' extension 14:45:15 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 14:45:15 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 14:45:15 INFO - building 'psutil._psutil_posix' extension 14:45:15 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 14:45:15 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 14:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:45:15 INFO - Successfully installed psutil 14:45:15 INFO - Cleaning up... 14:45:15 INFO - Return code: 0 14:45:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:45:15 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')]} 14:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:15 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')]} 14:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:15 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:15 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 14:45:15 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 14:45:15 INFO - Using env: {'DISPLAY': ':0', 14:45:15 INFO - 'HOME': '/home/cltbld', 14:45:15 INFO - 'LANG': 'en_US.UTF-8', 14:45:15 INFO - 'LANGUAGE': 'en_US:en', 14:45:15 INFO - 'LOGNAME': 'cltbld', 14:45:15 INFO - 'MAIL': '/var/mail/cltbld', 14:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:15 INFO - 'MOZ_NO_REMOTE': '1', 14:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:15 INFO - 'NO_EM_RESTART': '1', 14:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:15 INFO - 'SHELL': '/bin/bash', 14:45:15 INFO - 'SHLVL': '1', 14:45:15 INFO - 'TERM': 'linux', 14:45:15 INFO - 'TMOUT': '86400', 14:45:15 INFO - 'USER': 'cltbld', 14:45:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:15 INFO - '_': '/tools/buildbot/bin/python'} 14:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:45:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:45:17 INFO - Installing collected packages: mozsystemmonitor 14:45:17 INFO - Running setup.py install for mozsystemmonitor 14:45:17 INFO - Successfully installed mozsystemmonitor 14:45:17 INFO - Cleaning up... 14:45:17 INFO - Return code: 0 14:45:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:45: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')]} 14:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:17 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:17 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 14:45:17 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 14:45:17 INFO - Using env: {'DISPLAY': ':0', 14:45:17 INFO - 'HOME': '/home/cltbld', 14:45:17 INFO - 'LANG': 'en_US.UTF-8', 14:45:17 INFO - 'LANGUAGE': 'en_US:en', 14:45:17 INFO - 'LOGNAME': 'cltbld', 14:45:17 INFO - 'MAIL': '/var/mail/cltbld', 14:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:17 INFO - 'MOZ_NO_REMOTE': '1', 14:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:17 INFO - 'NO_EM_RESTART': '1', 14:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:17 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:17 INFO - 'SHELL': '/bin/bash', 14:45:17 INFO - 'SHLVL': '1', 14:45:17 INFO - 'TERM': 'linux', 14:45:17 INFO - 'TMOUT': '86400', 14:45:17 INFO - 'USER': 'cltbld', 14:45:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:17 INFO - '_': '/tools/buildbot/bin/python'} 14:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 14:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:19 INFO - Downloading blobuploader-1.2.4.tar.gz 14:45:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:45:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:45:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:20 INFO - Downloading docopt-0.6.1.tar.gz 14:45:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:45:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:45:20 INFO - Running setup.py install for blobuploader 14:45:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:45:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:45:20 INFO - Running setup.py install for requests 14:45:21 INFO - Running setup.py install for docopt 14:45:21 INFO - Successfully installed blobuploader requests docopt 14:45:21 INFO - Cleaning up... 14:45:21 INFO - Return code: 0 14:45:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:45:21 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')]} 14:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:21 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')]} 14:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:21 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:21 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 14:45:21 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 14:45:21 INFO - Using env: {'DISPLAY': ':0', 14:45:21 INFO - 'HOME': '/home/cltbld', 14:45:21 INFO - 'LANG': 'en_US.UTF-8', 14:45:21 INFO - 'LANGUAGE': 'en_US:en', 14:45:21 INFO - 'LOGNAME': 'cltbld', 14:45:21 INFO - 'MAIL': '/var/mail/cltbld', 14:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:21 INFO - 'MOZ_NO_REMOTE': '1', 14:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:21 INFO - 'NO_EM_RESTART': '1', 14:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:21 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:21 INFO - 'SHELL': '/bin/bash', 14:45:21 INFO - 'SHLVL': '1', 14:45:21 INFO - 'TERM': 'linux', 14:45:21 INFO - 'TMOUT': '86400', 14:45:21 INFO - 'USER': 'cltbld', 14:45:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:21 INFO - '_': '/tools/buildbot/bin/python'} 14:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:45:21 INFO - Running setup.py (path:/tmp/pip-gm0ZKR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:45:21 INFO - Running setup.py (path:/tmp/pip-OPosCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:45:21 INFO - Running setup.py (path:/tmp/pip-vPkHH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:45:21 INFO - Running setup.py (path:/tmp/pip-pOjYcF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:45:21 INFO - Running setup.py (path:/tmp/pip-jCP_xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:45:21 INFO - Running setup.py (path:/tmp/pip-6GtOwm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:45:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:45:21 INFO - Running setup.py (path:/tmp/pip-poSXIw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:45:22 INFO - Running setup.py (path:/tmp/pip-GwUKwX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:45:22 INFO - Running setup.py (path:/tmp/pip-wwOb48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:45:22 INFO - Running setup.py (path:/tmp/pip-2CFxbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:45:22 INFO - Running setup.py (path:/tmp/pip-oaf0wm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:45:22 INFO - Running setup.py (path:/tmp/pip-tSIyoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:45:22 INFO - Running setup.py (path:/tmp/pip-DOgn06-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:45:22 INFO - Running setup.py (path:/tmp/pip-DwG34U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:45:22 INFO - Running setup.py (path:/tmp/pip-mnzkQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:45:22 INFO - Running setup.py (path:/tmp/pip-HYuxCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:45:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:45:22 INFO - Running setup.py (path:/tmp/pip-lA65KF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:45:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:45:22 INFO - Running setup.py install for manifestparser 14:45:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:45:22 INFO - Running setup.py install for mozcrash 14:45:22 INFO - Running setup.py install for mozdebug 14:45:23 INFO - Running setup.py install for mozdevice 14:45:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for mozfile 14:45:23 INFO - Running setup.py install for mozhttpd 14:45:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for mozinfo 14:45:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for mozInstall 14:45:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for mozleak 14:45:23 INFO - Running setup.py install for mozlog 14:45:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for moznetwork 14:45:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:45:23 INFO - Running setup.py install for mozprocess 14:45:23 INFO - Running setup.py install for mozprofile 14:45:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:45:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:45:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:45:24 INFO - Running setup.py install for mozrunner 14:45:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:45:24 INFO - Running setup.py install for mozscreenshot 14:45:24 INFO - Running setup.py install for moztest 14:45:24 INFO - Running setup.py install for mozversion 14:45:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:45:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:45:24 INFO - Cleaning up... 14:45:24 INFO - Return code: 0 14:45:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:45:24 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')]} 14:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:24 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')]} 14:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:24 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:24 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 14:45:24 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 14:45:24 INFO - Using env: {'DISPLAY': ':0', 14:45:24 INFO - 'HOME': '/home/cltbld', 14:45:24 INFO - 'LANG': 'en_US.UTF-8', 14:45:24 INFO - 'LANGUAGE': 'en_US:en', 14:45:24 INFO - 'LOGNAME': 'cltbld', 14:45:24 INFO - 'MAIL': '/var/mail/cltbld', 14:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:24 INFO - 'MOZ_NO_REMOTE': '1', 14:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:24 INFO - 'NO_EM_RESTART': '1', 14:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:24 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:24 INFO - 'SHELL': '/bin/bash', 14:45:24 INFO - 'SHLVL': '1', 14:45:24 INFO - 'TERM': 'linux', 14:45:24 INFO - 'TMOUT': '86400', 14:45:24 INFO - 'USER': 'cltbld', 14:45:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:24 INFO - '_': '/tools/buildbot/bin/python'} 14:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:45:24 INFO - Running setup.py (path:/tmp/pip-QZGfdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:45:24 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)) 14:45:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:45:24 INFO - Running setup.py (path:/tmp/pip-GawiYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:45:24 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)) 14:45:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:45:24 INFO - Running setup.py (path:/tmp/pip-PJhu5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:45:24 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)) 14:45:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:45:24 INFO - Running setup.py (path:/tmp/pip-jVt5ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:45:25 INFO - Running setup.py (path:/tmp/pip-HdM6_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:45:25 INFO - Running setup.py (path:/tmp/pip-m1Uoa3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:45:25 INFO - Running setup.py (path:/tmp/pip-EB0vWw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:45:25 INFO - Running setup.py (path:/tmp/pip-V2SUQa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:45:25 INFO - Running setup.py (path:/tmp/pip-VVgox0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:45:25 INFO - Running setup.py (path:/tmp/pip-He4R2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:45:25 INFO - Running setup.py (path:/tmp/pip-IqVfCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:45:25 INFO - Running setup.py (path:/tmp/pip-OFpL4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:45:25 INFO - Running setup.py (path:/tmp/pip-PRNgoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:45:25 INFO - Running setup.py (path:/tmp/pip-Zpnqip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:45:25 INFO - Running setup.py (path:/tmp/pip-gkqWMi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:45:25 INFO - Running setup.py (path:/tmp/pip-hv5nQr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:45:25 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)) 14:45:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:45:25 INFO - Running setup.py (path:/tmp/pip-9m2PQp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:45:25 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)) 14:45:25 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)) 14:45:25 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)) 14:45:25 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)) 14:45:25 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)) 14:45:25 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)) 14:45:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:27 INFO - Downloading blessings-1.6.tar.gz 14:45:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:45:27 INFO - Installing collected packages: blessings 14:45:27 INFO - Running setup.py install for blessings 14:45:27 INFO - Successfully installed blessings 14:45:27 INFO - Cleaning up... 14:45:27 INFO - Return code: 0 14:45:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:45:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:45:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:45:28 INFO - Reading from file tmpfile_stdout 14:45:28 INFO - Current package versions: 14:45:28 INFO - argparse == 1.2.1 14:45:28 INFO - blessings == 1.6 14:45:28 INFO - blobuploader == 1.2.4 14:45:28 INFO - docopt == 0.6.1 14:45:28 INFO - manifestparser == 1.1 14:45:28 INFO - mozInstall == 1.12 14:45:28 INFO - mozcrash == 0.16 14:45:28 INFO - mozdebug == 0.1 14:45:28 INFO - mozdevice == 0.48 14:45:28 INFO - mozfile == 1.2 14:45:28 INFO - mozhttpd == 0.7 14:45:28 INFO - mozinfo == 0.9 14:45:28 INFO - mozleak == 0.1 14:45:28 INFO - mozlog == 3.1 14:45:28 INFO - moznetwork == 0.27 14:45:28 INFO - mozprocess == 0.22 14:45:28 INFO - mozprofile == 0.28 14:45:28 INFO - mozrunner == 6.11 14:45:28 INFO - mozscreenshot == 0.1 14:45:28 INFO - mozsystemmonitor == 0.0 14:45:28 INFO - moztest == 0.7 14:45:28 INFO - mozversion == 1.4 14:45:28 INFO - psutil == 3.1.1 14:45:28 INFO - requests == 1.2.3 14:45:28 INFO - wsgiref == 0.1.2 14:45:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:28 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 14:45:28 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 14:45:28 INFO - Using env: {'DISPLAY': ':0', 14:45:28 INFO - 'HOME': '/home/cltbld', 14:45:28 INFO - 'LANG': 'en_US.UTF-8', 14:45:28 INFO - 'LANGUAGE': 'en_US:en', 14:45:28 INFO - 'LOGNAME': 'cltbld', 14:45:28 INFO - 'MAIL': '/var/mail/cltbld', 14:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:28 INFO - 'MOZ_NO_REMOTE': '1', 14:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:28 INFO - 'NO_EM_RESTART': '1', 14:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:28 INFO - 'SHELL': '/bin/bash', 14:45:28 INFO - 'SHLVL': '1', 14:45:28 INFO - 'TERM': 'linux', 14:45:28 INFO - 'TMOUT': '86400', 14:45:28 INFO - 'USER': 'cltbld', 14:45:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:28 INFO - '_': '/tools/buildbot/bin/python'} 14:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 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)) 14:45:28 INFO - Cleaning up... 14:45:28 INFO - Return code: 0 14:45:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:28 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:28 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 14:45:28 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 14:45:28 INFO - Using env: {'DISPLAY': ':0', 14:45:28 INFO - 'HOME': '/home/cltbld', 14:45:28 INFO - 'LANG': 'en_US.UTF-8', 14:45:28 INFO - 'LANGUAGE': 'en_US:en', 14:45:28 INFO - 'LOGNAME': 'cltbld', 14:45:28 INFO - 'MAIL': '/var/mail/cltbld', 14:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:28 INFO - 'MOZ_NO_REMOTE': '1', 14:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:28 INFO - 'NO_EM_RESTART': '1', 14:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:28 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:28 INFO - 'SHELL': '/bin/bash', 14:45:28 INFO - 'SHLVL': '1', 14:45:28 INFO - 'TERM': 'linux', 14:45:28 INFO - 'TMOUT': '86400', 14:45:28 INFO - 'USER': 'cltbld', 14:45:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:28 INFO - '_': '/tools/buildbot/bin/python'} 14:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:28 INFO - Downloading/unpacking jsonschema 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:45:30 INFO - Downloading/unpacking functools32 (from jsonschema) 14:45:30 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 14:45:30 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 14:45:30 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 14:45:30 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 14:45:30 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 14:45:30 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 14:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:45:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:45:30 INFO - warning: no files found matching '*.txt' 14:45:30 INFO - no previously-included directories found matching 'build' 14:45:30 INFO - no previously-included directories found matching 'dist' 14:45:30 INFO - no previously-included directories found matching '.git*' 14:45:30 INFO - Installing collected packages: jsonschema, functools32 14:45:30 INFO - Running setup.py install for functools32 14:45:30 INFO - warning: no files found matching '*.txt' 14:45:30 INFO - no previously-included directories found matching 'build' 14:45:30 INFO - no previously-included directories found matching 'dist' 14:45:30 INFO - no previously-included directories found matching '.git*' 14:45:30 INFO - Successfully installed jsonschema functools32 14:45:30 INFO - Cleaning up... 14:45:30 INFO - Return code: 0 14:45:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:45: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')]} 14:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45: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')]} 14:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:45:30 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 0x7f0b932d9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, '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': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', '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 14:45:30 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 14:45:30 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 14:45:30 INFO - Using env: {'DISPLAY': ':0', 14:45:30 INFO - 'HOME': '/home/cltbld', 14:45:30 INFO - 'LANG': 'en_US.UTF-8', 14:45:30 INFO - 'LANGUAGE': 'en_US:en', 14:45:30 INFO - 'LOGNAME': 'cltbld', 14:45:30 INFO - 'MAIL': '/var/mail/cltbld', 14:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:30 INFO - 'MOZ_NO_REMOTE': '1', 14:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:30 INFO - 'NO_EM_RESTART': '1', 14:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:30 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:30 INFO - 'SHELL': '/bin/bash', 14:45:30 INFO - 'SHLVL': '1', 14:45:30 INFO - 'TERM': 'linux', 14:45:30 INFO - 'TMOUT': '86400', 14:45:30 INFO - 'USER': 'cltbld', 14:45:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:30 INFO - '_': '/tools/buildbot/bin/python'} 14:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:45:31 INFO - Downloading/unpacking flake8 14:45:31 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 14:45:31 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 14:45:31 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 14:45:31 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 14:45:31 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 14:45:31 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 14:45:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:45:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:45:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:32 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 14:45:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 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 14:45:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:33 INFO - no previously-included directories found matching 'docs/_build' 14:45:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:45:33 INFO - Running setup.py install for pep8 14:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:45:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:45:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:45:33 INFO - no previously-included directories found matching 'docs/_build' 14:45:33 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:45:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:45:33 INFO - Cleaning up... 14:45:33 INFO - Return code: 0 14:45:33 INFO - Running post-action listener: _resource_record_post_action 14:45:33 INFO - Running post-action listener: _start_resource_monitoring 14:45:33 INFO - Starting resource monitoring. 14:45:33 INFO - ##### 14:45:33 INFO - ##### Running install step. 14:45:33 INFO - ##### 14:45:33 INFO - Running pre-action listener: _resource_record_pre_action 14:45:33 INFO - Running main action method: install 14:45:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:45:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:45:33 INFO - Reading from file tmpfile_stdout 14:45:33 INFO - Detecting whether we're running mozinstall >=1.0... 14:45:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:45:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:45:34 INFO - Reading from file tmpfile_stdout 14:45:34 INFO - Output received: 14:45:34 INFO - Usage: mozinstall [options] installer 14:45:34 INFO - Options: 14:45:34 INFO - -h, --help show this help message and exit 14:45:34 INFO - -d DEST, --destination=DEST 14:45:34 INFO - Directory to install application into. [default: 14:45:34 INFO - "/builds/slave/test-pgo"] 14:45:34 INFO - --app=APP Application being installed. [default: firefox] 14:45:34 INFO - mkdir: /builds/slave/test-pgo/build/application 14:45:34 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'] 14:45:34 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 14:45:50 INFO - Reading from file tmpfile_stdout 14:45:50 INFO - Output received: 14:45:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:45:50 INFO - Running post-action listener: _resource_record_post_action 14:45:50 INFO - ##### 14:45:50 INFO - ##### Running run-tests step. 14:45:50 INFO - ##### 14:45:50 INFO - Running pre-action listener: _resource_record_pre_action 14:45:50 INFO - Running main action method: run_tests 14:45:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:45:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:45:50 INFO - Python 2.7.3 14:45:50 INFO - Return code: 0 14:45:50 INFO - grabbing minidump binary from tooltool 14:45:50 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')]} 14:45:50 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 0x1391840>, '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 0x12fe6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12feb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:45:50 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 14:45:50 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 14:45:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:45:50 INFO - Return code: 0 14:45:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:45:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:45:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:45:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:45:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:45:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:45:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:45:51 INFO - Return code: 0 14:45:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 14:45:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 14:45:51 INFO - Using env: {'DISPLAY': ':0', 14:45:51 INFO - 'HOME': '/home/cltbld', 14:45:51 INFO - 'LANG': 'en_US.UTF-8', 14:45:51 INFO - 'LANGUAGE': 'en_US:en', 14:45:51 INFO - 'LOGNAME': 'cltbld', 14:45:51 INFO - 'MAIL': '/var/mail/cltbld', 14:45:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:45:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:51 INFO - 'MOZ_NO_REMOTE': '1', 14:45:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:45:51 INFO - 'NO_EM_RESTART': '1', 14:45:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:45:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:45:51 INFO - 'SHELL': '/bin/bash', 14:45:51 INFO - 'SHLVL': '1', 14:45:51 INFO - 'TERM': 'linux', 14:45:51 INFO - 'TMOUT': '86400', 14:45:51 INFO - 'USER': 'cltbld', 14:45:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170', 14:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:51 INFO - '_': '/tools/buildbot/bin/python'} 14:45:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:45:51 INFO - mozversion application_buildid: 20160120113019 14:45:51 INFO - mozversion application_changeset: 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 14:45:51 INFO - mozversion application_display_name: Nightly 14:45:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:45:51 INFO - mozversion application_name: Firefox 14:45:51 INFO - mozversion application_remotingname: firefox 14:45:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:45:51 INFO - mozversion application_vendor: Mozilla 14:45:51 INFO - mozversion application_version: 46.0a1 14:45:51 INFO - mozversion platform_buildid: 20160120113019 14:45:51 INFO - mozversion platform_changeset: 63eb0ddd1cdbe82b4fdfd1c7bf9be38a95bc5234 14:45:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:45:51 INFO - mozversion platform_version: 46.0a1 14:45:51 INFO - using testdate: 1453329951 14:45:51 INFO - actual date: 1453329951 14:45:51 INFO - starting webserver on 'localhost:45229' 14:45:51 INFO - SUITE-START | Running 3 tests 14:45:51 INFO - TEST-START | dromaeo_css 14:45:51 INFO - operating with platform_type : linux_ 14:45:51 INFO - Initialising browser for dromaeo_css test... 14:45:51 INFO - TEST-INFO | started process 2864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdWSGO1/profile http://localhost:45229/getInfo.html) 14:45:55 INFO - PROCESS | 2864 | __metrics Screen width/height:1600/1200 14:45:55 INFO - PROCESS | 2864 | colorDepth:24 14:45:55 INFO - PROCESS | 2864 | Browser inner width/height: 1024/697 14:45:55 INFO - PROCESS | 2864 | __metrics 14:45:55 INFO - PROCESS | 2864 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:45:55 INFO - PROCESS | 2864 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:45:56 INFO - TEST-INFO | 2864: exit 0 14:45:56 INFO - Browser initialized. 14:45:56 INFO - Running cycle 1/1 for dromaeo_css test... 14:45:56 INFO - TEST-INFO | started process 2967 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdWSGO1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:08 INFO - PROCESS | 2967 | RSS: Main: 148987904 14:46:08 INFO - PROCESS | 2967 | 14:46:59 INFO - PROCESS | 2967 | 1453330019471 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] 14:49:07 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45229/tests/dromaeo/cssquery-ext.html) 14:49:08 INFO - PROCESS | 2967 | RSS: Main: 244092928 14:49:08 INFO - PROCESS | 2967 | 14:52:11 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-ext.html (next: http://localhost:45229/tests/dromaeo/cssquery-jquery.html) 14:52:11 INFO - PROCESS | 2967 | RSS: Main: 223055872 14:52:11 INFO - PROCESS | 2967 | 14:55:13 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45229/tests/dromaeo/cssquery-mootools.html) 14:55:14 INFO - PROCESS | 2967 | RSS: Main: 223850496 14:55:14 INFO - PROCESS | 2967 | 14:58:16 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45229/tests/dromaeo/cssquery-prototype.html) 14:58:16 INFO - PROCESS | 2967 | RSS: Main: 200835072 14:58:16 INFO - PROCESS | 2967 | 15:01:19 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45229/tests/dromaeo/cssquery-yui.html) 15:01:19 INFO - PROCESS | 2967 | RSS: Main: 209682432 15:01:19 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | Cycle 1(1): loaded http://localhost:45229/tests/dromaeo/cssquery-yui.html (next: http://localhost:45229/tests/dromaeo/cssquery-dojo.html) 15:04:22 INFO - PROCESS | 2967 | RSS: Main: 253775872 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | __start_tp_report 15:04:22 INFO - PROCESS | 2967 | _x_x_mozilla_page_load 15:04:22 INFO - PROCESS | 2967 | _x_x_mozilla_page_load_details 15:04:22 INFO - PROCESS | 2967 | |i|pagename|runs| 15:04:22 INFO - PROCESS | 2967 | |0;dojo.html;3013.3822566373897;3015.5175171972483;3052.9847350763243;3062.6937306269374;3067.6625571187174;4742;4809.326694262806;4886.48691887352;4905.215165573509;4940;4719.976400117995;4823.252395878644;4839.443464001641;4841.636877234213;4846.9030619387595;4279.700420970534;4435.179491794012;4515.683902126844;4525.886852828673;4580.541945805426;4433;4501.932471012921;4507.4365704286965;4544.091181763644;4576.931346029813;4435.600795928366;4456.64346852251;4464.464264288274;4494.438195225581;4503.1218912312115;4433.933490997638;4488.618467430272;4490.775461226958;4512.390827238313;4552.362669226311;4425.181341451842;4467.955320446787;4475.664325175625;4480.14877173336;4482.484514280867;4661.953380466186;4663.836765713218;4672.15901137795;4683.7892294846815;4708.128996135726;5207.401148867891;5228.738563071869;5231.476852314776;5234.842954711365;5288.471152884719;5231.136862417697;5255.632105752599;5260.658057226268;5263.368395792491;5287.206918962148;4858.82994095205;4922.33548470959;4936.679115857458;4945.851624451272;4972.776225069881;5327.680339179662;5330.067238233371;5367.731613419313;5375.247465354853;5381.0852155133725;5126.384833819965;5131.230315452637;5139.511746384088;5139.8458046258675;5198.298229739013;5174.6377753557645;5176.327077479904;5208.374995000624;5229.973850130801;5253.9211911820585;5182.818601348935;5198.662086964335;5210.166373380241;5211.2443695663915;5216.530512253916;5178.922316165261;5179.989901969156;5185.974070129625;5187.04039752647;5236.083685355047;4037.1320166163828;4104.856330028435;4106.589341065869;4107.9178416431505;4111.116110036357;3722.032271609347;3735.701143908481;3759.586445490994;3775.7923314217433;3780.3006443807985;4875.853724388274;4899.902001960012;4900.828471003498;4908.042931628298;4953.157963146274;5178.042062218502;5191.714455704897;5194.68831870089;5200.92198617021;5242.947570524246;4724.456687480915;4853.296272040534;4870.488598697157;4878.243872199815;4880.731559764176;4525.570070843265;4526.615237704832;4544.341070544752;4571.085782843445;4575.862724118282;5392.946070539323;5396.568274538027;5397.271368365299;5397.8380648580605;5398.1362981923485;5150.562202212704;5210.713410762444;5213.791448342024;5229.398619158846;5254.894902102013;5301.761420735999;5316.973415132899;5323.920141197963;5344.946550534445;5417.241586178017;5155.252488389087;5159.561437277874;5163.6127290454115;5165.147750621106;5202.375714914235;5179.22311653255;5221.765020574007;5234.084035293732;5251.159814429673;5303.4696530346655;5094.337736094284;5110.105731497048;5112.258722485293;5113.795448182031;5117.002184573972;5108.872278192926;5110.48895110486;5122.257272695364;5123.743812809419;5160.535551800356;4960.627952903619;4985.8005679772405;5018.04657115147;5051.873703157304;5098.719570423514;5094.337736094284;5114.693118412907;5118.641695081308;5118.948810511847;5133.486651334837;4952.900941981068;5033.697978121324;5035;5038.445770965264;5044.167712327425 15:04:22 INFO - PROCESS | 2967 | |1;ext.html;563.67588636534;564.0889962710224;568.5622071005326;578.1068249554436;578.7771707892462;29201.853990730044;29788.851055744744;34691.95924122277;34776;34912.476312855324;37770.62229377705;38167.427488587695;38172.42741358882;38202.23595528088;38217.235655286946;8491.872621910676;8766.824663506726;8786.472811631322;8788.34087443441;8791.868121978176;8420.957895210515;8538.786530336729;8540.78648033798;8543.658253669846;8555.315574754035;8546.70086546971;8623.051464338918;8625.95687021564;8626.956865215665;8638.697645582406;8351.874721879176;8379.62291696875;8389.32885369169;8401.873971890427;8408.453450525727;8355.749327520183;8496.447730897471;8497.532635705034;8498.532580708059;8498.575071246412;38595.42106868371;39156.21687566233;39172.21655566901;39212.84329361884;39222.21555568872;3175.6983086606965;3198.856051477689;3236.7572432067454;3536.381133301662;3827.100631351658;26305.210843674722;26492.205233843015;26567.468650627074;26603.334916627045;27319;3363.5795525559306;3365.932681346384;3366.293078453528;3408.9438743517812;3460.2733425980573;211119;213147;214248;214413;214521;52892.73553632284;53228;53728.73135634297;59689.70155149196;60370.698146509865;53903.19145212825;53954.460455395725;54103;54133.72933135309;54260.18609720857;13248.73502529944;14246.857531424761;14378.640533986525;14397.78403323951;14564.927175364055;9216.124468175512;10392.324498907547;10495.475226238657;10544.314619549705;10547.103496202755;18912.527186820163;18944.71582926257;19695.409137725892;19696.40910772679;19697.21211151538;7628.313451789366;7835.412344074217;7889.48718333318;7957.1644977276555;8021.919780802234;852.9829403411896;901.5492253873064;953.537534295866;954.5704433005176;1124.095103441721;27942.3014424641;28228;28423;28586.714132858822;28709;1049.459528342904;1101.388729255271;1129.1587767113554;1132.4903793293051;1145.3128123126057;14802.407903683732;14811;14895.659390654893;14957;14968;317177;321995;322404.81963852805;322610;324152;49909;50331.74834125806;50361.496385036415;50462.495375046514;50514;1197.3713800254761;1238.5107882386408;1261.2495565138727;1346.2730125731996;1366.8086467894502;25835;27295.181144565693;27536.724632753416;27834;28004.85997569999;40005.59994400019;40263.19473610453;40299.395509067974;44406.77796610996;44832;286567;289708;291979;292194;292955;28277.858610706815;28877.71122288834;28898.566521501773;28899.42201155923;28906.855465722536;40749.1850163001;41446.1710765789;41811.37282940819;41875.162496750505;42256;35087.47368789521;35125.12187195341;35479;36162.4575631371;36531.634683652825;35208.82395588108;35644;35928.46107308445;36179;36344.27311453809;35636;38058.238835223696;38584;38667;38721.41917871178;29528.557071644373;31677;32751.34497310088;32808.67191328056;32829.34341313208;24552.526848389152;25027.87486062558;25057.617221674842;25153.74846251514;25282.620760688238 15:04:22 INFO - PROCESS | 2967 | |2;jquery.html;360.2614639988024;360.2956220588749;363.9690626296763;366.55829725181155;367.896988843124;12864.871351286485;13095.803562946563;15477.303521341539;16775.24511396987;17922;10534.894651053488;12628.494860205603;13478.730425391486;13488.055836091478;13495.448023477304;4830.372051633282;4964.503549645043;4970.403551573798;4971.477994810547;4971.651984361096;3765.0963768695588;3912.4913761211;4909.042736666352;4975.776090075937;5177.585793136559;5298.814541491049;5359.035373632764;5362.731863406814;5370.516653501184;5387.838364849041;5207.791688332462;5427.240186373911;5438.564914806806;5440.183972404131;5446.591505637053;5035.84892453227;5234.319538460014;5236.423993360727;5241.816536421207;5249.186376111708;12724.427400766988;12904.419301131471;12904.54834080812;15526.456574019969;19874.70187947182;2020.5857799151138;2031.3601215617034;2057;2144.6997420361163;2157.482204270964;9711.320207585472;10817.675469735921;11005.229633925628;12540.498380064786;13096.607101786962;1793.6681713882974;1802.1710013393854;1814.5554339186983;1847.048769883511;1869.5419622192514;51753.74123129398;52995.205071924334;53839.46160538384;54416.455835441535;54831.725841370935;9778.951105244429;9950.35322704022;10057.849132263022;10084.394936303845;10135.493225338703;13139.802902956464;13341.332933353293;13353.73292534144;13380.933095334656;13383.799243011363;7006.474514411338;7015.298470152944;7045.7181712731945;7163.31948464895;7288.635568221674;6575.539712220194;6699.832504187434;6766.342246149725;6840.41856442208;6865.691043903036;4318.978405108017;4386.824527018884;4395.208862404734;4428.889277768081;4437.42313499243;1714.7342161964916;1739.199968014702;1768.2661695396266;1782.3583509936414;1815.3646223821556;899.321012635456;934.2152591822901;970.9998701337634;979.6081567373108;1008.0625018732649;13756.65608359779;14249.145051296955;15454.613634659;15509;15802.920985395229;900.9954950225207;948.2224575847877;964.7250533597891;964.8697425847421;970.6651205334149;8911.15344042315;9227.953860230657;9273.53632318395;9325.487098209664;9474.715758527254;385241;390721;396630.2190357618;548496;548986;61578.0763288551;65750.34249657538;71415.64292178505;71991.64004179946;72974.63512682403;1086.3047649504324;1115.3642423818508;1128.0991529273201;1130.9830352544718;1143.588308209044;14354.3540540678;14444.133351998913;14842.628934276729;14961.476348327757;15406.614834629225;29774.404511910074;30275.848620756755;30803;31083;33875;34324.48513272353;34900.65099349076;35063.29873402569;35125.47311790376;35334.46998294976;6977.232504424408;7032.12098487689;7118.9644051779405;7197.316254955771;7310.159331676925;10205.183585313305;10466.16270698327;10556.261061725605;10595;11089.445527723743;9437.339386242897;9548.092931171528;9609.807803843743;9631.325807193709;9657.93762686118;9568.282378821756;9581.329306948446;9600.279979001743;9739.756506087404;9780.41317520951;7337.559746415232;8617.741467755977;8975.2371048459;9744.464054477072;9747.610095596381;7241.384482319062;7299.124105107421;7340.96329518349;7453.664585093576;7456.701731930879;8643.308535317034;8879.733607991771;9077.636894524145;9620.422774633544;9833.508324583885 15:04:22 INFO - PROCESS | 2967 | |3;mootools.html;1295.5530342032007;1425.565202613203;1438.388684808956;1542.3290868472216;1715.6568686262742;6380.361963803617;6927.688254028568;7084.220735719066;7084.397826184781;7127.572345659264;6839.11091558098;6994.440444764419;7019.543729657581;7021.262767409425;7024.2273349931465;1907.3133671878113;1929.8166674165932;2218.4675677837363;2237.7202849643795;2267.614505534063;2185.8907054647284;2213.8893055347166;2216.1689366487567;2217.168561789329;2218.1016688241207;2130.4034870236283;2226.7105276314137;2230.9776902230933;2237.1163390460756;2237.407087121906;2178.063432723928;2198.923037693673;2215.1693115081844;2225.3880182949656;2228.732552093751;2168.013553833018;2168.4036889855415;2190.58378908007;2200.4058904095805;2209.7569267380577;6741.865162696768;6780.7287708492095;6783;6789;6802.081718967926;4466.3523789050405;4507.098580283956;4510.503844577094;4511.503734589192;4517.548245175489;2961.7926745127847;3010.8795648174046;3060.32672811981;3069;3084.845757712128;965.3821554205314;969.8933117357085;987.1263931420673;1000.4247557654378;1002.5187909803335;9394.201492873113;9473.526323683856;9474.763130921645;9477.28920330978;9490;4031.75809451428;4040.5151381834366;4122.484689413824;4176.895577610523;4179.226843034048;8442.957785211034;8457.40798144124;8458.027326857367;8465.57672116404;8493.023302320189;4589.747563884019;4604.585587297092;4627.421572303462;4642.79107440166;4643.3963584733765;4201.831926722897;4204.8528301509305;4218.1985422770185;4229.577042295746;4277.764722940268;3335.366280406715;3342.415077361452;3367.2087059540986;3517.419625761772;3558.6085530591613;1142.765733024728;1205.2647884790272;1211.2248161176854;1213.6298428979069;1224.0024380130164;1027.1166796554958;1027.7225149209671;1202.5430336472084;1235.71578536937;1258.5532136091556;6390.936090639034;6394.71223794921;6396.968015159894;6414.037894315797;6467.773627923;1062.134360496193;1067.1569460126414;1070.550368845087;1095.0691911874842;1118.43578198462;5194;5248.475152484797;5252.868678282997;5266.2890509781455;5272;8180.672773089129;8227.13615070409;8232.053313868983;8266;8552.10202928696;8130.878036829452;8149.511029338259;8150.062742784656;8448.07071222165;8479.152084791594;6733.7306507741105;6777.1189745332795;6887.173539175331;6906.482013848981;6918.757843475454;6595.472362211108;6604.900926486011;6642.335766423513;6642.734290628321;6647.135872336566;7623.4663573549315;7742.458027937991;7762.573058481612;7766;7784.260495252942;7294.234105418855;7361.8159546011775;7371.041764570786;7950.920490795018;8146.75559733209;6423.132877061536;6526.477881769352;6539.574927629689;6606.108175396452;6624.6025238485845;6031.60794548353;6284.528660350401;6409.134766806422;6417.711202995783;6618.437432818265;6078.513718902389;6153.292371377349;6274.403931626488;6321.778737744341;6357.745690172342;6074.757009719562;6175.135481032569;6217.285012223471;6267.874642507033;6288.937110628835;6061.605995610271;6140.907886381798;6146.631202127886;6192.195014648067;6275;5679.77280908759;5707.229524014205;5715.999700052557;5916.171735956884;5927.436893495111;5465.918011229915;5773.53811695055;5791;5822.82531524055;5833.941660583339 15:04:22 INFO - PROCESS | 2967 | |4;prototype.html;323.35490696061373;324.9203945033467;325.0670575448463;329.7526854858856;335.7767084888549;5816.418358164182;5858.20914176586;5883.794067207648;5903.970480147594;5933.673647949361;5528.419515950827;5634.295713035871;5638.295213098363;5641.68970706611;5787.652740835553;4456.952616135214;4461.977690111545;4482.058767658796;4489.2817149256125;4498.460184777831;4480.932786008212;4481.058977614704;4482.417285752864;4485.506594274627;4499.122671079141;4248.447701798762;4356.607905288523;4369.519352871182;4474.731516109044;4494.16857881293;4466.709663871838;4472.546422412713;4475.686701930867;4492.2812350024005;4493.4832494263255;3954.7231693781446;3958.247932892741;3964.623360780721;3964.960350396517;3967.523897132334;5581.162825576155;5593.105103183471;5598.216249725042;5599.356074051455;5606.159076138571;5104.336436263299;5216;5225.503577160163;5229.686218826882;5230.816921407771;6150.66171360575;6155.476784473325;6155.969220153916;6156.969215153896;6158.630482171084;4397.538258482845;4403.119376124788;4403.955960440387;4406.25093734066;4412.536683648203;6271.560990730651;6454.612723236621;6458.806235812933;6464.191976003;6464.51516136287;4503.144402563568;4503.504614492404;4506.301523263899;4507.5943165115295;4508.18852606534;4561.156186105581;4564.0871825635;4564.3153526970555;4565.657575681771;4567.543245675406;5150.8969820604125;5173.379194496609;5180.274761533388;5184.196449550251;5198.454162312903;6061.939380606225;6216.098665693449;6217.658028808369;6222.751089956441;6231.875362492725;1593.4900831733735;1612.1455628516906;1613.6530645911184;1615.055192712253;1616.0303817709516;1064.6912395405245;1094.715374002765;1097.665212110314;1104.0339702760084;1114.676743744305;5914.792982245601;5939.970300148558;5952.613080149863;5957.434043765836;5961.672108034099;6407.615543067338;6437.420632143129;6445.484361251182;6447.806565803034;6460;5706.80026199081;5772.365039845614;5809.651420914674;5885.911711324334;5937.643741375531;3432.845521951518;3450.4306789379975;3457.5159477673146;3465.9480107798404;3466.705330046924;6641.435477984329;6674.899876501856;6780.559263647847;6783.966080169567;6791.626460544619;6358.936410635834;6600.8349791255605;6621.834454138589;6625.536212465177;6650.3349665034075;6802.115724955724;6806.8638627228165;6815.829604259933;6817.761378351634;6821.488388370892;6428.871422571616;6435.195600549931;6490.870182596227;6493.707783149675;6513.837154071186;6272.686365681789;6379.52153588492;6385.648789316632;6472.741090356333;6483;6760.174752816613;6775.4240889524945;6777.457803375817;6779.35596118368;6799.796006119825;4395.318725597537;4412.051408947092;4444.044530425845;4447;4450.1767173073085;6341.7780377688405;6460.224773027267;6472.967635161794;6498.577592456475;6503.089567460464;6230.847293250763;6333.746650134128;6348.555601107878;6402.103705481143;6423.229212494531;6363.3636636336;6376.234851817626;6389.808305750835;6396.840078997876;6405.263394709668;6099.542534309856;6213.596116252429;6220.284667263322;6226.937730622636;6229.065640154013;6363;6370.1718776558755;6433.099366088845;6441.742330306923;6442.710078046593;6220.502359811295;6222.377762223741;6225.8132256032395;6229.53278504123;6230.937690623217 15:04:22 INFO - PROCESS | 2967 | |5;yui.html;742.528494406052;748.9925100748994;809.453618807305;812.9918700812992;834.585045111361;13011.219326840384;13162.605121846336;13164.47342106317;13185.934070329635;13196.604101876947;12414.875851241484;12483.188592741466;12508.186967847083;12516.123871328988;12557.183783054117;660.5871330418488;673.3603077076797;807.4751411582489;823.983520329593;823.983520329593;801.2268161224417;805.0621026504145;806.4234072638062;808.0505406147753;808.6522795198063;689.2590465249851;848.1306660672828;854.0264098927228;854.9529775862325;855.1662129423825;692.127918822285;836.9497830130181;849.0448245723561;854.3421565394674;854.8461276970143;629.0689779126872;629.072118625029;629.26061877294;629.339193846464;629.4586655476287;13048.739025219538;13098.738025239538;13103.672408189776;13109.934450327783;13125.409356578977;12146.514139434412;12642.431090600945;12859.292738899358;12904.290264035475;13050.477980880753;10506.78986420275;10516.68449946503;10554.050135487843;10621.57513699451;10953;3597.7661452005536;3634.745567810254;3680.963190368089;3697.7411581189326;3765.9246815063543;47207.76396118032;48911;48998.51001489975;49061;49347.50652493465;9421.76445588852;9812.215022798158;9817.116459518678;9967.700968970943;10023.448710321003;18833.811661883206;18883.150258238413;18890.81109188918;18934.147963341682;18953.147108380155;7703.3067023968115;7716.5370077795515;7758.185390534026;7823.100343460461;7928.048634163937;4306.82772689089;4343.478782546052;4354.978225108917;4393.7363758174615;4406.867793966187;2980.493316136262;3020.2600362911226;3021.0634703242067;3031.8787248510253;3034.742046926036;515.6983164848606;517.0486305198377;527.6069328350403;528.0837746509802;540.6728928997978;651.7165033210568;664.9394216225113;668.6857177126743;675.9831004224835;694.6387878303356;9004.406158720625;9434.811303773886;9455.19630831387;9547.093026162504;9575.760605984906;542.4223202289548;568.5877738639535;600.1365759317257;643.5109316919081;645.6384424722171;3954.426608141803;4022.577629348935;4051.2707712612014;4067.6745860331102;4152.273352163359;48944;49898.25152622713;55320.446795532334;56016.159757603666;56058;43799.56200437955;44936.10127797426;45223;45484.77257613691;45495.54504454979;39532.80233598871;40063.59936400657;40544.18911621751;40733;41067;8853.557322133738;8983.595738191667;9095.544712845913;9131.543422828965;9181.449113053239;32415.189620259684;33170.66829331772;33276.500852486744;33403.498947516295;33780.324393512485;40888.59111408848;41986;43014;45047;46576.7671161642;11098.389588572383;11148.498317575892;11300.321980681185;11470.254433461798;11517.654470365902;12494.625161245178;12526.624201273977;12557.74884502323;13191.620211478763;13343.771659942913;10499.160067194758;10778.89221107779;10816.18878584125;10950.94524527404;11602.361870097226;11311.886881131413;11753.529858805552;11857.229280096766;11926.330912283765;12312.445939932546;11140.275882067639;11408.486618102039;11591;11966.46150923228;12007.639770806889;9109.635614575343;9222.262219022328;9257.537123143951;9499.667511637059;9626.133647971716;9151.679691210775;9545.570449329658;9675.70972870815;10069.90778545686;10081.362573216402 15:04:22 INFO - PROCESS | 2967 | __end_tp_report 15:04:22 INFO - PROCESS | 2967 | __start_cc_report 15:04:22 INFO - PROCESS | 2967 | _x_x_mozilla_cycle_collect,819 15:04:22 INFO - PROCESS | 2967 | __end_cc_report 15:04:22 INFO - PROCESS | 2967 | __startTimestamp1453331062716__endTimestamp 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | ------- Summary: start ------- 15:04:22 INFO - PROCESS | 2967 | Number of tests: 6 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#0] dojo.html Cycles:165 Average:4861.74 Median:5044.17 stddev:501.27 (9.9%) stddev-sans-first:481.38 15:04:22 INFO - PROCESS | 2967 | Values: 3013.4 3015.5 3053.0 3062.7 3067.7 4742.0 4809.3 4886.5 4905.2 4940.0 4720.0 4823.3 4839.4 4841.6 4846.9 4279.7 4435.2 4515.7 4525.9 4580.5 4433.0 4501.9 4507.4 4544.1 4576.9 4435.6 4456.6 4464.5 4494.4 4503.1 4433.9 4488.6 4490.8 4512.4 4552.4 4425.2 4468.0 4475.7 4480.1 4482.5 4662.0 4663.8 4672.2 4683.8 4708.1 5207.4 5228.7 5231.5 5234.8 5288.5 5231.1 5255.6 5260.7 5263.4 5287.2 4858.8 4922.3 4936.7 4945.9 4972.8 5327.7 5330.1 5367.7 5375.2 5381.1 5126.4 5131.2 5139.5 5139.8 5198.3 5174.6 5176.3 5208.4 5230.0 5253.9 5182.8 5198.7 5210.2 5211.2 5216.5 5178.9 5180.0 5186.0 5187.0 5236.1 4037.1 4104.9 4106.6 4107.9 4111.1 3722.0 3735.7 3759.6 3775.8 3780.3 4875.9 4899.9 4900.8 4908.0 4953.2 5178.0 5191.7 5194.7 5200.9 5242.9 4724.5 4853.3 4870.5 4878.2 4880.7 4525.6 4526.6 4544.3 4571.1 4575.9 5392.9 5396.6 5397.3 5397.8 5398.1 5150.6 5210.7 5213.8 5229.4 5254.9 5301.8 5317.0 5323.9 5344.9 5417.2 5155.3 5159.6 5163.6 5165.1 5202.4 5179.2 5221.8 5234.1 5251.2 5303.5 5094.3 5110.1 5112.3 5113.8 5117.0 5108.9 5110.5 5122.3 5123.7 5160.5 4960.6 4985.8 5018.0 5051.9 5098.7 5094.3 5114.7 5118.6 5118.9 5133.5 4952.9 5033.7 5035.0 5038.4 5044.2 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#1] ext.html Cycles:180 Average:43809.24 Median:19372.60 stddev:72986.70 (376.8%) stddev-sans-first:73119.22 15:04:22 INFO - PROCESS | 2967 | Values: 563.7 564.1 568.6 578.1 578.8 29201.9 29788.9 34692.0 34776.0 34912.5 37770.6 38167.4 38172.4 38202.2 38217.2 8491.9 8766.8 8786.5 8788.3 8791.9 8421.0 8538.8 8540.8 8543.7 8555.3 8546.7 8623.1 8626.0 8627.0 8638.7 8351.9 8379.6 8389.3 8401.9 8408.5 8355.7 8496.4 8497.5 8498.5 8498.6 38595.4 39156.2 39172.2 39212.8 39222.2 3175.7 3198.9 3236.8 3536.4 3827.1 26305.2 26492.2 26567.5 26603.3 27319.0 3363.6 3365.9 3366.3 3408.9 3460.3 211119.0 213147.0 214248.0 214413.0 214521.0 52892.7 53228.0 53728.7 59689.7 60370.7 53903.2 53954.5 54103.0 54133.7 54260.2 13248.7 14246.9 14378.6 14397.8 14564.9 9216.1 10392.3 10495.5 10544.3 10547.1 18912.5 18944.7 19695.4 19696.4 19697.2 7628.3 7835.4 7889.5 7957.2 8021.9 853.0 901.5 953.5 954.6 1124.1 27942.3 28228.0 28423.0 28586.7 28709.0 1049.5 1101.4 1129.2 1132.5 1145.3 14802.4 14811.0 14895.7 14957.0 14968.0 317177.0 321995.0 322404.8 322610.0 324152.0 49909.0 50331.7 50361.5 50462.5 50514.0 1197.4 1238.5 1261.2 1346.3 1366.8 25835.0 27295.2 27536.7 27834.0 28004.9 40005.6 40263.2 40299.4 44406.8 44832.0 286567.0 289708.0 291979.0 292194.0 292955.0 28277.9 28877.7 28898.6 28899.4 28906.9 40749.2 41446.2 41811.4 41875.2 42256.0 35087.5 35125.1 35479.0 36162.5 36531.6 35208.8 35644.0 35928.5 36179.0 36344.3 35636.0 38058.2 38584.0 38667.0 38721.4 29528.6 31677.0 32751.3 32808.7 32829.3 24552.5 25027.9 25057.6 25153.7 25282.6 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#2] jquery.html Cycles:180 Average:24279.79 Median:4967.45 stddev:75321.02 (1516.3%) stddev-sans-first:75510.90 15:04:22 INFO - PROCESS | 2967 | Values: 360.3 360.3 364.0 366.6 367.9 12864.9 13095.8 15477.3 16775.2 17922.0 10534.9 12628.5 13478.7 13488.1 13495.4 4830.4 4964.5 4970.4 4971.5 4971.7 3765.1 3912.5 4909.0 4975.8 5177.6 5298.8 5359.0 5362.7 5370.5 5387.8 5207.8 5427.2 5438.6 5440.2 5446.6 5035.8 5234.3 5236.4 5241.8 5249.2 12724.4 12904.4 12904.5 15526.5 19874.7 2020.6 2031.4 2057.0 2144.7 2157.5 9711.3 10817.7 11005.2 12540.5 13096.6 1793.7 1802.2 1814.6 1847.0 1869.5 51753.7 52995.2 53839.5 54416.5 54831.7 9779.0 9950.4 10057.8 10084.4 10135.5 13139.8 13341.3 13353.7 13380.9 13383.8 7006.5 7015.3 7045.7 7163.3 7288.6 6575.5 6699.8 6766.3 6840.4 6865.7 4319.0 4386.8 4395.2 4428.9 4437.4 1714.7 1739.2 1768.3 1782.4 1815.4 899.3 934.2 971.0 979.6 1008.1 13756.7 14249.1 15454.6 15509.0 15802.9 901.0 948.2 964.7 964.9 970.7 8911.2 9228.0 9273.5 9325.5 9474.7 385241.0 390721.0 396630.2 548496.0 548986.0 61578.1 65750.3 71415.6 71991.6 72974.6 1086.3 1115.4 1128.1 1131.0 1143.6 14354.4 14444.1 14842.6 14961.5 15406.6 29774.4 30275.8 30803.0 31083.0 33875.0 34324.5 34900.7 35063.3 35125.5 35334.5 6977.2 7032.1 7119.0 7197.3 7310.2 10205.2 10466.2 10556.3 10595.0 11089.4 9437.3 9548.1 9609.8 9631.3 9657.9 9568.3 9581.3 9600.3 9739.8 9780.4 7337.6 8617.7 8975.2 9744.5 9747.6 7241.4 7299.1 7341.0 7453.7 7456.7 8643.3 8879.7 9077.6 9620.4 9833.5 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#3] mootools.html Cycles:180 Average:4984.53 Median:5921.80 stddev:2465.62 (41.6%) stddev-sans-first:2456.94 15:04:22 INFO - PROCESS | 2967 | Values: 1295.6 1425.6 1438.4 1542.3 1715.7 6380.4 6927.7 7084.2 7084.4 7127.6 6839.1 6994.4 7019.5 7021.3 7024.2 1907.3 1929.8 2218.5 2237.7 2267.6 2185.9 2213.9 2216.2 2217.2 2218.1 2130.4 2226.7 2231.0 2237.1 2237.4 2178.1 2198.9 2215.2 2225.4 2228.7 2168.0 2168.4 2190.6 2200.4 2209.8 6741.9 6780.7 6783.0 6789.0 6802.1 4466.4 4507.1 4510.5 4511.5 4517.5 2961.8 3010.9 3060.3 3069.0 3084.8 965.4 969.9 987.1 1000.4 1002.5 9394.2 9473.5 9474.8 9477.3 9490.0 4031.8 4040.5 4122.5 4176.9 4179.2 8443.0 8457.4 8458.0 8465.6 8493.0 4589.7 4604.6 4627.4 4642.8 4643.4 4201.8 4204.9 4218.2 4229.6 4277.8 3335.4 3342.4 3367.2 3517.4 3558.6 1142.8 1205.3 1211.2 1213.6 1224.0 1027.1 1027.7 1202.5 1235.7 1258.6 6390.9 6394.7 6397.0 6414.0 6467.8 1062.1 1067.2 1070.6 1095.1 1118.4 5194.0 5248.5 5252.9 5266.3 5272.0 8180.7 8227.1 8232.1 8266.0 8552.1 8130.9 8149.5 8150.1 8448.1 8479.2 6733.7 6777.1 6887.2 6906.5 6918.8 6595.5 6604.9 6642.3 6642.7 6647.1 7623.5 7742.5 7762.6 7766.0 7784.3 7294.2 7361.8 7371.0 7950.9 8146.8 6423.1 6526.5 6539.6 6606.1 6624.6 6031.6 6284.5 6409.1 6417.7 6618.4 6078.5 6153.3 6274.4 6321.8 6357.7 6074.8 6175.1 6217.3 6267.9 6288.9 6061.6 6140.9 6146.6 6192.2 6275.0 5679.8 5707.2 5716.0 5916.2 5927.4 5465.9 5773.5 5791.0 5822.8 5833.9 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#4] prototype.html Cycles:180 Average:5234.83 Median:5884.85 stddev:1579.25 (26.8%) stddev-sans-first:1540.05 15:04:22 INFO - PROCESS | 2967 | Values: 323.4 324.9 325.1 329.8 335.8 5816.4 5858.2 5883.8 5904.0 5933.7 5528.4 5634.3 5638.3 5641.7 5787.7 4457.0 4462.0 4482.1 4489.3 4498.5 4480.9 4481.1 4482.4 4485.5 4499.1 4248.4 4356.6 4369.5 4474.7 4494.2 4466.7 4472.5 4475.7 4492.3 4493.5 3954.7 3958.2 3964.6 3965.0 3967.5 5581.2 5593.1 5598.2 5599.4 5606.2 5104.3 5216.0 5225.5 5229.7 5230.8 6150.7 6155.5 6156.0 6157.0 6158.6 4397.5 4403.1 4404.0 4406.3 4412.5 6271.6 6454.6 6458.8 6464.2 6464.5 4503.1 4503.5 4506.3 4507.6 4508.2 4561.2 4564.1 4564.3 4565.7 4567.5 5150.9 5173.4 5180.3 5184.2 5198.5 6061.9 6216.1 6217.7 6222.8 6231.9 1593.5 1612.1 1613.7 1615.1 1616.0 1064.7 1094.7 1097.7 1104.0 1114.7 5914.8 5940.0 5952.6 5957.4 5961.7 6407.6 6437.4 6445.5 6447.8 6460.0 5706.8 5772.4 5809.7 5885.9 5937.6 3432.8 3450.4 3457.5 3465.9 3466.7 6641.4 6674.9 6780.6 6784.0 6791.6 6358.9 6600.8 6621.8 6625.5 6650.3 6802.1 6806.9 6815.8 6817.8 6821.5 6428.9 6435.2 6490.9 6493.7 6513.8 6272.7 6379.5 6385.6 6472.7 6483.0 6760.2 6775.4 6777.5 6779.4 6799.8 4395.3 4412.1 4444.0 4447.0 4450.2 6341.8 6460.2 6473.0 6498.6 6503.1 6230.8 6333.7 6348.6 6402.1 6423.2 6363.4 6376.2 6389.8 6396.8 6405.3 6099.5 6213.6 6220.3 6226.9 6229.1 6363.0 6370.2 6433.1 6441.7 6442.7 6220.5 6222.4 6225.8 6229.5 6230.9 15:04:22 INFO - PROCESS | 2967 | 15:04:22 INFO - PROCESS | 2967 | [#5] yui.html Cycles:180 Average:13337.73 Median:4400.30 stddev:14818.10 (336.8%) stddev-sans-first:14829.48 15:04:22 INFO - PROCESS | 2967 | Values: 742.5 749.0 809.5 813.0 834.6 13011.2 13162.6 13164.5 13185.9 13196.6 12414.9 12483.2 12508.2 12516.1 12557.2 660.6 673.4 807.5 824.0 824.0 801.2 805.1 806.4 808.1 808.7 689.3 848.1 854.0 855.0 855.2 692.1 836.9 849.0 854.3 854.8 629.1 629.1 629.3 629.3 629.5 13048.7 13098.7 13103.7 13109.9 13125.4 12146.5 12642.4 12859.3 12904.3 13050.5 10506.8 10516.7 10554.1 10621.6 10953.0 3597.8 3634.7 3681.0 3697.7 3765.9 47207.8 48911.0 48998.5 49061.0 49347.5 9421.8 9812.2 9817.1 9967.7 10023.4 18833.8 18883.2 18890.8 18934.1 18953.1 7703.3 7716.5 7758.2 7823.1 7928.0 4306.8 4343.5 4355.0 4393.7 4406.9 2980.5 3020.3 3021.1 3031.9 3034.7 515.7 517.0 527.6 528.1 540.7 651.7 664.9 668.7 676.0 694.6 9004.4 9434.8 9455.2 9547.1 9575.8 542.4 568.6 600.1 643.5 645.6 3954.4 4022.6 4051.3 4067.7 4152.3 48944.0 49898.3 55320.4 56016.2 56058.0 43799.6 44936.1 45223.0 45484.8 45495.5 39532.8 40063.6 40544.2 40733.0 41067.0 8853.6 8983.6 9095.5 9131.5 9181.4 32415.2 33170.7 33276.5 33403.5 33780.3 40888.6 41986.0 43014.0 45047.0 46576.8 11098.4 11148.5 11300.3 11470.3 11517.7 12494.6 12526.6 12557.7 13191.6 13343.8 10499.2 10778.9 10816.2 10950.9 11602.4 11311.9 11753.5 11857.2 11926.3 12312.4 11140.3 11408.5 11591.0 11966.5 12007.6 9109.6 9222.3 9257.5 9499.7 9626.1 9151.7 9545.6 9675.7 10069.9 10081.4 15:04:22 INFO - PROCESS | 2967 | -------- Summary: end -------- 15:04:22 INFO - PROCESS | 2967 | 15:04:23 INFO - TEST-INFO | 2967: exit 0 15:04:23 INFO - TEST-OK | dromaeo_css | took 1111983ms 15:04:23 INFO - TEST-START | kraken 15:04:23 INFO - operating with platform_type : linux_ 15:04:23 INFO - Initialising browser for kraken test... 15:04:23 INFO - TEST-INFO | started process 3171 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcotAmI/profile http://localhost:45229/getInfo.html) 15:04:27 INFO - PROCESS | 3171 | __metrics Screen width/height:1600/1200 15:04:27 INFO - PROCESS | 3171 | colorDepth:24 15:04:27 INFO - PROCESS | 3171 | Browser inner width/height: 1024/697 15:04:27 INFO - PROCESS | 3171 | __metrics 15:04:27 INFO - PROCESS | 3171 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:04:27 INFO - PROCESS | 3171 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:04:28 INFO - TEST-INFO | 3171: exit 0 15:04:28 INFO - Browser initialized. 15:04:28 INFO - Running cycle 1/1 for kraken test... 15:04:28 INFO - TEST-INFO | started process 3255 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcotAmI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:40 INFO - PROCESS | 3255 | RSS: Main: 148905984 15:04:40 INFO - PROCESS | 3255 | 15:04:42 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45229/tests/kraken/driver.html?testName=audio-beat-detection) 15:04:43 INFO - PROCESS | 3255 | RSS: Main: 184705024 15:04:43 INFO - PROCESS | 3255 | 15:04:46 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45229/tests/kraken/driver.html?testName=audio-dft) 15:04:46 INFO - PROCESS | 3255 | RSS: Main: 175771648 15:04:46 INFO - PROCESS | 3255 | 15:04:49 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45229/tests/kraken/driver.html?testName=audio-fft) 15:04:50 INFO - PROCESS | 3255 | RSS: Main: 161808384 15:04:50 INFO - PROCESS | 3255 | 15:04:52 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45229/tests/kraken/driver.html?testName=audio-oscillator) 15:04:52 INFO - PROCESS | 3255 | RSS: Main: 162398208 15:04:52 INFO - PROCESS | 3255 | 15:04:54 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:04:55 INFO - PROCESS | 3255 | RSS: Main: 166043648 15:04:55 INFO - PROCESS | 3255 | 15:04:58 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45229/tests/kraken/driver.html?testName=imaging-darkroom) 15:04:58 INFO - PROCESS | 3255 | RSS: Main: 165969920 15:04:58 INFO - PROCESS | 3255 | 15:05:02 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45229/tests/kraken/driver.html?testName=imaging-desaturate) 15:05:02 INFO - PROCESS | 3255 | RSS: Main: 166768640 15:05:02 INFO - PROCESS | 3255 | 15:05:05 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45229/tests/kraken/driver.html?testName=json-parse-financial) 15:05:06 INFO - PROCESS | 3255 | RSS: Main: 168034304 15:05:06 INFO - PROCESS | 3255 | 15:05:07 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:05:08 INFO - PROCESS | 3255 | RSS: Main: 182235136 15:05:08 INFO - PROCESS | 3255 | 15:05:10 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:05:10 INFO - PROCESS | 3255 | RSS: Main: 178708480 15:05:10 INFO - PROCESS | 3255 | 15:05:12 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:05:13 INFO - PROCESS | 3255 | RSS: Main: 192544768 15:05:13 INFO - PROCESS | 3255 | 15:05:15 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:05:16 INFO - PROCESS | 3255 | RSS: Main: 197840896 15:05:16 INFO - PROCESS | 3255 | 15:05:18 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:05:19 INFO - PROCESS | 3255 | RSS: Main: 194789376 15:05:19 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | Cycle 1(1): loaded http://localhost:45229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45229/tests/kraken/driver.html?testName=ai-astar) 15:05:21 INFO - PROCESS | 3255 | RSS: Main: 252653568 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | __start_tp_report 15:05:21 INFO - PROCESS | 3255 | _x_x_mozilla_page_load 15:05:21 INFO - PROCESS | 3255 | _x_x_mozilla_page_load_details 15:05:21 INFO - PROCESS | 3255 | |i|pagename|runs| 15:05:21 INFO - PROCESS | 3255 | |0;ai-astar;112;110;106;110;109;111;111;111;103;111 15:05:21 INFO - PROCESS | 3255 | |1;audio-beat-detection;154;124;152;164;124;150;156;131;174;124 15:05:21 INFO - PROCESS | 3255 | |2;audio-dft;160;162;161;161;161;161;161;161;163;163 15:05:21 INFO - PROCESS | 3255 | |3;audio-fft;72;73;101;92;76;73;74;117;101;72 15:05:21 INFO - PROCESS | 3255 | |4;audio-oscillator;97;97;142;95;95;96;138;95;95;142 15:05:21 INFO - PROCESS | 3255 | |5;imaging-gaussian-blur;110;109;110;110;109;111;109;110;111;112 15:05:21 INFO - PROCESS | 3255 | |6;imaging-darkroom;145;146;145;146;145;145;146;145;145;146 15:05:21 INFO - PROCESS | 3255 | |7;imaging-desaturate;96;96;96;97;96;96;95;96;97;96 15:05:21 INFO - PROCESS | 3255 | |8;json-parse-financial;58;58;57;56;57;59;59;57;71;58 15:05:21 INFO - PROCESS | 3255 | |9;json-stringify-tinderbox;70;69;68;69;69;70;68;67;69;69 15:05:21 INFO - PROCESS | 3255 | |10;stanford-crypto-aes;82;81;83;82;83;83;88;83;84;83 15:05:21 INFO - PROCESS | 3255 | |11;stanford-crypto-ccm;119;116;117;113;119;114;125;115;117;122 15:05:21 INFO - PROCESS | 3255 | |12;stanford-crypto-pbkdf2;147;139;144;144;148;144;144;144;143;146 15:05:21 INFO - PROCESS | 3255 | |13;stanford-crypto-sha256-iterative;68;75;69;68;72;69;68;68;68;70 15:05:21 INFO - PROCESS | 3255 | __end_tp_report 15:05:21 INFO - PROCESS | 3255 | __start_cc_report 15:05:21 INFO - PROCESS | 3255 | _x_x_mozilla_cycle_collect,947 15:05:21 INFO - PROCESS | 3255 | __end_cc_report 15:05:21 INFO - PROCESS | 3255 | __startTimestamp1453331121426__endTimestamp 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | ------- Summary: start ------- 15:05:21 INFO - PROCESS | 3255 | Number of tests: 14 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:2.80 15:05:21 INFO - PROCESS | 3255 | Values: 112.0 110.0 106.0 110.0 109.0 111.0 111.0 111.0 103.0 111.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:153.00 stddev:18.25 (11.9%) stddev-sans-first:19.08 15:05:21 INFO - PROCESS | 3255 | Values: 154.0 124.0 152.0 164.0 124.0 150.0 156.0 131.0 174.0 124.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 15:05:21 INFO - PROCESS | 3255 | Values: 160.0 162.0 161.0 161.0 161.0 161.0 161.0 161.0 163.0 163.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#3] audio-fft Cycles:10 Average:85.10 Median:73.00 stddev:16.37 (22.4%) stddev-sans-first:16.67 15:05:21 INFO - PROCESS | 3255 | Values: 72.0 73.0 101.0 92.0 76.0 73.0 74.0 117.0 101.0 72.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:95.00 stddev:21.76 (22.9%) stddev-sans-first:22.62 15:05:21 INFO - PROCESS | 3255 | Values: 97.0 97.0 142.0 95.0 95.0 96.0 138.0 95.0 95.0 142.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 15:05:21 INFO - PROCESS | 3255 | Values: 110.0 109.0 110.0 110.0 109.0 111.0 109.0 110.0 111.0 112.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:05:21 INFO - PROCESS | 3255 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 15:05:21 INFO - PROCESS | 3255 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 95.0 96.0 97.0 96.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:4.32 (7.4%) stddev-sans-first:4.57 15:05:21 INFO - PROCESS | 3255 | Values: 58.0 58.0 57.0 56.0 57.0 59.0 59.0 57.0 71.0 58.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 15:05:21 INFO - PROCESS | 3255 | Values: 70.0 69.0 68.0 69.0 69.0 70.0 68.0 67.0 69.0 69.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.87 (2.3%) stddev-sans-first:1.94 15:05:21 INFO - PROCESS | 3255 | Values: 82.0 81.0 83.0 82.0 83.0 83.0 88.0 83.0 84.0 83.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#11] stanford-crypto-ccm Cycles:10 Average:117.70 Median:118.00 stddev:3.68 (3.1%) stddev-sans-first:3.88 15:05:21 INFO - PROCESS | 3255 | Values: 119.0 116.0 117.0 113.0 119.0 114.0 125.0 115.0 117.0 122.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:144.00 stddev:2.45 (1.7%) stddev-sans-first:2.40 15:05:21 INFO - PROCESS | 3255 | Values: 147.0 139.0 144.0 144.0 148.0 144.0 144.0 144.0 143.0 146.0 15:05:21 INFO - PROCESS | 3255 | 15:05:21 INFO - PROCESS | 3255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.32 (3.4%) stddev-sans-first:2.40 15:05:21 INFO - PROCESS | 3255 | Values: 68.0 75.0 69.0 68.0 72.0 69.0 68.0 68.0 68.0 70.0 15:05:21 INFO - PROCESS | 3255 | -------- Summary: end -------- 15:05:21 INFO - PROCESS | 3255 | 15:05:22 INFO - TEST-INFO | 3255: exit 0 15:05:22 INFO - TEST-OK | kraken | took 58951ms 15:05:22 INFO - TEST-START | v8_7 15:05:22 INFO - operating with platform_type : linux_ 15:05:22 INFO - Initialising browser for v8_7 test... 15:05:22 INFO - TEST-INFO | started process 3508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGjcdg1/profile http://localhost:45229/getInfo.html) 15:05:26 INFO - PROCESS | 3508 | __metrics Screen width/height:1600/1200 15:05:26 INFO - PROCESS | 3508 | colorDepth:24 15:05:26 INFO - PROCESS | 3508 | Browser inner width/height: 1024/697 15:05:26 INFO - PROCESS | 3508 | __metrics 15:05:26 INFO - PROCESS | 3508 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:05:26 INFO - PROCESS | 3508 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:05:27 INFO - TEST-INFO | 3508: exit 0 15:05:27 INFO - Browser initialized. 15:05:27 INFO - Running cycle 1/1 for v8_7 test... 15:05:27 INFO - TEST-INFO | started process 3592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGjcdg1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:38 INFO - PROCESS | 3592 | RSS: Main: 148697088 15:05:38 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | Cycle 1(1): loaded http://localhost:45229/tests/v8_7/run.html (next: http://localhost:45229/tests/v8_7/run.html) 15:06:01 INFO - PROCESS | 3592 | RSS: Main: 564342784 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | __start_tp_report 15:06:01 INFO - PROCESS | 3592 | _x_x_mozilla_page_load 15:06:01 INFO - PROCESS | 3592 | _x_x_mozilla_page_load_details 15:06:01 INFO - PROCESS | 3592 | |i|pagename|runs| 15:06:01 INFO - PROCESS | 3592 | |0;Richards;168.29350387075058 15:06:01 INFO - PROCESS | 3592 | |1;DeltaBlue;196.50225977598743 15:06:01 INFO - PROCESS | 3592 | |2;Encrypt;286.368843069874 15:06:01 INFO - PROCESS | 3592 | |3;Decrypt;5263.1578947368425 15:06:01 INFO - PROCESS | 3592 | |4;RayTrace;1112.3470522803113 15:06:01 INFO - PROCESS | 3592 | |5;Earley;793.6507936507936 15:06:01 INFO - PROCESS | 3592 | |6;Boyer;12256.09756097561 15:06:01 INFO - PROCESS | 3592 | |7;RegExp;43446.8085106383 15:06:01 INFO - PROCESS | 3592 | |8;Splay;558.708959376739 15:06:01 INFO - PROCESS | 3592 | |9;NavierStokes;4830.917874396136 15:06:01 INFO - PROCESS | 3592 | __end_tp_report 15:06:01 INFO - PROCESS | 3592 | __startTimestamp1453331161679__endTimestamp 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | ------- Summary: start ------- 15:06:01 INFO - PROCESS | 3592 | Number of tests: 10 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#0] Richards Cycles:1 Average:168.29 Median:168.29 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 168.3 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#1] DeltaBlue Cycles:1 Average:196.50 Median:196.50 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 196.5 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#2] Encrypt Cycles:1 Average:286.37 Median:286.37 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 286.4 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 5263.2 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 1112.3 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 793.7 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 12256.1 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#7] RegExp Cycles:1 Average:43446.81 Median:43446.81 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 43446.8 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#8] Splay Cycles:1 Average:558.71 Median:558.71 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 558.7 15:06:01 INFO - PROCESS | 3592 | 15:06:01 INFO - PROCESS | 3592 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:06:01 INFO - PROCESS | 3592 | Values: 4830.9 15:06:01 INFO - PROCESS | 3592 | -------- Summary: end -------- 15:06:01 INFO - PROCESS | 3592 | 15:06:02 INFO - TEST-INFO | 3592: exit 0 15:06:02 INFO - TEST-OK | v8_7 | took 40125ms 15:06:02 INFO - SUITE-END | took 1211s 15:06:02 INFO - Completed test suite (00:20:11) 15:06:02 INFO - Working with test: dromaeo_css 15:06:02 INFO - Generating results file: dromaeo_css 15:06:02 INFO - Working with test: kraken 15:06:02 INFO - Generating results file: kraken 15:06:02 INFO - javascript benchmark 15:06:02 INFO - Working with test: v8_7 15:06:02 INFO - Generating results file: v8_7 15:06:02 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:06:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 15:06:02 INFO - process_Request line: dromaeo_css 6587.67 graph.html#tests=[[72,64,35]] 15:06:02 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:06:02 INFO - process_Request line: kraken 1504.50 graph.html#tests=[[232,64,35]] 15:06:02 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:06:02 INFO - process_Request line: v8_7 19955.45 graph.html#tests=[[230,64,35]] 15:06:02 INFO - RETURN: dromaeo_css: 6587.67 15:06:02 INFO - RETURN: kraken: 1504.50 15:06:02 INFO - RETURN: v8_7: 19955.45 15:06:02 INFO - javascript benchmark 15:06:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3013.3822566373897, 3015.5175171972483, 3052.9847350763243, 3062.6937306269374, 3067.6625571187174, 4742.0, 4809.326694262806, 4886.48691887352, 4905.215165573509, 4940.0, 4719.976400117995, 4823.252395878644, 4839.443464001641, 4841.636877234213, 4846.9030619387595, 4279.700420970534, 4435.179491794012, 4515.683902126844, 4525.886852828673, 4580.541945805426, 4433.0, 4501.932471012921, 4507.4365704286965, 4544.091181763644, 4576.931346029813, 4435.600795928366, 4456.64346852251, 4464.464264288274, 4494.438195225581, 4503.1218912312115, 4433.933490997638, 4488.618467430272, 4490.775461226958, 4512.390827238313, 4552.362669226311, 4425.181341451842, 4467.955320446787, 4475.664325175625, 4480.14877173336, 4482.484514280867, 4661.953380466186, 4663.836765713218, 4672.15901137795, 4683.7892294846815, 4708.128996135726, 5207.401148867891, 5228.738563071869, 5231.476852314776, 5234.842954711365, 5288.471152884719, 5231.136862417697, 5255.632105752599, 5260.658057226268, 5263.368395792491, 5287.206918962148, 4858.82994095205, 4922.33548470959, 4936.679115857458, 4945.851624451272, 4972.776225069881, 5327.680339179662, 5330.067238233371, 5367.731613419313, 5375.247465354853, 5381.0852155133725, 5126.384833819965, 5131.230315452637, 5139.511746384088, 5139.8458046258675, 5198.298229739013, 5174.6377753557645, 5176.327077479904, 5208.374995000624, 5229.973850130801, 5253.9211911820585, 5182.818601348935, 5198.662086964335, 5210.166373380241, 5211.2443695663915, 5216.530512253916, 5178.922316165261, 5179.989901969156, 5185.974070129625, 5187.04039752647, 5236.083685355047, 4037.1320166163828, 4104.856330028435, 4106.589341065869, 4107.9178416431505, 4111.116110036357, 3722.032271609347, 3735.701143908481, 3759.586445490994, 3775.7923314217433, 3780.3006443807985, 4875.853724388274, 4899.902001960012, 4900.828471003498, 4908.042931628298, 4953.157963146274, 5178.042062218502, 5191.714455704897, 5194.68831870089, 5200.92198617021, 5242.947570524246, 4724.456687480915, 4853.296272040534, 4870.488598697157, 4878.243872199815, 4880.731559764176, 4525.570070843265, 4526.615237704832, 4544.341070544752, 4571.085782843445, 4575.862724118282, 5392.946070539323, 5396.568274538027, 5397.271368365299, 5397.8380648580605, 5398.1362981923485, 5150.562202212704, 5210.713410762444, 5213.791448342024, 5229.398619158846, 5254.894902102013, 5301.761420735999, 5316.973415132899, 5323.920141197963, 5344.946550534445, 5417.241586178017, 5155.252488389087, 5159.561437277874, 5163.6127290454115, 5165.147750621106, 5202.375714914235, 5179.22311653255, 5221.765020574007, 5234.084035293732, 5251.159814429673, 5303.4696530346655, 5094.337736094284, 5110.105731497048, 5112.258722485293, 5113.795448182031, 5117.002184573972, 5108.872278192926, 5110.48895110486, 5122.257272695364, 5123.743812809419, 5160.535551800356, 4960.627952903619, 4985.8005679772405, 5018.04657115147, 5051.873703157304, 5098.719570423514, 5094.337736094284, 5114.693118412907, 5118.641695081308, 5118.948810511847, 5133.486651334837, 4952.900941981068, 5033.697978121324, 5035.0, 5038.445770965264, 5044.167712327425], "unit": "score", "name": "dojo.html", "value": 4831.964948429139}, {"lowerIsBetter": false, "replicates": [563.67588636534, 564.0889962710224, 568.5622071005326, 578.1068249554436, 578.7771707892462, 29201.853990730044, 29788.851055744744, 34691.95924122277, 34776.0, 34912.476312855324, 37770.62229377705, 38167.427488587695, 38172.42741358882, 38202.23595528088, 38217.235655286946, 8491.872621910676, 8766.824663506726, 8786.472811631322, 8788.34087443441, 8791.868121978176, 8420.957895210515, 8538.786530336729, 8540.78648033798, 8543.658253669846, 8555.315574754035, 8546.70086546971, 8623.051464338918, 8625.95687021564, 8626.956865215665, 8638.697645582406, 8351.874721879176, 8379.62291696875, 8389.32885369169, 8401.873971890427, 8408.453450525727, 8355.749327520183, 8496.447730897471, 8497.532635705034, 8498.532580708059, 8498.575071246412, 38595.42106868371, 39156.21687566233, 39172.21655566901, 39212.84329361884, 39222.21555568872, 3175.6983086606965, 3198.856051477689, 3236.7572432067454, 3536.381133301662, 3827.100631351658, 26305.210843674722, 26492.205233843015, 26567.468650627074, 26603.334916627045, 27319.0, 3363.5795525559306, 3365.932681346384, 3366.293078453528, 3408.9438743517812, 3460.2733425980573, 211119.0, 213147.0, 214248.0, 214413.0, 214521.0, 52892.73553632284, 53228.0, 53728.73135634297, 59689.70155149196, 60370.698146509865, 53903.19145212825, 53954.460455395725, 54103.0, 54133.72933135309, 54260.18609720857, 13248.73502529944, 14246.857531424761, 14378.640533986525, 14397.78403323951, 14564.927175364055, 9216.124468175512, 10392.324498907547, 10495.475226238657, 10544.314619549705, 10547.103496202755, 18912.527186820163, 18944.71582926257, 19695.409137725892, 19696.40910772679, 19697.21211151538, 7628.313451789366, 7835.412344074217, 7889.48718333318, 7957.1644977276555, 8021.919780802234, 852.9829403411896, 901.5492253873064, 953.537534295866, 954.5704433005176, 1124.095103441721, 27942.3014424641, 28228.0, 28423.0, 28586.714132858822, 28709.0, 1049.459528342904, 1101.388729255271, 1129.1587767113554, 1132.4903793293051, 1145.3128123126057, 14802.407903683732, 14811.0, 14895.659390654893, 14957.0, 14968.0, 317177.0, 321995.0, 322404.81963852805, 322610.0, 324152.0, 49909.0, 50331.74834125806, 50361.496385036415, 50462.495375046514, 50514.0, 1197.3713800254761, 1238.5107882386408, 1261.2495565138727, 1346.2730125731996, 1366.8086467894502, 25835.0, 27295.181144565693, 27536.724632753416, 27834.0, 28004.85997569999, 40005.59994400019, 40263.19473610453, 40299.395509067974, 44406.77796610996, 44832.0, 286567.0, 289708.0, 291979.0, 292194.0, 292955.0, 28277.858610706815, 28877.71122288834, 28898.566521501773, 28899.42201155923, 28906.855465722536, 40749.1850163001, 41446.1710765789, 41811.37282940819, 41875.162496750505, 42256.0, 35087.47368789521, 35125.12187195341, 35479.0, 36162.4575631371, 36531.634683652825, 35208.82395588108, 35644.0, 35928.46107308445, 36179.0, 36344.27311453809, 35636.0, 38058.238835223696, 38584.0, 38667.0, 38721.41917871178, 29528.557071644373, 31677.0, 32751.34497310088, 32808.67191328056, 32829.34341313208, 24552.526848389152, 25027.87486062558, 25057.617221674842, 25153.74846251514, 25282.620760688238], "unit": "score", "name": "ext.html", "value": 17674.52838243201}, {"lowerIsBetter": false, "replicates": [360.2614639988024, 360.2956220588749, 363.9690626296763, 366.55829725181155, 367.896988843124, 12864.871351286485, 13095.803562946563, 15477.303521341539, 16775.24511396987, 17922.0, 10534.894651053488, 12628.494860205603, 13478.730425391486, 13488.055836091478, 13495.448023477304, 4830.372051633282, 4964.503549645043, 4970.403551573798, 4971.477994810547, 4971.651984361096, 3765.0963768695588, 3912.4913761211, 4909.042736666352, 4975.776090075937, 5177.585793136559, 5298.814541491049, 5359.035373632764, 5362.731863406814, 5370.516653501184, 5387.838364849041, 5207.791688332462, 5427.240186373911, 5438.564914806806, 5440.183972404131, 5446.591505637053, 5035.84892453227, 5234.319538460014, 5236.423993360727, 5241.816536421207, 5249.186376111708, 12724.427400766988, 12904.419301131471, 12904.54834080812, 15526.456574019969, 19874.70187947182, 2020.5857799151138, 2031.3601215617034, 2057.0, 2144.6997420361163, 2157.482204270964, 9711.320207585472, 10817.675469735921, 11005.229633925628, 12540.498380064786, 13096.607101786962, 1793.6681713882974, 1802.1710013393854, 1814.5554339186983, 1847.048769883511, 1869.5419622192514, 51753.74123129398, 52995.205071924334, 53839.46160538384, 54416.455835441535, 54831.725841370935, 9778.951105244429, 9950.35322704022, 10057.849132263022, 10084.394936303845, 10135.493225338703, 13139.802902956464, 13341.332933353293, 13353.73292534144, 13380.933095334656, 13383.799243011363, 7006.474514411338, 7015.298470152944, 7045.7181712731945, 7163.31948464895, 7288.635568221674, 6575.539712220194, 6699.832504187434, 6766.342246149725, 6840.41856442208, 6865.691043903036, 4318.978405108017, 4386.824527018884, 4395.208862404734, 4428.889277768081, 4437.42313499243, 1714.7342161964916, 1739.199968014702, 1768.2661695396266, 1782.3583509936414, 1815.3646223821556, 899.321012635456, 934.2152591822901, 970.9998701337634, 979.6081567373108, 1008.0625018732649, 13756.65608359779, 14249.145051296955, 15454.613634659, 15509.0, 15802.920985395229, 900.9954950225207, 948.2224575847877, 964.7250533597891, 964.8697425847421, 970.6651205334149, 8911.15344042315, 9227.953860230657, 9273.53632318395, 9325.487098209664, 9474.715758527254, 385241.0, 390721.0, 396630.2190357618, 548496.0, 548986.0, 61578.0763288551, 65750.34249657538, 71415.64292178505, 71991.64004179946, 72974.63512682403, 1086.3047649504324, 1115.3642423818508, 1128.0991529273201, 1130.9830352544718, 1143.588308209044, 14354.3540540678, 14444.133351998913, 14842.628934276729, 14961.476348327757, 15406.614834629225, 29774.404511910074, 30275.848620756755, 30803.0, 31083.0, 33875.0, 34324.48513272353, 34900.65099349076, 35063.29873402569, 35125.47311790376, 35334.46998294976, 6977.232504424408, 7032.12098487689, 7118.9644051779405, 7197.316254955771, 7310.159331676925, 10205.183585313305, 10466.16270698327, 10556.261061725605, 10595.0, 11089.445527723743, 9437.339386242897, 9548.092931171528, 9609.807803843743, 9631.325807193709, 9657.93762686118, 9568.282378821756, 9581.329306948446, 9600.279979001743, 9739.756506087404, 9780.41317520951, 7337.559746415232, 8617.741467755977, 8975.2371048459, 9744.464054477072, 9747.610095596381, 7241.384482319062, 7299.124105107421, 7340.96329518349, 7453.664585093576, 7456.701731930879, 8643.308535317034, 8879.733607991771, 9077.636894524145, 9620.422774633544, 9833.508324583885], "unit": "score", "name": "jquery.html", "value": 7784.646413839028}, {"lowerIsBetter": false, "replicates": [1295.5530342032007, 1425.565202613203, 1438.388684808956, 1542.3290868472216, 1715.6568686262742, 6380.361963803617, 6927.688254028568, 7084.220735719066, 7084.397826184781, 7127.572345659264, 6839.11091558098, 6994.440444764419, 7019.543729657581, 7021.262767409425, 7024.2273349931465, 1907.3133671878113, 1929.8166674165932, 2218.4675677837363, 2237.7202849643795, 2267.614505534063, 2185.8907054647284, 2213.8893055347166, 2216.1689366487567, 2217.168561789329, 2218.1016688241207, 2130.4034870236283, 2226.7105276314137, 2230.9776902230933, 2237.1163390460756, 2237.407087121906, 2178.063432723928, 2198.923037693673, 2215.1693115081844, 2225.3880182949656, 2228.732552093751, 2168.013553833018, 2168.4036889855415, 2190.58378908007, 2200.4058904095805, 2209.7569267380577, 6741.865162696768, 6780.7287708492095, 6783.0, 6789.0, 6802.081718967926, 4466.3523789050405, 4507.098580283956, 4510.503844577094, 4511.503734589192, 4517.548245175489, 2961.7926745127847, 3010.8795648174046, 3060.32672811981, 3069.0, 3084.845757712128, 965.3821554205314, 969.8933117357085, 987.1263931420673, 1000.4247557654378, 1002.5187909803335, 9394.201492873113, 9473.526323683856, 9474.763130921645, 9477.28920330978, 9490.0, 4031.75809451428, 4040.5151381834366, 4122.484689413824, 4176.895577610523, 4179.226843034048, 8442.957785211034, 8457.40798144124, 8458.027326857367, 8465.57672116404, 8493.023302320189, 4589.747563884019, 4604.585587297092, 4627.421572303462, 4642.79107440166, 4643.3963584733765, 4201.831926722897, 4204.8528301509305, 4218.1985422770185, 4229.577042295746, 4277.764722940268, 3335.366280406715, 3342.415077361452, 3367.2087059540986, 3517.419625761772, 3558.6085530591613, 1142.765733024728, 1205.2647884790272, 1211.2248161176854, 1213.6298428979069, 1224.0024380130164, 1027.1166796554958, 1027.7225149209671, 1202.5430336472084, 1235.71578536937, 1258.5532136091556, 6390.936090639034, 6394.71223794921, 6396.968015159894, 6414.037894315797, 6467.773627923, 1062.134360496193, 1067.1569460126414, 1070.550368845087, 1095.0691911874842, 1118.43578198462, 5194.0, 5248.475152484797, 5252.868678282997, 5266.2890509781455, 5272.0, 8180.672773089129, 8227.13615070409, 8232.053313868983, 8266.0, 8552.10202928696, 8130.878036829452, 8149.511029338259, 8150.062742784656, 8448.07071222165, 8479.152084791594, 6733.7306507741105, 6777.1189745332795, 6887.173539175331, 6906.482013848981, 6918.757843475454, 6595.472362211108, 6604.900926486011, 6642.335766423513, 6642.734290628321, 6647.135872336566, 7623.4663573549315, 7742.458027937991, 7762.573058481612, 7766.0, 7784.260495252942, 7294.234105418855, 7361.8159546011775, 7371.041764570786, 7950.920490795018, 8146.75559733209, 6423.132877061536, 6526.477881769352, 6539.574927629689, 6606.108175396452, 6624.6025238485845, 6031.60794548353, 6284.528660350401, 6409.134766806422, 6417.711202995783, 6618.437432818265, 6078.513718902389, 6153.292371377349, 6274.403931626488, 6321.778737744341, 6357.745690172342, 6074.757009719562, 6175.135481032569, 6217.285012223471, 6267.874642507033, 6288.937110628835, 6061.605995610271, 6140.907886381798, 6146.631202127886, 6192.195014648067, 6275.0, 5679.77280908759, 5707.229524014205, 5715.999700052557, 5916.171735956884, 5927.436893495111, 5465.918011229915, 5773.53811695055, 5791.0, 5822.82531524055, 5833.941660583339], "unit": "score", "name": "mootools.html", "value": 4174.131615394746}, {"lowerIsBetter": false, "replicates": [323.35490696061373, 324.9203945033467, 325.0670575448463, 329.7526854858856, 335.7767084888549, 5816.418358164182, 5858.20914176586, 5883.794067207648, 5903.970480147594, 5933.673647949361, 5528.419515950827, 5634.295713035871, 5638.295213098363, 5641.68970706611, 5787.652740835553, 4456.952616135214, 4461.977690111545, 4482.058767658796, 4489.2817149256125, 4498.460184777831, 4480.932786008212, 4481.058977614704, 4482.417285752864, 4485.506594274627, 4499.122671079141, 4248.447701798762, 4356.607905288523, 4369.519352871182, 4474.731516109044, 4494.16857881293, 4466.709663871838, 4472.546422412713, 4475.686701930867, 4492.2812350024005, 4493.4832494263255, 3954.7231693781446, 3958.247932892741, 3964.623360780721, 3964.960350396517, 3967.523897132334, 5581.162825576155, 5593.105103183471, 5598.216249725042, 5599.356074051455, 5606.159076138571, 5104.336436263299, 5216.0, 5225.503577160163, 5229.686218826882, 5230.816921407771, 6150.66171360575, 6155.476784473325, 6155.969220153916, 6156.969215153896, 6158.630482171084, 4397.538258482845, 4403.119376124788, 4403.955960440387, 4406.25093734066, 4412.536683648203, 6271.560990730651, 6454.612723236621, 6458.806235812933, 6464.191976003, 6464.51516136287, 4503.144402563568, 4503.504614492404, 4506.301523263899, 4507.5943165115295, 4508.18852606534, 4561.156186105581, 4564.0871825635, 4564.3153526970555, 4565.657575681771, 4567.543245675406, 5150.8969820604125, 5173.379194496609, 5180.274761533388, 5184.196449550251, 5198.454162312903, 6061.939380606225, 6216.098665693449, 6217.658028808369, 6222.751089956441, 6231.875362492725, 1593.4900831733735, 1612.1455628516906, 1613.6530645911184, 1615.055192712253, 1616.0303817709516, 1064.6912395405245, 1094.715374002765, 1097.665212110314, 1104.0339702760084, 1114.676743744305, 5914.792982245601, 5939.970300148558, 5952.613080149863, 5957.434043765836, 5961.672108034099, 6407.615543067338, 6437.420632143129, 6445.484361251182, 6447.806565803034, 6460.0, 5706.80026199081, 5772.365039845614, 5809.651420914674, 5885.911711324334, 5937.643741375531, 3432.845521951518, 3450.4306789379975, 3457.5159477673146, 3465.9480107798404, 3466.705330046924, 6641.435477984329, 6674.899876501856, 6780.559263647847, 6783.966080169567, 6791.626460544619, 6358.936410635834, 6600.8349791255605, 6621.834454138589, 6625.536212465177, 6650.3349665034075, 6802.115724955724, 6806.8638627228165, 6815.829604259933, 6817.761378351634, 6821.488388370892, 6428.871422571616, 6435.195600549931, 6490.870182596227, 6493.707783149675, 6513.837154071186, 6272.686365681789, 6379.52153588492, 6385.648789316632, 6472.741090356333, 6483.0, 6760.174752816613, 6775.4240889524945, 6777.457803375817, 6779.35596118368, 6799.796006119825, 4395.318725597537, 4412.051408947092, 4444.044530425845, 4447.0, 4450.1767173073085, 6341.7780377688405, 6460.224773027267, 6472.967635161794, 6498.577592456475, 6503.089567460464, 6230.847293250763, 6333.746650134128, 6348.555601107878, 6402.103705481143, 6423.229212494531, 6363.3636636336, 6376.234851817626, 6389.808305750835, 6396.840078997876, 6405.263394709668, 6099.542534309856, 6213.596116252429, 6220.284667263322, 6226.937730622636, 6229.065640154013, 6363.0, 6370.1718776558755, 6433.099366088845, 6441.742330306923, 6442.710078046593, 6220.502359811295, 6222.377762223741, 6225.8132256032395, 6229.53278504123, 6230.937690623217], "unit": "score", "name": "prototype.html", "value": 4723.7012376016155}, {"lowerIsBetter": false, "replicates": [742.528494406052, 748.9925100748994, 809.453618807305, 812.9918700812992, 834.585045111361, 13011.219326840384, 13162.605121846336, 13164.47342106317, 13185.934070329635, 13196.604101876947, 12414.875851241484, 12483.188592741466, 12508.186967847083, 12516.123871328988, 12557.183783054117, 660.5871330418488, 673.3603077076797, 807.4751411582489, 823.983520329593, 823.983520329593, 801.2268161224417, 805.0621026504145, 806.4234072638062, 808.0505406147753, 808.6522795198063, 689.2590465249851, 848.1306660672828, 854.0264098927228, 854.9529775862325, 855.1662129423825, 692.127918822285, 836.9497830130181, 849.0448245723561, 854.3421565394674, 854.8461276970143, 629.0689779126872, 629.072118625029, 629.26061877294, 629.339193846464, 629.4586655476287, 13048.739025219538, 13098.738025239538, 13103.672408189776, 13109.934450327783, 13125.409356578977, 12146.514139434412, 12642.431090600945, 12859.292738899358, 12904.290264035475, 13050.477980880753, 10506.78986420275, 10516.68449946503, 10554.050135487843, 10621.57513699451, 10953.0, 3597.7661452005536, 3634.745567810254, 3680.963190368089, 3697.7411581189326, 3765.9246815063543, 47207.76396118032, 48911.0, 48998.51001489975, 49061.0, 49347.50652493465, 9421.76445588852, 9812.215022798158, 9817.116459518678, 9967.700968970943, 10023.448710321003, 18833.811661883206, 18883.150258238413, 18890.81109188918, 18934.147963341682, 18953.147108380155, 7703.3067023968115, 7716.5370077795515, 7758.185390534026, 7823.100343460461, 7928.048634163937, 4306.82772689089, 4343.478782546052, 4354.978225108917, 4393.7363758174615, 4406.867793966187, 2980.493316136262, 3020.2600362911226, 3021.0634703242067, 3031.8787248510253, 3034.742046926036, 515.6983164848606, 517.0486305198377, 527.6069328350403, 528.0837746509802, 540.6728928997978, 651.7165033210568, 664.9394216225113, 668.6857177126743, 675.9831004224835, 694.6387878303356, 9004.406158720625, 9434.811303773886, 9455.19630831387, 9547.093026162504, 9575.760605984906, 542.4223202289548, 568.5877738639535, 600.1365759317257, 643.5109316919081, 645.6384424722171, 3954.426608141803, 4022.577629348935, 4051.2707712612014, 4067.6745860331102, 4152.273352163359, 48944.0, 49898.25152622713, 55320.446795532334, 56016.159757603666, 56058.0, 43799.56200437955, 44936.10127797426, 45223.0, 45484.77257613691, 45495.54504454979, 39532.80233598871, 40063.59936400657, 40544.18911621751, 40733.0, 41067.0, 8853.557322133738, 8983.595738191667, 9095.544712845913, 9131.543422828965, 9181.449113053239, 32415.189620259684, 33170.66829331772, 33276.500852486744, 33403.498947516295, 33780.324393512485, 40888.59111408848, 41986.0, 43014.0, 45047.0, 46576.7671161642, 11098.389588572383, 11148.498317575892, 11300.321980681185, 11470.254433461798, 11517.654470365902, 12494.625161245178, 12526.624201273977, 12557.74884502323, 13191.620211478763, 13343.771659942913, 10499.160067194758, 10778.89221107779, 10816.18878584125, 10950.94524527404, 11602.361870097226, 11311.886881131413, 11753.529858805552, 11857.229280096766, 11926.330912283765, 12312.445939932546, 11140.275882067639, 11408.486618102039, 11591.0, 11966.46150923228, 12007.639770806889, 9109.635614575343, 9222.262219022328, 9257.537123143951, 9499.667511637059, 9626.133647971716, 9151.679691210775, 9545.570449329658, 9675.70972870815, 10069.90778545686, 10081.362573216402], "unit": "score", "name": "yui.html", "value": 6234.374759995434}], "name": "dromaeo_css", "value": 6587.6732199481985}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 106.0, 110.0, 109.0, 111.0, 111.0, 111.0, 103.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 152.0, 164.0, 124.0, 150.0, 156.0, 131.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 101.0, 92.0, 76.0, 73.0, 74.0, 117.0, 101.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 142.0, 95.0, 95.0, 96.0, 138.0, 95.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 111.0, 109.0, 110.0, 111.0, 112.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 56.0, 57.0, 59.0, 59.0, 57.0, 71.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 69.0, 70.0, 68.0, 67.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 82.0, 83.0, 83.0, 88.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 117.0, 113.0, 119.0, 114.0, 125.0, 115.0, 117.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.7}, {"lowerIsBetter": true, "replicates": [147.0, 139.0, 144.0, 144.0, 148.0, 144.0, 144.0, 144.0, 143.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [68.0, 75.0, 69.0, 68.0, 72.0, 69.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1504.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.29350387075058], "unit": "score", "name": "Richards", "value": 209.76448399999992}, {"lowerIsBetter": false, "replicates": [196.50225977598743], "unit": "score", "name": "DeltaBlue", "value": 336.4745019999999}, {"lowerIsBetter": false, "replicates": [286.368843069874], "unit": "score", "name": "Encrypt", "value": 929.5040519999998}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [793.6507936507936], "unit": "score", "name": "Earley", "value": 839.7433799999998}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [43446.8085106383], "unit": "score", "name": "RegExp", "value": 20.967823212536747}, {"lowerIsBetter": false, "replicates": [558.708959376739], "unit": "score", "name": "Splay", "value": 145.8559033864542}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19955.447332633223}]} 15:06:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19955.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6587.67"}}} 15:06:02 INFO - Return code: 0 15:06:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:06:02 INFO - # TBPL SUCCESS # 15:06:02 INFO - Running post-action listener: _resource_record_post_action 15:06:02 INFO - Running post-run listener: _resource_record_post_run 15:06:04 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539488256; Read time: 392; Write time: 471668 15:06:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237375488; Read time: 228; Write time: 292880 15:06:04 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302112768; Read time: 164; Write time: 178788 15:06:04 INFO - Running post-run listener: _upload_blobber_files 15:06:04 INFO - Blob upload gear active. 15:06:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:06:04 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 15:06:04 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'] 15:06:04 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 15:06:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:06:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:06:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:05 INFO - (blobuploader) - INFO - Done attempting. 15:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:06:06 INFO - (blobuploader) - INFO - Done attempting. 15:06:06 INFO - (blobuploader) - INFO - Iteration through files over. 15:06:06 INFO - Return code: 0 15:06:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:06:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:06:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e082948f8c4fef4d268e943a131dfe4de5e76a6ca04efb4367323d9475efc1cd452f5234429426a0fa69596614a43413cb7a2577ea52b25700bc3dd9f54b5f73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb9b2e9d575e8cd23545892744bafc5d41203e71b60435fd2f27454871cff8c2dc85f620ce8d5e7c458e0f5631c9d526ba84e263bc072362a69ca7a5c0752051"} 15:06:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:06:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:06:06 INFO - Contents: 15:06:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e082948f8c4fef4d268e943a131dfe4de5e76a6ca04efb4367323d9475efc1cd452f5234429426a0fa69596614a43413cb7a2577ea52b25700bc3dd9f54b5f73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb9b2e9d575e8cd23545892744bafc5d41203e71b60435fd2f27454871cff8c2dc85f620ce8d5e7c458e0f5631c9d526ba84e263bc072362a69ca7a5c0752051"} 15:06:06 INFO - Running post-run listener: copy_logs_to_upload_dir 15:06:06 INFO - Copying logs to upload dir... 15:06:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:06:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.478227 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-20 15:06:05.591035) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 15:06:05.594757) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e082948f8c4fef4d268e943a131dfe4de5e76a6ca04efb4367323d9475efc1cd452f5234429426a0fa69596614a43413cb7a2577ea52b25700bc3dd9f54b5f73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb9b2e9d575e8cd23545892744bafc5d41203e71b60435fd2f27454871cff8c2dc85f620ce8d5e7c458e0f5631c9d526ba84e263bc072362a69ca7a5c0752051"} build_url:https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/Rs9pT6FCQFSuLg1JuCwulw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e082948f8c4fef4d268e943a131dfe4de5e76a6ca04efb4367323d9475efc1cd452f5234429426a0fa69596614a43413cb7a2577ea52b25700bc3dd9f54b5f73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb9b2e9d575e8cd23545892744bafc5d41203e71b60435fd2f27454871cff8c2dc85f620ce8d5e7c458e0f5631c9d526ba84e263bc072362a69ca7a5c0752051"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-20 15:06:05.618962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 15:06:05.619245) ========= 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=0e2a256762fed810e2f0f810000001b3-1453329898.602267-796102170 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-20 15:06:05.703242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 15:06:05.703561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-20 15:06:05.703849) ========= ========= Total master_lag: 0.28 =========