builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1453445413.86 results: success (0) buildid: 20160121203058 builduid: 0abbd13d6fed46a7872d4981bd27bd29 revision: a45569eb51d7bb63602a80802f98b450b77ae9d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.862500) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.863356) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.863712) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006303 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.888456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.888827) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.903073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.903555) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.955977) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.956661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.957548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:13.958206) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 22:50:14-- 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% 30.4M=0s 2016-01-21 22:50:14 (30.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102507 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.074405) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.074782) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.127000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.127438) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a45569eb51d7bb63602a80802f98b450b77ae9d5 --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 a45569eb51d7bb63602a80802f98b450b77ae9d5 --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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 22:50:14,491 truncating revision to first 12 chars 2016-01-21 22:50:14,491 Setting DEBUG logging. 2016-01-21 22:50:14,491 attempt 1/10 2016-01-21 22:50:14,491 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a45569eb51d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 22:50:14,744 unpacking tar archive at: fx-team-a45569eb51d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.552993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.694522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.694917) ========= echo a45569eb51d7bb63602a80802f98b450b77ae9d5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a45569eb51d7bb63602a80802f98b450b77ae9d5'] 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a45569eb51d7bb63602a80802f98b450b77ae9d5 program finished with exit code 0 elapsedTime=0.003881 script_repo_revision: 'a45569eb51d7bb63602a80802f98b450b77ae9d5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.744882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.745250) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 22:50:14.758790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-21 22:50:14.759189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:50:15 INFO - MultiFileLogger online at 20160121 22:50:15 in /builds/slave/test-pgo 22:50:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:50:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:50:15 INFO - {'append_to_log': False, 22:50:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:50:15 INFO - 'blob_upload_branch': 'Fx-Team', 22:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:50:15 INFO - 'branch': 'Fx-Team', 22:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:50:15 INFO - 'config_files': ('talos/linux_config.py',), 22:50:15 INFO - 'default_actions': ('clobber', 22:50:15 INFO - 'read-buildbot-config', 22:50:15 INFO - 'download-and-extract', 22:50:15 INFO - 'populate-webroot', 22:50:15 INFO - 'create-virtualenv', 22:50:15 INFO - 'install', 22:50:15 INFO - 'run-tests'), 22:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:50:15 INFO - 'download_minidump_stackwalk': True, 22:50:15 INFO - 'download_symbols': 'ondemand', 22:50:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:50:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:50:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:50:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:50:15 INFO - 'installer_path': 'installer.exe', 22:50:15 INFO - 'log_level': 'info', 22:50:15 INFO - 'log_name': 'talos', 22:50:15 INFO - 'log_to_console': True, 22:50:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:50:15 INFO - 'opt_config_files': (), 22:50:15 INFO - 'pip_index': False, 22:50:15 INFO - 'sps_profile': False, 22:50:15 INFO - 'sps_profile_interval': 0, 22:50:15 INFO - 'suite': 'dromaeojs-e10s', 22:50:15 INFO - 'system_bits': '32', 22:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:50:15 INFO - 'title': 'talos-linux64-ix-050', 22:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:50:15 INFO - 'use_talos_json': True, 22:50:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:50:15 INFO - 'work_dir': 'build'} 22:50:15 INFO - ##### 22:50:15 INFO - ##### Running clobber step. 22:50:15 INFO - ##### 22:50:15 INFO - Running pre-action listener: _resource_record_pre_action 22:50:15 INFO - Running main action method: clobber 22:50:15 INFO - rmtree: /builds/slave/test-pgo/build 22:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:50:16 INFO - Running post-action listener: _resource_record_post_action 22:50:16 INFO - ##### 22:50:16 INFO - ##### Running read-buildbot-config step. 22:50:16 INFO - ##### 22:50:16 INFO - Running pre-action listener: _resource_record_pre_action 22:50:16 INFO - Running main action method: read_buildbot_config 22:50:16 INFO - Using buildbot properties: 22:50:16 INFO - { 22:50:16 INFO - "project": "", 22:50:16 INFO - "product": "firefox", 22:50:16 INFO - "script_repo_revision": "production", 22:50:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:50:16 INFO - "repository": "", 22:50:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:50:16 INFO - "buildid": "20160121203058", 22:50:16 INFO - "pgo_build": "True", 22:50:16 INFO - "basedir": "/builds/slave/test-pgo", 22:50:16 INFO - "buildnumber": 231, 22:50:16 INFO - "slavename": "talos-linux64-ix-050", 22:50:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:50:16 INFO - "platform": "ubuntu64_hw", 22:50:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:50:16 INFO - "branch": "fx-team", 22:50:16 INFO - "repo_path": "integration/fx-team", 22:50:16 INFO - "revision": "a45569eb51d7bb63602a80802f98b450b77ae9d5", 22:50:16 INFO - "stage_platform": "linux64-pgo", 22:50:16 INFO - "builduid": "0abbd13d6fed46a7872d4981bd27bd29", 22:50:16 INFO - "slavebuilddir": "test" 22:50:16 INFO - } 22:50:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:50:16 INFO - Running post-action listener: _resource_record_post_action 22:50:16 INFO - ##### 22:50:16 INFO - ##### Running download-and-extract step. 22:50:16 INFO - ##### 22:50:16 INFO - Running pre-action listener: _resource_record_pre_action 22:50:16 INFO - Running main action method: download_and_extract 22:50:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:16 INFO - https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/test_packages.json 22:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/test_packages.json 22:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:50:16 INFO - Downloaded 1448 bytes. 22:50:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:50:16 INFO - Using the following test package requirements: 22:50:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:50:16 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:50:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'jsshell-linux-x86_64.zip'], 22:50:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:50:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:50:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:50:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:50:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:50:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:50:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:50:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:16 INFO - https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:50:17 INFO - Downloaded 22487016 bytes. 22:50:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:50:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:50:19 INFO - Return code: 0 22:50:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:19 INFO - https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:50:21 INFO - Downloaded 22487016 bytes. 22:50:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:50:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:50:22 INFO - Return code: 0 22:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:22 INFO - https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:50:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:50:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:50:24 INFO - Downloaded 10706572 bytes. 22:50:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:50:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:50:24 INFO - Return code: 0 22:50: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')]} 22:50:24 INFO - https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:50:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:50:27 INFO - Downloaded 55959583 bytes. 22:50:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:27 INFO - mkdir: /builds/slave/test-pgo/properties 22:50:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:50:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:50:27 INFO - Contents: 22:50:27 INFO - build_url:https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:50:27 INFO - Running post-action listener: _resource_record_post_action 22:50:27 INFO - Running post-action listener: set_extra_try_arguments 22:50:27 INFO - ##### 22:50:27 INFO - ##### Running populate-webroot step. 22:50:27 INFO - ##### 22:50:27 INFO - Running pre-action listener: _resource_record_pre_action 22:50:27 INFO - Running main action method: populate_webroot 22:50:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:50:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:50:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:50:27 INFO - '--tppagecycles', 22:50:27 INFO - '7'], 22:50:27 INFO - 'tests': ['tsvgm']}}, 22:50:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:50:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:50:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:50:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:50:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:50:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:50:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'tests': ['damp', 'tps']}, 22:50:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['damp', 'tps']}, 22:50:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:50:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:50:27 INFO - 'other': {'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'other_l64': {'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'other_nol64': {'tests': ['a11yr', 22:50:27 INFO - 'ts_paint', 22:50:27 INFO - 'tpaint', 22:50:27 INFO - 'sessionrestore', 22:50:27 INFO - 'sessionrestore_no_auto_restore']}, 22:50:27 INFO - 'svgr': {'tests': ['tsvgx', 22:50:27 INFO - 'tsvgr_opacity', 22:50:27 INFO - 'tart', 22:50:27 INFO - 'tscrollx', 22:50:27 INFO - 'cart']}, 22:50:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['tsvgx', 22:50:27 INFO - 'tsvgr_opacity', 22:50:27 INFO - 'tart', 22:50:27 INFO - 'tscrollx', 22:50:27 INFO - 'cart']}, 22:50:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'tests': ['tp5o']}, 22:50:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'talos_options': ['--e10s'], 22:50:27 INFO - 'tests': ['tp5o']}, 22:50:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'talos_options': ['--xperf_path', 22:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:50:27 INFO - 'tests': ['tp5n']}, 22:50:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:50:27 INFO - 'talos_options': ['--e10s', 22:50:27 INFO - '--xperf_path', 22:50:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:50:27 INFO - 'tests': ['tp5n']}}, 22:50:27 INFO - 'talos.zip': {'path': '', 22:50:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:50:27 INFO - Running post-action listener: _resource_record_post_action 22:50:27 INFO - ##### 22:50:27 INFO - ##### Running create-virtualenv step. 22:50:27 INFO - ##### 22:50:27 INFO - Running pre-action listener: _resource_record_pre_action 22:50:27 INFO - Running main action method: create_virtualenv 22:50:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:50:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:50:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:50:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:50:27 INFO - Using real prefix '/usr' 22:50:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:50:28 INFO - Installing distribute.............................................................................................................................................................................................done. 22:50:30 INFO - Installing pip.................done. 22:50:30 INFO - Return code: 0 22:50:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:50: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 pip>=1.5 22:50:30 INFO - Using env: {'DISPLAY': ':0', 22:50:30 INFO - 'HOME': '/home/cltbld', 22:50:30 INFO - 'LANG': 'en_US.UTF-8', 22:50:30 INFO - 'LANGUAGE': 'en_US:en', 22:50:30 INFO - 'LOGNAME': 'cltbld', 22:50:30 INFO - 'MAIL': '/var/mail/cltbld', 22:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:30 INFO - 'MOZ_NO_REMOTE': '1', 22:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:30 INFO - 'NO_EM_RESTART': '1', 22:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:30 INFO - 'SHELL': '/bin/bash', 22:50:30 INFO - 'SHLVL': '1', 22:50:30 INFO - 'TERM': 'linux', 22:50:30 INFO - 'TMOUT': '86400', 22:50:30 INFO - 'USER': 'cltbld', 22:50:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:30 INFO - '_': '/tools/buildbot/bin/python'} 22:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:50:30 INFO - Cleaning up... 22:50:30 INFO - Return code: 0 22:50:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50: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', '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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:50: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 psutil>=0.7.1 22:50:30 INFO - Using env: {'DISPLAY': ':0', 22:50:30 INFO - 'HOME': '/home/cltbld', 22:50:30 INFO - 'LANG': 'en_US.UTF-8', 22:50:30 INFO - 'LANGUAGE': 'en_US:en', 22:50:30 INFO - 'LOGNAME': 'cltbld', 22:50:30 INFO - 'MAIL': '/var/mail/cltbld', 22:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:30 INFO - 'MOZ_NO_REMOTE': '1', 22:50:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:30 INFO - 'NO_EM_RESTART': '1', 22:50:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:30 INFO - 'SHELL': '/bin/bash', 22:50:30 INFO - 'SHLVL': '1', 22:50:30 INFO - 'TERM': 'linux', 22:50:30 INFO - 'TMOUT': '86400', 22:50:30 INFO - 'USER': 'cltbld', 22:50:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:30 INFO - '_': '/tools/buildbot/bin/python'} 22:50:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:30 INFO - Downloading/unpacking psutil>=0.7.1 22:50: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 22:50: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 22:50: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 22:50: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 22:50: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 22:50: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 22:50:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:32 INFO - Installing collected packages: psutil 22:50:32 INFO - Running setup.py install for psutil 22:50:32 INFO - building 'psutil._psutil_linux' extension 22:50:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:50:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:50:32 INFO - building 'psutil._psutil_posix' extension 22:50:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:50:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:50:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:50:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:50:32 INFO - Successfully installed psutil 22:50:32 INFO - Cleaning up... 22:50:32 INFO - Return code: 0 22:50:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:32 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:50:32 INFO - Using env: {'DISPLAY': ':0', 22:50:32 INFO - 'HOME': '/home/cltbld', 22:50:32 INFO - 'LANG': 'en_US.UTF-8', 22:50:32 INFO - 'LANGUAGE': 'en_US:en', 22:50:32 INFO - 'LOGNAME': 'cltbld', 22:50:32 INFO - 'MAIL': '/var/mail/cltbld', 22:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:32 INFO - 'MOZ_NO_REMOTE': '1', 22:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:32 INFO - 'NO_EM_RESTART': '1', 22:50:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:32 INFO - 'SHELL': '/bin/bash', 22:50:32 INFO - 'SHLVL': '1', 22:50:32 INFO - 'TERM': 'linux', 22:50:32 INFO - 'TMOUT': '86400', 22:50:32 INFO - 'USER': 'cltbld', 22:50:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:32 INFO - '_': '/tools/buildbot/bin/python'} 22:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:50: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 22:50: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 22:50: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 22:50: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 22:50: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 22:50: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 22:50:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:50:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:50:34 INFO - Installing collected packages: mozsystemmonitor 22:50:34 INFO - Running setup.py install for mozsystemmonitor 22:50:34 INFO - Successfully installed mozsystemmonitor 22:50:34 INFO - Cleaning up... 22:50:34 INFO - Return code: 0 22:50:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:34 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:50:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:50:34 INFO - Using env: {'DISPLAY': ':0', 22:50:34 INFO - 'HOME': '/home/cltbld', 22:50:34 INFO - 'LANG': 'en_US.UTF-8', 22:50:34 INFO - 'LANGUAGE': 'en_US:en', 22:50:34 INFO - 'LOGNAME': 'cltbld', 22:50:34 INFO - 'MAIL': '/var/mail/cltbld', 22:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:34 INFO - 'MOZ_NO_REMOTE': '1', 22:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:34 INFO - 'NO_EM_RESTART': '1', 22:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:34 INFO - 'SHELL': '/bin/bash', 22:50:34 INFO - 'SHLVL': '1', 22:50:34 INFO - 'TERM': 'linux', 22:50:34 INFO - 'TMOUT': '86400', 22:50:34 INFO - 'USER': 'cltbld', 22:50:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:34 INFO - '_': '/tools/buildbot/bin/python'} 22:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:50:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:50:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:50:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:37 INFO - Downloading docopt-0.6.1.tar.gz 22:50:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:50:37 INFO - Running setup.py install for blobuploader 22:50:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:50:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:50:37 INFO - Running setup.py install for requests 22:50:38 INFO - Running setup.py install for docopt 22:50:38 INFO - Successfully installed blobuploader requests docopt 22:50:38 INFO - Cleaning up... 22:50:38 INFO - Return code: 0 22:50:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:38 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:50:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:50:38 INFO - Using env: {'DISPLAY': ':0', 22:50:38 INFO - 'HOME': '/home/cltbld', 22:50:38 INFO - 'LANG': 'en_US.UTF-8', 22:50:38 INFO - 'LANGUAGE': 'en_US:en', 22:50:38 INFO - 'LOGNAME': 'cltbld', 22:50:38 INFO - 'MAIL': '/var/mail/cltbld', 22:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:38 INFO - 'MOZ_NO_REMOTE': '1', 22:50:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:38 INFO - 'NO_EM_RESTART': '1', 22:50:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:38 INFO - 'SHELL': '/bin/bash', 22:50:38 INFO - 'SHLVL': '1', 22:50:38 INFO - 'TERM': 'linux', 22:50:38 INFO - 'TMOUT': '86400', 22:50:38 INFO - 'USER': 'cltbld', 22:50:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:38 INFO - '_': '/tools/buildbot/bin/python'} 22:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:38 INFO - Running setup.py (path:/tmp/pip-Buj7Dd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:38 INFO - Running setup.py (path:/tmp/pip-b6duJR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:38 INFO - Running setup.py (path:/tmp/pip-PWsKv8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:38 INFO - Running setup.py (path:/tmp/pip-_Owj6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:38 INFO - Running setup.py (path:/tmp/pip-maJN8Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:38 INFO - Running setup.py (path:/tmp/pip-Fkh3cU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:38 INFO - Running setup.py (path:/tmp/pip-CWyDca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:39 INFO - Running setup.py (path:/tmp/pip-_gEbWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:39 INFO - Running setup.py (path:/tmp/pip-R_6Ezx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:39 INFO - Running setup.py (path:/tmp/pip-usgnyE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:39 INFO - Running setup.py (path:/tmp/pip-jHN2K7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:39 INFO - Running setup.py (path:/tmp/pip-yK9oPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:39 INFO - Running setup.py (path:/tmp/pip-JtUn7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:39 INFO - Running setup.py (path:/tmp/pip-VINWZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:39 INFO - Running setup.py (path:/tmp/pip-UvX9AO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:39 INFO - Running setup.py (path:/tmp/pip-H_ZxfR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:39 INFO - Running setup.py (path:/tmp/pip-EumpFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:50:39 INFO - Running setup.py install for manifestparser 22:50:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:50:39 INFO - Running setup.py install for mozcrash 22:50:39 INFO - Running setup.py install for mozdebug 22:50:40 INFO - Running setup.py install for mozdevice 22:50:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for mozfile 22:50:40 INFO - Running setup.py install for mozhttpd 22:50:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for mozinfo 22:50:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for mozInstall 22:50:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for mozleak 22:50:40 INFO - Running setup.py install for mozlog 22:50:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for moznetwork 22:50:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:50:40 INFO - Running setup.py install for mozprocess 22:50:40 INFO - Running setup.py install for mozprofile 22:50:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:50:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:50:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:50:41 INFO - Running setup.py install for mozrunner 22:50:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:50:41 INFO - Running setup.py install for mozscreenshot 22:50:41 INFO - Running setup.py install for moztest 22:50:41 INFO - Running setup.py install for mozversion 22:50:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:50:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:50:41 INFO - Cleaning up... 22:50:41 INFO - Return code: 0 22:50:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:41 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:50:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:50:41 INFO - Using env: {'DISPLAY': ':0', 22:50:41 INFO - 'HOME': '/home/cltbld', 22:50:41 INFO - 'LANG': 'en_US.UTF-8', 22:50:41 INFO - 'LANGUAGE': 'en_US:en', 22:50:41 INFO - 'LOGNAME': 'cltbld', 22:50:41 INFO - 'MAIL': '/var/mail/cltbld', 22:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:41 INFO - 'MOZ_NO_REMOTE': '1', 22:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:41 INFO - 'NO_EM_RESTART': '1', 22:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:41 INFO - 'SHELL': '/bin/bash', 22:50:41 INFO - 'SHLVL': '1', 22:50:41 INFO - 'TERM': 'linux', 22:50:41 INFO - 'TMOUT': '86400', 22:50:41 INFO - 'USER': 'cltbld', 22:50:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:41 INFO - '_': '/tools/buildbot/bin/python'} 22:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:41 INFO - Running setup.py (path:/tmp/pip-SyVvCN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:41 INFO - Running setup.py (path:/tmp/pip-mfM9Xh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:41 INFO - Running setup.py (path:/tmp/pip-IVjAzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:50:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:41 INFO - Running setup.py (path:/tmp/pip-Xj6R8u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:42 INFO - Running setup.py (path:/tmp/pip-QM2DoU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:42 INFO - Running setup.py (path:/tmp/pip-DchSJq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:42 INFO - Running setup.py (path:/tmp/pip-EJnIIN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:42 INFO - Running setup.py (path:/tmp/pip-krcyB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:42 INFO - Running setup.py (path:/tmp/pip-hBcrl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:42 INFO - Running setup.py (path:/tmp/pip-k_Bx95-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:42 INFO - Running setup.py (path:/tmp/pip-6CyxUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:42 INFO - Running setup.py (path:/tmp/pip-dbqr4_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:42 INFO - Running setup.py (path:/tmp/pip-CTZ0TW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:42 INFO - Running setup.py (path:/tmp/pip-MagLaQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:42 INFO - Running setup.py (path:/tmp/pip-mmemsf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:42 INFO - Running setup.py (path:/tmp/pip-ycBbpN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:50:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:42 INFO - Running setup.py (path:/tmp/pip-pxoyHX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:50:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:44 INFO - Downloading blessings-1.6.tar.gz 22:50:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:50:44 INFO - Installing collected packages: blessings 22:50:44 INFO - Running setup.py install for blessings 22:50:44 INFO - Successfully installed blessings 22:50:44 INFO - Cleaning up... 22:50:44 INFO - Return code: 0 22:50:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:50:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:50:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:50:45 INFO - Reading from file tmpfile_stdout 22:50:45 INFO - Current package versions: 22:50:45 INFO - argparse == 1.2.1 22:50:45 INFO - blessings == 1.6 22:50:45 INFO - blobuploader == 1.2.4 22:50:45 INFO - docopt == 0.6.1 22:50:45 INFO - manifestparser == 1.1 22:50:45 INFO - mozInstall == 1.12 22:50:45 INFO - mozcrash == 0.16 22:50:45 INFO - mozdebug == 0.1 22:50:45 INFO - mozdevice == 0.48 22:50:45 INFO - mozfile == 1.2 22:50:45 INFO - mozhttpd == 0.7 22:50:45 INFO - mozinfo == 0.9 22:50:45 INFO - mozleak == 0.1 22:50:45 INFO - mozlog == 3.1 22:50:45 INFO - moznetwork == 0.27 22:50:45 INFO - mozprocess == 0.22 22:50:45 INFO - mozprofile == 0.28 22:50:45 INFO - mozrunner == 6.11 22:50:45 INFO - mozscreenshot == 0.1 22:50:45 INFO - mozsystemmonitor == 0.0 22:50:45 INFO - moztest == 0.7 22:50:45 INFO - mozversion == 1.4 22:50:45 INFO - psutil == 3.1.1 22:50:45 INFO - requests == 1.2.3 22:50:45 INFO - wsgiref == 0.1.2 22:50:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:45 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:50:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:50:45 INFO - Using env: {'DISPLAY': ':0', 22:50:45 INFO - 'HOME': '/home/cltbld', 22:50:45 INFO - 'LANG': 'en_US.UTF-8', 22:50:45 INFO - 'LANGUAGE': 'en_US:en', 22:50:45 INFO - 'LOGNAME': 'cltbld', 22:50:45 INFO - 'MAIL': '/var/mail/cltbld', 22:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:45 INFO - 'MOZ_NO_REMOTE': '1', 22:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:45 INFO - 'NO_EM_RESTART': '1', 22:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:45 INFO - 'SHELL': '/bin/bash', 22:50:45 INFO - 'SHLVL': '1', 22:50:45 INFO - 'TERM': 'linux', 22:50:45 INFO - 'TMOUT': '86400', 22:50:45 INFO - 'USER': 'cltbld', 22:50:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:45 INFO - '_': '/tools/buildbot/bin/python'} 22:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:50:45 INFO - Cleaning up... 22:50:45 INFO - Return code: 0 22:50:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:50:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:50:45 INFO - Using env: {'DISPLAY': ':0', 22:50:45 INFO - 'HOME': '/home/cltbld', 22:50:45 INFO - 'LANG': 'en_US.UTF-8', 22:50:45 INFO - 'LANGUAGE': 'en_US:en', 22:50:45 INFO - 'LOGNAME': 'cltbld', 22:50:45 INFO - 'MAIL': '/var/mail/cltbld', 22:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:45 INFO - 'MOZ_NO_REMOTE': '1', 22:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:45 INFO - 'NO_EM_RESTART': '1', 22:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:45 INFO - 'SHELL': '/bin/bash', 22:50:45 INFO - 'SHLVL': '1', 22:50:45 INFO - 'TERM': 'linux', 22:50:45 INFO - 'TMOUT': '86400', 22:50:45 INFO - 'USER': 'cltbld', 22:50:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:45 INFO - '_': '/tools/buildbot/bin/python'} 22:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:45 INFO - Downloading/unpacking jsonschema 22:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:50:47 INFO - Downloading/unpacking functools32 (from jsonschema) 22:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:47 INFO - Downloading functools32-3.2.3-2.tar.gz 22:50:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:50:47 INFO - warning: no files found matching '*.txt' 22:50:47 INFO - no previously-included directories found matching 'build' 22:50:47 INFO - no previously-included directories found matching 'dist' 22:50:47 INFO - no previously-included directories found matching '.git*' 22:50:47 INFO - Installing collected packages: jsonschema, functools32 22:50:47 INFO - Running setup.py install for functools32 22:50:47 INFO - warning: no files found matching '*.txt' 22:50:47 INFO - no previously-included directories found matching 'build' 22:50:47 INFO - no previously-included directories found matching 'dist' 22:50:47 INFO - no previously-included directories found matching '.git*' 22:50:47 INFO - Successfully installed jsonschema functools32 22:50:47 INFO - Cleaning up... 22:50:47 INFO - Return code: 0 22:50:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:50:47 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 0x7f5da84c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x243b360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, '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': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:50:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:50:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:50:47 INFO - Using env: {'DISPLAY': ':0', 22:50:47 INFO - 'HOME': '/home/cltbld', 22:50:47 INFO - 'LANG': 'en_US.UTF-8', 22:50:47 INFO - 'LANGUAGE': 'en_US:en', 22:50:47 INFO - 'LOGNAME': 'cltbld', 22:50:47 INFO - 'MAIL': '/var/mail/cltbld', 22:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:50:47 INFO - 'MOZ_NO_REMOTE': '1', 22:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:50:47 INFO - 'NO_EM_RESTART': '1', 22:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:50:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:50:47 INFO - 'SHELL': '/bin/bash', 22:50:47 INFO - 'SHLVL': '1', 22:50:47 INFO - 'TERM': 'linux', 22:50:47 INFO - 'TMOUT': '86400', 22:50:47 INFO - 'USER': 'cltbld', 22:50:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:50:47 INFO - '_': '/tools/buildbot/bin/python'} 22:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:50:48 INFO - Downloading/unpacking flake8 22:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:50:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:50:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:50:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:50:50 INFO - no previously-included directories found matching 'docs/_build' 22:50:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:50:50 INFO - Running setup.py install for pep8 22:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:50:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:50:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:50:50 INFO - no previously-included directories found matching 'docs/_build' 22:50:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:50:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:50:50 INFO - Cleaning up... 22:50:50 INFO - Return code: 0 22:50:50 INFO - Running post-action listener: _resource_record_post_action 22:50:50 INFO - Running post-action listener: _start_resource_monitoring 22:50:50 INFO - Starting resource monitoring. 22:50:50 INFO - ##### 22:50:50 INFO - ##### Running install step. 22:50:50 INFO - ##### 22:50:50 INFO - Running pre-action listener: _resource_record_pre_action 22:50:50 INFO - Running main action method: install 22:50:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:50:50 INFO - Reading from file tmpfile_stdout 22:50:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:50:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:50:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:50:51 INFO - Reading from file tmpfile_stdout 22:50:51 INFO - Output received: 22:50:51 INFO - Usage: mozinstall [options] installer 22:50:51 INFO - Options: 22:50:51 INFO - -h, --help show this help message and exit 22:50:51 INFO - -d DEST, --destination=DEST 22:50:51 INFO - Directory to install application into. [default: 22:50:51 INFO - "/builds/slave/test-pgo"] 22:50:51 INFO - --app=APP Application being installed. [default: firefox] 22:50:51 INFO - mkdir: /builds/slave/test-pgo/build/application 22:50:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:50:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:51:07 INFO - Reading from file tmpfile_stdout 22:51:07 INFO - Output received: 22:51:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:51:07 INFO - Running post-action listener: _resource_record_post_action 22:51:07 INFO - ##### 22:51:07 INFO - ##### Running run-tests step. 22:51:07 INFO - ##### 22:51:07 INFO - Running pre-action listener: _resource_record_pre_action 22:51:07 INFO - Running main action method: run_tests 22:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:51:07 INFO - Python 2.7.3 22:51:07 INFO - Return code: 0 22:51:07 INFO - grabbing minidump binary from tooltool 22:51: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')]} 22:51:07 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 0x24ca540>, '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 0x24cb440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24cb8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:51:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:51:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:51:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:51:07 INFO - Return code: 0 22:51:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:51:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:51:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:51:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:51:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:51:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:51:08 INFO - Return code: 0 22:51:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:51:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:51:08 INFO - Using env: {'DISPLAY': ':0', 22:51:08 INFO - 'HOME': '/home/cltbld', 22:51:08 INFO - 'LANG': 'en_US.UTF-8', 22:51:08 INFO - 'LANGUAGE': 'en_US:en', 22:51:08 INFO - 'LOGNAME': 'cltbld', 22:51:08 INFO - 'MAIL': '/var/mail/cltbld', 22:51:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:08 INFO - 'MOZ_NO_REMOTE': '1', 22:51:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:08 INFO - 'NO_EM_RESTART': '1', 22:51:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:51:08 INFO - 'SHELL': '/bin/bash', 22:51:08 INFO - 'SHLVL': '1', 22:51:08 INFO - 'TERM': 'linux', 22:51:08 INFO - 'TMOUT': '86400', 22:51:08 INFO - 'USER': 'cltbld', 22:51:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917', 22:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:08 INFO - '_': '/tools/buildbot/bin/python'} 22:51:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:51:08 INFO - mozversion application_buildid: 20160121203058 22:51:08 INFO - mozversion application_changeset: a45569eb51d7bb63602a80802f98b450b77ae9d5 22:51:08 INFO - mozversion application_display_name: Nightly 22:51:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:51:08 INFO - mozversion application_name: Firefox 22:51:08 INFO - mozversion application_remotingname: firefox 22:51:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:51:08 INFO - mozversion application_vendor: Mozilla 22:51:08 INFO - mozversion application_version: 46.0a1 22:51:08 INFO - mozversion platform_buildid: 20160121203058 22:51:08 INFO - mozversion platform_changeset: a45569eb51d7bb63602a80802f98b450b77ae9d5 22:51:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:51:08 INFO - mozversion platform_version: 46.0a1 22:51:08 INFO - using testdate: 1453445468 22:51:08 INFO - actual date: 1453445468 22:51:08 INFO - starting webserver on 'localhost:35059' 22:51:08 INFO - SUITE-START | Running 3 tests 22:51:08 INFO - TEST-START | dromaeo_css 22:51:08 INFO - operating with platform_type : linux_ 22:51:08 INFO - Initialising browser for dromaeo_css test... 22:51:08 INFO - TEST-INFO | started process 2317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyL0S9u/profile http://localhost:35059/getInfo.html) 22:51:12 INFO - PROCESS | 2317 | 22:51:12 INFO - PROCESS | 2317 | (process:2493): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:51:12 INFO - PROCESS | 2317 | __metrics Screen width/height:1600/1200 22:51:12 INFO - PROCESS | 2317 | colorDepth:24 22:51:12 INFO - PROCESS | 2317 | Browser inner width/height: 1024/697 22:51:12 INFO - PROCESS | 2317 | __metrics 22:51:12 INFO - PROCESS | 2317 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:51:13 INFO - TEST-INFO | 2317: exit 0 22:51:13 INFO - Browser initialized. 22:51:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:51:13 INFO - TEST-INFO | started process 2542 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyL0S9u/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:51:15 INFO - PROCESS | 2542 | 22:51:15 INFO - PROCESS | 2542 | (process:2602): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:51:25 INFO - PROCESS | 2542 | RSS: Main: 153772032 22:51:25 INFO - PROCESS | 2542 | 22:52:15 INFO - PROCESS | 2542 | 1453445535257 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:54:24 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35059/tests/dromaeo/cssquery-ext.html) 22:54:25 INFO - PROCESS | 2542 | RSS: Main: 161955840 22:54:25 INFO - PROCESS | 2542 | 22:57:27 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-ext.html (next: http://localhost:35059/tests/dromaeo/cssquery-jquery.html) 22:57:28 INFO - PROCESS | 2542 | RSS: Main: 156397568 22:57:28 INFO - PROCESS | 2542 | 23:00:30 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35059/tests/dromaeo/cssquery-mootools.html) 23:00:30 INFO - PROCESS | 2542 | RSS: Main: 158203904 23:00:30 INFO - PROCESS | 2542 | 23:03:32 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35059/tests/dromaeo/cssquery-prototype.html) 23:03:33 INFO - PROCESS | 2542 | RSS: Main: 156102656 23:03:33 INFO - PROCESS | 2542 | 23:06:35 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35059/tests/dromaeo/cssquery-yui.html) 23:06:35 INFO - PROCESS | 2542 | RSS: Main: 157274112 23:06:35 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | Cycle 1(1): loaded http://localhost:35059/tests/dromaeo/cssquery-yui.html (next: http://localhost:35059/tests/dromaeo/cssquery-dojo.html) 23:09:38 INFO - PROCESS | 2542 | RSS: Main: 159260672 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | __start_tp_report 23:09:38 INFO - PROCESS | 2542 | _x_x_mozilla_page_load 23:09:38 INFO - PROCESS | 2542 | _x_x_mozilla_page_load_details 23:09:38 INFO - PROCESS | 2542 | |i|pagename|runs| 23:09:38 INFO - PROCESS | 2542 | |0;dojo.html;3261.575995120634;3261.7064464198215;3286.408446479633;3309.3050459403526;3311.370839540488;5240.659357141783;5344.225087362335;5344.904294619603;5355.544778693811;5388.057090009247;5314.990151871142;5355.357357117142;5414.296141501599;5418.916216756655;5425.02349577076;4802.25565037418;4855.271709243624;4930.852074437755;5005;5029.220470827027;4906.460289368167;4954.603631709472;4979.8008079676765;4992.400911890578;5011.323471331379;4772.403449568804;4840.572031250789;4903.754812259373;4970.229614409773;4980.950190498085;4889.657723959324;4901.1177987962155;4939.703617782909;4941.308216849644;4959.330490383788;4757.643176761722;4863.8784030399165;4908.214685650279;4964.478729733362;4992.176290911995;5111;5172.405173405069;5219.582433405319;5236.293100431431;5280.2079688046715;5815.331236907725;5843.678597677126;5847.590668653196;5854.121881717734;5859.7656093756195;5746.79886203985;5839.970800146015;5839.978003849309;5883.352831188566;5913.8817223655715;5471.644343117685;5502.697351645658;5521.337439507285;5528.530074943675;5557.277553918006;5955.076963070731;5961.880762384728;5964.7315870785915;5968.671723055274;5975.671338076448;5607.635503692247;5721.942780572224;5740.56945729072;5749.68376739275;5752.137179423036;5660.773569057192;5718.25662663851;5723.055695810144;5738.225339579187;5779.942200577941;5801.680907550125;5807.186993820868;5812.564057695689;5813.912791308134;5816.88366232673;5776.913346299809;5790.073588225863;5794.188813566104;5794.739236734357;5798.333191682926;4285.507166675872;4379.430674012358;4449.9777501112285;4506.729596224237;4512.774361281923;3980.840766369313;3986.063275130342;3997.520297564253;4013.4581831452965;4015.8996025099605;5348.572114230852;5378.704171270618;5382.838514844561;5391.083515802323;5432.212329212242;5660.518855897295;5721.942780572141;5744.712764361765;5779.653220806765;5831.271091113611;5397.73011349431;5422.0511410503;5434.538064264502;5442.727863606804;5452.509274165344;4955.776990035385;4973.850784476472;4993.275974983607;5005.6996580205305;5010.423801262901;5830.3586605473365;5900.468957793733;6087.726052327655;6112.052631842072;6132.054283104726;5841.766329346779;5848.0350742127075;5877.500412464818;5877.706114694333;5918.704064796829;6019.578629495893;6041.18444010053;6050.45545900871;6061.030235162353;6086;5587.469190426903;5661.603687741983;5690.715464226855;5747.051736463437;5824.883502330014;5820.708964551671;5832.679202643895;5834.124881267844;5870.002099642986;5897.144913987534;5565.833025009256;5686.800961966312;5692.6299790513485;5697.145428185805;5700.828975130753;5610.971945140248;5732.856678582902;5747.683877386784;5759.424057594207;5793.594448388572;5567.05360088794;5593.049181639212;5593.468620481048;5595.972020139873;5604.355499117491;5547.33431988164;5626.943730562805;5660.264165658438;5665.716714164193;5721.056025755704;5584.162375643686;5585.106382978704;5586.497215250647;5626.774929002794;5670.971645141748 23:09:38 INFO - PROCESS | 2542 | |1;ext.html;526.4288247251732;527.4619887714533;527.786246570139;547.9808206712764;551.9953684294585;34520;35822.462663060076;35878;36192.095197620074;36263.63736362635;39554.80222598883;39921.40117898234;40218.19563608726;40260.590879319156;40506.18987620246;8436.282915952152;8730.781730456725;8769.079246679103;8772.166644168825;8782.429142105775;8437.662493500253;8567.400281980264;8581.570921453902;8595.742127736146;8602.440841345324;8554.443961142537;8628.697995570155;8675.305975521944;8679.132086791333;8683.913160868406;8510.404271700952;8586.78533036676;8651.307895368356;8655.134486551295;8663.090375510576;8405.537695426749;8507.702230421906;8525.701600443954;8578.313734901192;8584.055753867133;38159.23681526354;38513.422298665544;38551.18110236221;38806.61193388058;38904.41643375352;3161.0990867602623;3392.7964322140506;3661.121330880596;3702.648248416396;3708.4622729704042;31038.534421983688;31137.844310778528;31499.685003149905;31639;31768.523472147936;3739.8317075731657;3843.673287770543;3901.1027463683226;3935.74417662851;3986.919633510468;233386;234076;235880;236145;236662;54062.72968635132;54738;54843.45156548463;54992;55470.72264638651;66587.33412665811;67902.3209767906;68037.3196268031;68042;68293.3170668297;14068.226247556482;14239.501617443548;14502.637434064232;14716.632084197981;14890.478833241;11425.714357141138;11500.88499115015;11559.653210403701;11564.074874010059;11569.247998880046;19440.90279548593;19870.50323741918;19916.800831991783;20444.693329600068;20597;7803.414743894117;8031.477953932976;8046.839063218703;8158.714444994397;8220.177982201732;899.7255836969787;906.4878343735768;924.8843894513186;1028.8919663435381;1045.4981608827804;31571.36857262842;32054.519182212287;33131.50302745461;33218.3356332872;33891.491627625604;971.8833739951251;1010.6361709784471;1026.820306446369;1108.6396921000546;1171.689502281896;14975.700485990437;15274.770878436831;15376.461823836336;15434.228288585526;15512.844871551366;285619;293753;293914;294459;297255;50870.23694644583;51051.74474127606;51158;51408;51572;1300.5253082624963;1301.7852054410916;1303.0357535423907;1308.2673702726504;1350.628577141294;28044.43911121807;28956;29360;29452.410951781272;29739.10782676523;46533.3020004707;46999.765001174776;47121.76439117782;47179.29231061605;47295.29057064078;301453;303695;304645;305041;305313;32391;43627.56372436235;44352.556474434845;44393.33409998917;44453.11093778171;40434.39348409717;40830.387544187455;40940.79529602333;41672;46886.531134688215;33705.494417583264;33978.15054623654;34088;34526;41882.790586046875;37055;37384.439233412064;39588.2082358357;40650.39024414577;40818;36292.274154516235;37134.44298335473;37224;37304.25391492209;37715.81142094272;35722.28555428929;36763.44854827233;36962.8151859239;37335.626643733216;37709;26228.8688556556;27631.723682762917;27688;27756.306092347044;27843.860780695966 23:09:38 INFO - PROCESS | 2542 | |2;jquery.html;360.4773079035398;361.1386842380924;361.31711066085103;361.45420415173095;362.7424528584705;10509.15926725862;11004.339739615629;15706.764398534016;16656;17954.551136221584;16723;16745.413910513136;17086.231119599615;17215.913920430412;17341.566460838487;5598.888022239553;5932.11018347247;5944.673042982634;5957.970210148943;6021.126936594192;5738.7417566209415;5853.941460585383;5888.97055514724;6061.939380606182;6067.696615169246;6044.395560443964;6079.300880398767;6130.325664176937;6386.808395748112;6413.8717225655455;5659.207710920475;6395.968020159916;6405.7117429715545;6753.763618273386;6772.424343930772;6265.530085243625;6465.773697920597;6495.188101487314;6501;6503.024546318043;21457.141714331407;21548;21771.891140544198;22222.777772222395;22435.77564224353;2190.353845615547;2241.9775802242093;2300.367398965281;2341.0635745701857;2352.9999750106135;12705.809412858815;13074.973379126252;13574.117682350616;13697.520586779514;14034;1901.591157901044;1928.6046360496064;1986.5232344237425;2008.6986951957176;2095.6646936490242;60215.69892150555;62570.061449077846;64689.67655161741;64957;65176.3482365175;14091.929540352437;14667.633309167357;14683.41266349334;14756.926215368854;14794.260286985607;23372.415689607897;23392.7660723394;23397.181098661466;23705.288841334786;23710.458820176635;6720.462363010947;7008;7101.822454438577;7178.928210717826;8581.699640512677;6694.297098804653;6769.153855768029;6813.727450902007;6830.521863469509;6857.965710171417;4369.951211709231;4399.032212913154;4407.845725399596;4420.778961051935;4425.203463376559;1764.9205785739673;1784.794748603901;1794.7128459446687;1833.7432759413693;1847.8706490545533;893.1827377949234;895.1585509620935;907.0747837206013;978.4520668425562;981.239539357004;15403.229838508254;16170.676586468206;16206.918965405097;16356.509304720877;16709.33162673504;881.5415983688446;882.3735148044832;885.6590212768002;899.536738579632;904.3307952115518;9317.301202409846;9562.426254424618;9604;9635.181009614262;9712.22302215821;462860;468279;470800;473847;478286;70182;70745.2925470749;72417.2758272421;72724.63637681778;73581.6320918392;1044.9216308776872;1053.0785562632695;1057.0222544146634;1069.962551310716;1070.8500809886466;14041.789373159207;14560.271986400427;14816.925915370353;14917.403303868157;15023.24883755786;29625;30141;30449;30765.69234307718;30814.383712326075;40304.59695403009;40940.1811963765;40983.59016409798;41012;41078.38382424326;7204.675789589586;7226.132864056347;7344.926550734638;7589.354904833151;7603.619819008917;10096.899031009889;10698.8930110701;11107.666769996913;11135.610253641084;11223.438828058728;9512.95243523778;9530.428174309563;9613.423194608346;9844.310898237054;9863.457509837028;8684.913150868662;9517.666881659108;9649.614015439303;9670.613175473183;9808.460534670661;3311.519829624739;3969.8213580388374;8026.551901669814;9258;9985.900140998498;7111.075560177351;7116.323949224816;7187.425005999612;7252.347288744038;7382.114146302478;9417.340786144903;9816.460094694861;9833.311668183445;9951.800963980535;10145.594176232868 23:09:38 INFO - PROCESS | 2542 | |3;mootools.html;1458.117838707582;1483.6810085831548;1642.4415698662453;1771.3268957796035;1790.8477779388759;7786.299233069023;7812.843743125134;7962.761117166487;8011.038675358958;8012.879806802888;8022.919770802305;8028.157043510435;8108.594570271493;8116.472429292092;8116.91883081169;2388.988055059727;2404.110479122727;2409.132712223598;2417.395651087228;2418.141559746291;2433.7687919647606;2445.4497738008895;2460.3849037740565;2461.7415171407015;2462.704475462947;2081.573277478121;2127.5106725453156;2318.4435735423544;2408.1691816323428;2433.2700189943034;2350.471143992605;2354.5055538336883;2358;2367.242482405631;2389.7251816041203;2316.1661801751357;2350.083467447697;2350.9412264693347;2353.599888019041;2364.598018336887;7772.922270777276;7805.765827025199;7858.567778772165;7864.842703145962;7880.172581878935;4793.616510679172;4876.366072410564;4906.31311616374;4929.876753081166;4941.357623508921;3183.6338821035647;3199.312147888192;3308.387948229585;3322;3322.069820450278;970.8592254123113;1030.4744580264119;1032.3702541449709;1042.8279333909895;1081.5457507846722;11090.778184436347;11139.665810025632;11144.498497567629;11192.496337664825;11208.66374008781;4430.601245887886;4482.462104547475;4545.136424079415;4556.658250631216;4596.310553416947;8957.372983891066;8998.370114092082;9053.411528250643;9088.500132492643;9133.49765762876;4984.152694042022;5026.095302845523;5032.647714660012;5038.168702164102;5042.067217564762;4599.862004139881;4609.423822022247;4631.328457373662;4636.35091087248;4645.070985802853;3619.167591453928;3651.068977410743;3672.4491326300736;3677.8161091945294;3678.3562876496508;1119.0599896087326;1134.5178299222798;1139.3847322445952;1142.7086093046387;1148.465963327057;933.2347475070377;936.8266870628955;1043.4730461117088;1089.199438412766;1242.6458459339044;7397.334239918326;7415.666295016737;7450.701971921062;7464.962675186589;7479.177290498041;577.9104238842986;609.2993057983355;613.4049971527611;613.7391608566342;738.75621045055;5743.396943320891;5769.68266745333;5812.854678633068;5816.302043754777;5817.476427121579;9224.169824715807;9228.169464748205;9355.29835262358;9416.340856140141;9502.47736374506;9227.307951903635;9287.071292870658;9360.859587106199;9389.483578403253;9457.90542094584;7108.68010939509;7197.388222001084;7257.564546127143;7331.193568707438;7526.698932042657;7383.926160738324;7443.813904652427;7472.663730132266;7512.39900807945;7528.058992625922;8257.298129659046;8305.335573154254;8577.528235947082;8590.226879580618;8639.308855291687;8657.264132548551;8678.652853885775;8689.30485561141;8692.652293908173;8794.956025219833;6813.4889883257965;7043.2604576518725;7084.22073571917;7093.6453177341955;7097.893531596927;7347.191808901123;7350.669219885011;7397.482176247611;7404.148522919718;7417.332440080419;6730.46156307504;6964.860702786017;6994.125734283215;7004.264552221944;7079.327463890922;6154.569180157346;6727.831804204934;7001.50989430735;7102.218755936946;7127.928720712726;7189.317014883578;7228;7266.309700578437;7273.3817625502425;7282.708691652275;6292.056191571301;6303.243610766737;6307.211598550181;6330.651814150266;6334.556581039283;6598.307177746267;6633.303503132294;6637.933620663732;6638.701258443285;6678.699458524281 23:09:38 INFO - PROCESS | 2542 | |4;prototype.html;342.45207667731626;343.4504792332267;346.4387691939059;350.353597612405;351.5991769382902;6170.352113028129;6211.720472578733;6260.780872669452;6302.684865756711;6408.647524386157;6191.5356348273945;6197.845053873655;6208.751649934008;6220.440160385564;6233.501319894409;4760.166970780117;4769.833055843046;4789.161896668086;4796.952030479702;4803.519648035195;4749.240121580548;4785.449673287581;4786.856394308176;4796.640251981098;4798.280257961299;4658.231391820363;4697.318888761128;4722.97638511807;4725.929111063337;4734;4703.34153218548;4714.669973101884;4715.2455607102875;4717.43390793107;4737.313089602006;4122.91754164915;4124.91750164995;4126.525449573277;4127.484064491939;4129.648979836717;5892.852678683067;5898.174255604219;5902.3507414184405;5909;5910.67491287979;5352.304200453916;5477.04151773442;5514.007478653841;5514.641548299348;5526.336839579236;6629.33706629338;6633.4693224541925;6638.93361066388;6647.667616619198;6647.767328143492;4539.886502837422;4544.204764166291;4547.295169248771;4565.383673204141;4571.588557029883;6749.392554670103;6855.108835851307;6859.279775623588;6862.519623626298;6921.065656136408;4624.3294722265755;4629.675922685447;4641.814327426932;4643.86068417948;4646.628269738413;4693.389859318267;4694.577488026094;4696.107739529479;4699.506551812079;4714.3871296731895;5453.972730136404;5465.890682186334;5466.01611709888;5469.56243500519;5474.890502189934;6480.805575832733;6662.6668666566475;6683.532152749261;6705.463562914955;6705.530612857053;1643.3098098798532;1677.865770738338;1735.6355165415152;1737.1835237438384;1740.199508226205;1137.8634563852224;1138.163449864349;1143.0341361549476;1143.085531574737;1150.9942450287695;6143.109249158847;6173.259208894961;6194.938050619436;6194.969025154845;6230.532710046765;6702.698378572976;6710.597364158166;6726.192856857208;6753.932460675429;6758.189017317954;6079.361667024898;6215.65813880241;6263.467605253513;6279.0895320178315;6283.340249273851;3658.359787037258;3682.226732386229;3696.353138200804;3701.241245544657;3702.4631428442726;7112.288771122846;7139.571625702474;7140.893161559967;7144.678489467987;7145.356917877312;6676.132102826601;6859.176898772179;6889.862202755917;6927.203371612229;6940.167179938338;7095.822604434828;7097.290270972861;7100.7869763907165;7110.182329032227;7113.039739635186;6714.462842972648;6749.122614060338;6751.966240168767;6753.054572359972;6765.019072234597;6471.158749362553;6615.040819081302;6628.966855165693;6684.565503242274;6701.865962680817;7007.684654190675;7049.894251586333;7090.326418990187;7096.716131354688;7101.573905565682;4808.374911261653;4809.44691360498;4812.759362031815;4813.855584332476;4839.733814640088;6661.4004739573675;6696.866062678817;6698.39714425704;6719.160104986877;6952.721891124298;6679.532432729662;6727.730890764315;6756.087928129639;6759.425448836904;6776.322367763381;6734.393904548614;6751.392374686302;6751.864962700817;6759.087523184307;6770.341266389569;6487.54587178893;6579.80260592183;6620.205575330991;6631;6641.767538136335;6743.5953842769595;6753.2909044549615;6758;6762.7294908205085;6799.456043516408;6543.836404089936;6603.976383660541;6606.240282367589;6607.438367738796;6615.470762339098 23:09:38 INFO - PROCESS | 2542 | |5;yui.html;744.8137965508623;746.2574738135553;760.8212070163512;826.7767702720262;830.1698301698302;12592.559260425887;12620.242785432869;12628.305443200621;12680.492780288778;12713.809292860615;12171.57399491018;12299.754004919896;12320.383980800947;12338.383080845944;12417.56538521152;771.4792515052345;792.0178978067213;795.0618270440877;797.0753925446484;799.0251892690908;786.5084322298563;786.5162924801264;790.3282210121408;791.3471386106456;793.9166387529312;822.7408366364576;825.228411435307;828.8383765165795;830.5888585150359;831.5301854452215;822.9917700822975;824.814416756231;824.8721448175543;826.7478419082178;828.7928017995501;603.1856993059379;606.854354954812;607.0802733858164;608.0969759906535;609.8383928259015;13869.583912482642;13962.441502339894;13968.58094257174;13981.79027314591;13988.650283742885;12417.317047562381;12459.439325230387;12536.185147965445;12598.61236981679;12804.231746095264;10211.948940255326;10304.742381440448;10500.317479363894;11512;11720.238184517979;4238.766867822269;4271.1671224111315;4290.120525292339;4435.911281774379;4449.443819522559;42902.78548607237;42996.57003429957;42998;43293.35059974103;43298.134037319076;9214.549815129436;9596.952015240018;9752.414855108716;9788.363756355815;9968.352057116264;18101.637967240582;18460.630787384176;18467.261309547466;18638.627227455647;18687.345942892207;7194.100737407824;7281.381082608038;7380.852382952311;7568.281013303727;7675;4060.3706425504092;4143.212789569972;4165.729227600257;4178.8328466860985;4188.832446702158;3111.719945204897;3121.282105115836;3135.8275294859;3141.7172454479205;3146.2920842810186;564.1058921609214;583.1311346094374;588.1648059755158;589.5755056359415;593.4540222994768;558.3746204251183;561.9241402410622;601.5097695378253;650.0314531348257;669.4160540314383;8715.346349023848;8800.119988001148;8885;9383.155516003457;9941;531.3066448284948;547.8137433272707;584.9736761845727;585.8974679431083;685.2428066985909;3980.86066987654;4126.793660316972;4148.8133034013545;4201.306784380604;4239.51245606753;51925;52822;52845.73577132167;52966.205506917424;52976.20535691968;49377.50622493729;50768.238476422885;50815.491845081815;51253.74373128185;51586;42613.36079958803;44701;44853.55146448494;45152.096958060654;45437.772811135736;8708.521031343336;8892.421992570462;9245.676401325922;9402.717918462457;9488.288378371511;33144.33711325808;33196.33607327888;33731.83134084314;34114.82942585271;34220.82889585536;38939.80530097331;39184;41921.16157676891;42371.364429534195;42685.78657106694;10686.305390149615;10746.355218686904;10889.401082940514;10906.34561926287;10955.616553420592;12035.097367697634;12054.578089767167;12192.390380481118;12502.624921252376;12678.683032924251;11404;11687.240329378563;11709.297442153498;12105.51577936908;12111.576094836639;11195.776084478102;11224.382658953837;11664.125190610568;11720.648380548597;12119.45462454174;11701.414929253673;11741.941290293495;11791.646250612495;11794.882051179378;12113.939430302793;9289.117533834275;9372.297077719335;9542.709749660171;9880.25898057663;10017.198624110199;9816.901830981598;10371.553337492202;10377.169826413718;10404.219683523615;10420.583176672848 23:09:38 INFO - PROCESS | 2542 | __end_tp_report 23:09:38 INFO - PROCESS | 2542 | __start_cc_report 23:09:38 INFO - PROCESS | 2542 | _x_x_mozilla_cycle_collect,320 23:09:38 INFO - PROCESS | 2542 | __end_cc_report 23:09:38 INFO - PROCESS | 2542 | __startTimestamp1453446578867__endTimestamp 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | ------- Summary: start ------- 23:09:38 INFO - PROCESS | 2542 | Number of tests: 6 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#0] dojo.html Cycles:165 Average:5386.13 Median:5593.05 stddev:600.60 (10.7%) stddev-sans-first:578.85 23:09:38 INFO - PROCESS | 2542 | Values: 3261.6 3261.7 3286.4 3309.3 3311.4 5240.7 5344.2 5344.9 5355.5 5388.1 5315.0 5355.4 5414.3 5418.9 5425.0 4802.3 4855.3 4930.9 5005.0 5029.2 4906.5 4954.6 4979.8 4992.4 5011.3 4772.4 4840.6 4903.8 4970.2 4981.0 4889.7 4901.1 4939.7 4941.3 4959.3 4757.6 4863.9 4908.2 4964.5 4992.2 5111.0 5172.4 5219.6 5236.3 5280.2 5815.3 5843.7 5847.6 5854.1 5859.8 5746.8 5840.0 5840.0 5883.4 5913.9 5471.6 5502.7 5521.3 5528.5 5557.3 5955.1 5961.9 5964.7 5968.7 5975.7 5607.6 5721.9 5740.6 5749.7 5752.1 5660.8 5718.3 5723.1 5738.2 5779.9 5801.7 5807.2 5812.6 5813.9 5816.9 5776.9 5790.1 5794.2 5794.7 5798.3 4285.5 4379.4 4450.0 4506.7 4512.8 3980.8 3986.1 3997.5 4013.5 4015.9 5348.6 5378.7 5382.8 5391.1 5432.2 5660.5 5721.9 5744.7 5779.7 5831.3 5397.7 5422.1 5434.5 5442.7 5452.5 4955.8 4973.9 4993.3 5005.7 5010.4 5830.4 5900.5 6087.7 6112.1 6132.1 5841.8 5848.0 5877.5 5877.7 5918.7 6019.6 6041.2 6050.5 6061.0 6086.0 5587.5 5661.6 5690.7 5747.1 5824.9 5820.7 5832.7 5834.1 5870.0 5897.1 5565.8 5686.8 5692.6 5697.1 5700.8 5611.0 5732.9 5747.7 5759.4 5793.6 5567.1 5593.0 5593.5 5596.0 5604.4 5547.3 5626.9 5660.3 5665.7 5721.1 5584.2 5585.1 5586.5 5626.8 5671.0 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#1] ext.html Cycles:180 Average:45687.12 Median:20562.14 stddev:72758.05 (353.8%) stddev-sans-first:72883.14 23:09:38 INFO - PROCESS | 2542 | Values: 526.4 527.5 527.8 548.0 552.0 34520.0 35822.5 35878.0 36192.1 36263.6 39554.8 39921.4 40218.2 40260.6 40506.2 8436.3 8730.8 8769.1 8772.2 8782.4 8437.7 8567.4 8581.6 8595.7 8602.4 8554.4 8628.7 8675.3 8679.1 8683.9 8510.4 8586.8 8651.3 8655.1 8663.1 8405.5 8507.7 8525.7 8578.3 8584.1 38159.2 38513.4 38551.2 38806.6 38904.4 3161.1 3392.8 3661.1 3702.6 3708.5 31038.5 31137.8 31499.7 31639.0 31768.5 3739.8 3843.7 3901.1 3935.7 3986.9 233386.0 234076.0 235880.0 236145.0 236662.0 54062.7 54738.0 54843.5 54992.0 55470.7 66587.3 67902.3 68037.3 68042.0 68293.3 14068.2 14239.5 14502.6 14716.6 14890.5 11425.7 11500.9 11559.7 11564.1 11569.2 19440.9 19870.5 19916.8 20444.7 20597.0 7803.4 8031.5 8046.8 8158.7 8220.2 899.7 906.5 924.9 1028.9 1045.5 31571.4 32054.5 33131.5 33218.3 33891.5 971.9 1010.6 1026.8 1108.6 1171.7 14975.7 15274.8 15376.5 15434.2 15512.8 285619.0 293753.0 293914.0 294459.0 297255.0 50870.2 51051.7 51158.0 51408.0 51572.0 1300.5 1301.8 1303.0 1308.3 1350.6 28044.4 28956.0 29360.0 29452.4 29739.1 46533.3 46999.8 47121.8 47179.3 47295.3 301453.0 303695.0 304645.0 305041.0 305313.0 32391.0 43627.6 44352.6 44393.3 44453.1 40434.4 40830.4 40940.8 41672.0 46886.5 33705.5 33978.2 34088.0 34526.0 41882.8 37055.0 37384.4 39588.2 40650.4 40818.0 36292.3 37134.4 37224.0 37304.3 37715.8 35722.3 36763.4 36962.8 37335.6 37709.0 26228.9 27631.7 27688.0 27756.3 27843.9 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#2] jquery.html Cycles:180 Average:26187.31 Median:472323.50 stddev:76988.86 (16.3%) stddev-sans-first:77180.41 23:09:38 INFO - PROCESS | 2542 | Values: 360.5 361.1 361.3 361.5 362.7 10509.2 11004.3 15706.8 16656.0 17954.6 16723.0 16745.4 17086.2 17215.9 17341.6 5598.9 5932.1 5944.7 5958.0 6021.1 5738.7 5853.9 5889.0 6061.9 6067.7 6044.4 6079.3 6130.3 6386.8 6413.9 5659.2 6396.0 6405.7 6753.8 6772.4 6265.5 6465.8 6495.2 6501.0 6503.0 21457.1 21548.0 21771.9 22222.8 22435.8 2190.4 2242.0 2300.4 2341.1 2353.0 12705.8 13075.0 13574.1 13697.5 14034.0 1901.6 1928.6 1986.5 2008.7 2095.7 60215.7 62570.1 64689.7 64957.0 65176.3 14091.9 14667.6 14683.4 14756.9 14794.3 23372.4 23392.8 23397.2 23705.3 23710.5 6720.5 7008.0 7101.8 7178.9 8581.7 6694.3 6769.2 6813.7 6830.5 6858.0 4370.0 4399.0 4407.8 4420.8 4425.2 1764.9 1784.8 1794.7 1833.7 1847.9 893.2 895.2 907.1 978.5 981.2 15403.2 16170.7 16206.9 16356.5 16709.3 881.5 882.4 885.7 899.5 904.3 9317.3 9562.4 9604.0 9635.2 9712.2 462860.0 468279.0 470800.0 473847.0 478286.0 70182.0 70745.3 72417.3 72724.6 73581.6 1044.9 1053.1 1057.0 1070.0 1070.9 14041.8 14560.3 14816.9 14917.4 15023.2 29625.0 30141.0 30449.0 30765.7 30814.4 40304.6 40940.2 40983.6 41012.0 41078.4 7204.7 7226.1 7344.9 7589.4 7603.6 10096.9 10698.9 11107.7 11135.6 11223.4 9513.0 9530.4 9613.4 9844.3 9863.5 8684.9 9517.7 9649.6 9670.6 9808.5 3311.5 3969.8 8026.6 9258.0 9985.9 7111.1 7116.3 7187.4 7252.3 7382.1 9417.3 9816.5 9833.3 9951.8 10145.6 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#3] mootools.html Cycles:180 Average:5543.96 Median:6332.60 stddev:2867.29 (45.3%) stddev-sans-first:2858.89 23:09:38 INFO - PROCESS | 2542 | Values: 1458.1 1483.7 1642.4 1771.3 1790.8 7786.3 7812.8 7962.8 8011.0 8012.9 8022.9 8028.2 8108.6 8116.5 8116.9 2389.0 2404.1 2409.1 2417.4 2418.1 2433.8 2445.4 2460.4 2461.7 2462.7 2081.6 2127.5 2318.4 2408.2 2433.3 2350.5 2354.5 2358.0 2367.2 2389.7 2316.2 2350.1 2350.9 2353.6 2364.6 7772.9 7805.8 7858.6 7864.8 7880.2 4793.6 4876.4 4906.3 4929.9 4941.4 3183.6 3199.3 3308.4 3322.0 3322.1 970.9 1030.5 1032.4 1042.8 1081.5 11090.8 11139.7 11144.5 11192.5 11208.7 4430.6 4482.5 4545.1 4556.7 4596.3 8957.4 8998.4 9053.4 9088.5 9133.5 4984.2 5026.1 5032.6 5038.2 5042.1 4599.9 4609.4 4631.3 4636.4 4645.1 3619.2 3651.1 3672.4 3677.8 3678.4 1119.1 1134.5 1139.4 1142.7 1148.5 933.2 936.8 1043.5 1089.2 1242.6 7397.3 7415.7 7450.7 7465.0 7479.2 577.9 609.3 613.4 613.7 738.8 5743.4 5769.7 5812.9 5816.3 5817.5 9224.2 9228.2 9355.3 9416.3 9502.5 9227.3 9287.1 9360.9 9389.5 9457.9 7108.7 7197.4 7257.6 7331.2 7526.7 7383.9 7443.8 7472.7 7512.4 7528.1 8257.3 8305.3 8577.5 8590.2 8639.3 8657.3 8678.7 8689.3 8692.7 8795.0 6813.5 7043.3 7084.2 7093.6 7097.9 7347.2 7350.7 7397.5 7404.1 7417.3 6730.5 6964.9 6994.1 7004.3 7079.3 6154.6 6727.8 7001.5 7102.2 7127.9 7189.3 7228.0 7266.3 7273.4 7282.7 6292.1 6303.2 6307.2 6330.7 6334.6 6598.3 6633.3 6637.9 6638.7 6678.7 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#4] prototype.html Cycles:180 Average:5528.90 Median:6218.05 stddev:1666.08 (26.8%) stddev-sans-first:1624.64 23:09:38 INFO - PROCESS | 2542 | Values: 342.5 343.5 346.4 350.4 351.6 6170.4 6211.7 6260.8 6302.7 6408.6 6191.5 6197.8 6208.8 6220.4 6233.5 4760.2 4769.8 4789.2 4797.0 4803.5 4749.2 4785.4 4786.9 4796.6 4798.3 4658.2 4697.3 4723.0 4725.9 4734.0 4703.3 4714.7 4715.2 4717.4 4737.3 4122.9 4124.9 4126.5 4127.5 4129.6 5892.9 5898.2 5902.4 5909.0 5910.7 5352.3 5477.0 5514.0 5514.6 5526.3 6629.3 6633.5 6638.9 6647.7 6647.8 4539.9 4544.2 4547.3 4565.4 4571.6 6749.4 6855.1 6859.3 6862.5 6921.1 4624.3 4629.7 4641.8 4643.9 4646.6 4693.4 4694.6 4696.1 4699.5 4714.4 5454.0 5465.9 5466.0 5469.6 5474.9 6480.8 6662.7 6683.5 6705.5 6705.5 1643.3 1677.9 1735.6 1737.2 1740.2 1137.9 1138.2 1143.0 1143.1 1151.0 6143.1 6173.3 6194.9 6195.0 6230.5 6702.7 6710.6 6726.2 6753.9 6758.2 6079.4 6215.7 6263.5 6279.1 6283.3 3658.4 3682.2 3696.4 3701.2 3702.5 7112.3 7139.6 7140.9 7144.7 7145.4 6676.1 6859.2 6889.9 6927.2 6940.2 7095.8 7097.3 7100.8 7110.2 7113.0 6714.5 6749.1 6752.0 6753.1 6765.0 6471.2 6615.0 6629.0 6684.6 6701.9 7007.7 7049.9 7090.3 7096.7 7101.6 4808.4 4809.4 4812.8 4813.9 4839.7 6661.4 6696.9 6698.4 6719.2 6952.7 6679.5 6727.7 6756.1 6759.4 6776.3 6734.4 6751.4 6751.9 6759.1 6770.3 6487.5 6579.8 6620.2 6631.0 6641.8 6743.6 6753.3 6758.0 6762.7 6799.5 6543.8 6604.0 6606.2 6607.4 6615.5 23:09:38 INFO - PROCESS | 2542 | 23:09:38 INFO - PROCESS | 2542 | [#5] yui.html Cycles:180 Average:13399.78 Median:42997.29 stddev:14894.82 (34.6%) stddev-sans-first:14906.29 23:09:38 INFO - PROCESS | 2542 | Values: 744.8 746.3 760.8 826.8 830.2 12592.6 12620.2 12628.3 12680.5 12713.8 12171.6 12299.8 12320.4 12338.4 12417.6 771.5 792.0 795.1 797.1 799.0 786.5 786.5 790.3 791.3 793.9 822.7 825.2 828.8 830.6 831.5 823.0 824.8 824.9 826.7 828.8 603.2 606.9 607.1 608.1 609.8 13869.6 13962.4 13968.6 13981.8 13988.7 12417.3 12459.4 12536.2 12598.6 12804.2 10211.9 10304.7 10500.3 11512.0 11720.2 4238.8 4271.2 4290.1 4435.9 4449.4 42902.8 42996.6 42998.0 43293.4 43298.1 9214.5 9597.0 9752.4 9788.4 9968.4 18101.6 18460.6 18467.3 18638.6 18687.3 7194.1 7281.4 7380.9 7568.3 7675.0 4060.4 4143.2 4165.7 4178.8 4188.8 3111.7 3121.3 3135.8 3141.7 3146.3 564.1 583.1 588.2 589.6 593.5 558.4 561.9 601.5 650.0 669.4 8715.3 8800.1 8885.0 9383.2 9941.0 531.3 547.8 585.0 585.9 685.2 3980.9 4126.8 4148.8 4201.3 4239.5 51925.0 52822.0 52845.7 52966.2 52976.2 49377.5 50768.2 50815.5 51253.7 51586.0 42613.4 44701.0 44853.6 45152.1 45437.8 8708.5 8892.4 9245.7 9402.7 9488.3 33144.3 33196.3 33731.8 34114.8 34220.8 38939.8 39184.0 41921.2 42371.4 42685.8 10686.3 10746.4 10889.4 10906.3 10955.6 12035.1 12054.6 12192.4 12502.6 12678.7 11404.0 11687.2 11709.3 12105.5 12111.6 11195.8 11224.4 11664.1 11720.6 12119.5 11701.4 11741.9 11791.6 11794.9 12113.9 9289.1 9372.3 9542.7 9880.3 10017.2 9816.9 10371.6 10377.2 10404.2 10420.6 23:09:38 INFO - PROCESS | 2542 | -------- Summary: end -------- 23:09:38 INFO - PROCESS | 2542 | 23:09:39 INFO - TEST-INFO | 2542: exit 0 23:09:39 INFO - TEST-OK | dromaeo_css | took 1110923ms 23:09:39 INFO - TEST-START | kraken 23:09:39 INFO - operating with platform_type : linux_ 23:09:39 INFO - Initialising browser for kraken test... 23:09:39 INFO - TEST-INFO | started process 2887 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy2uTEn/profile http://localhost:35059/getInfo.html) 23:09:42 INFO - PROCESS | 2887 | 23:09:42 INFO - PROCESS | 2887 | (process:2960): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:09:43 INFO - PROCESS | 2887 | __metrics Screen width/height:1600/1200 23:09:43 INFO - PROCESS | 2887 | colorDepth:24 23:09:43 INFO - PROCESS | 2887 | Browser inner width/height: 1024/697 23:09:43 INFO - PROCESS | 2887 | __metrics 23:09:43 INFO - PROCESS | 2887 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:09:44 INFO - TEST-INFO | 2887: exit 0 23:09:44 INFO - Browser initialized. 23:09:44 INFO - Running cycle 1/1 for kraken test... 23:09:44 INFO - TEST-INFO | started process 3009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpy2uTEn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:09:46 INFO - PROCESS | 3009 | 23:09:46 INFO - PROCESS | 3009 | (process:3068): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:09:56 INFO - PROCESS | 3009 | RSS: Main: 152412160 23:09:56 INFO - PROCESS | 3009 | 23:09:59 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35059/tests/kraken/driver.html?testName=audio-beat-detection) 23:09:59 INFO - PROCESS | 3009 | RSS: Main: 156303360 23:09:59 INFO - PROCESS | 3009 | 23:10:02 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35059/tests/kraken/driver.html?testName=audio-dft) 23:10:02 INFO - PROCESS | 3009 | RSS: Main: 160239616 23:10:02 INFO - PROCESS | 3009 | 23:10:05 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35059/tests/kraken/driver.html?testName=audio-fft) 23:10:06 INFO - PROCESS | 3009 | RSS: Main: 152920064 23:10:06 INFO - PROCESS | 3009 | 23:10:08 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35059/tests/kraken/driver.html?testName=audio-oscillator) 23:10:09 INFO - PROCESS | 3009 | RSS: Main: 153268224 23:10:09 INFO - PROCESS | 3009 | 23:10:11 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:10:12 INFO - PROCESS | 3009 | RSS: Main: 153497600 23:10:12 INFO - PROCESS | 3009 | 23:10:15 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35059/tests/kraken/driver.html?testName=imaging-darkroom) 23:10:15 INFO - PROCESS | 3009 | RSS: Main: 154664960 23:10:15 INFO - PROCESS | 3009 | 23:10:18 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35059/tests/kraken/driver.html?testName=imaging-desaturate) 23:10:19 INFO - PROCESS | 3009 | RSS: Main: 153591808 23:10:19 INFO - PROCESS | 3009 | 23:10:22 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35059/tests/kraken/driver.html?testName=json-parse-financial) 23:10:22 INFO - PROCESS | 3009 | RSS: Main: 155963392 23:10:22 INFO - PROCESS | 3009 | 23:10:24 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:10:25 INFO - PROCESS | 3009 | RSS: Main: 157081600 23:10:25 INFO - PROCESS | 3009 | 23:10:26 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:10:27 INFO - PROCESS | 3009 | RSS: Main: 156729344 23:10:27 INFO - PROCESS | 3009 | 23:10:29 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:10:30 INFO - PROCESS | 3009 | RSS: Main: 157356032 23:10:30 INFO - PROCESS | 3009 | 23:10:32 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:10:33 INFO - PROCESS | 3009 | RSS: Main: 157065216 23:10:33 INFO - PROCESS | 3009 | 23:10:35 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:10:36 INFO - PROCESS | 3009 | RSS: Main: 156917760 23:10:36 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | Cycle 1(1): loaded http://localhost:35059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35059/tests/kraken/driver.html?testName=ai-astar) 23:10:38 INFO - PROCESS | 3009 | RSS: Main: 157863936 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | __start_tp_report 23:10:38 INFO - PROCESS | 3009 | _x_x_mozilla_page_load 23:10:38 INFO - PROCESS | 3009 | _x_x_mozilla_page_load_details 23:10:38 INFO - PROCESS | 3009 | |i|pagename|runs| 23:10:38 INFO - PROCESS | 3009 | |0;ai-astar;112;108;111;111;111;123;111;111;112;112 23:10:38 INFO - PROCESS | 3009 | |1;audio-beat-detection;162;129;157;169;130;149;157;130;176;127 23:10:38 INFO - PROCESS | 3009 | |2;audio-dft;163;164;169;164;163;164;166;172;163;163 23:10:38 INFO - PROCESS | 3009 | |3;audio-fft;73;73;73;76;73;76;135;73;74;73 23:10:38 INFO - PROCESS | 3009 | |4;audio-oscillator;96;96;141;97;96;96;141;96;97;137 23:10:38 INFO - PROCESS | 3009 | |5;imaging-gaussian-blur;109;110;110;110;110;110;110;111;111;110 23:10:38 INFO - PROCESS | 3009 | |6;imaging-darkroom;148;147;147;146;147;147;147;147;146;146 23:10:38 INFO - PROCESS | 3009 | |7;imaging-desaturate;97;98;97;97;98;96;96;97;96;96 23:10:38 INFO - PROCESS | 3009 | |8;json-parse-financial;60;60;60;62;61;61;60;61;67;57 23:10:38 INFO - PROCESS | 3009 | |9;json-stringify-tinderbox;69;68;68;68;68;69;71;68;68;68 23:10:38 INFO - PROCESS | 3009 | |10;stanford-crypto-aes;81;82;81;91;81;83;81;82;83;82 23:10:38 INFO - PROCESS | 3009 | |11;stanford-crypto-ccm;128;119;129;120;116;118;116;123;118;117 23:10:38 INFO - PROCESS | 3009 | |12;stanford-crypto-pbkdf2;139;149;149;144;139;139;146;163;144;147 23:10:38 INFO - PROCESS | 3009 | |13;stanford-crypto-sha256-iterative;67;68;67;66;68;68;67;70;72;67 23:10:38 INFO - PROCESS | 3009 | __end_tp_report 23:10:38 INFO - PROCESS | 3009 | __start_cc_report 23:10:38 INFO - PROCESS | 3009 | _x_x_mozilla_cycle_collect,738 23:10:38 INFO - PROCESS | 3009 | __end_cc_report 23:10:38 INFO - PROCESS | 3009 | __startTimestamp1453446638346__endTimestamp 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | ------- Summary: start ------- 23:10:38 INFO - PROCESS | 3009 | Number of tests: 14 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.50 stddev:3.97 (3.6%) stddev-sans-first:4.21 23:10:38 INFO - PROCESS | 3009 | Values: 112.0 108.0 111.0 111.0 111.0 123.0 111.0 111.0 112.0 112.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:157.00 stddev:18.35 (11.7%) stddev-sans-first:18.81 23:10:38 INFO - PROCESS | 3009 | Values: 162.0 129.0 157.0 169.0 130.0 149.0 157.0 130.0 176.0 127.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:3.07 (1.9%) stddev-sans-first:3.16 23:10:38 INFO - PROCESS | 3009 | Values: 163.0 164.0 169.0 164.0 163.0 164.0 166.0 172.0 163.0 163.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:19.40 (26.6%) stddev-sans-first:20.41 23:10:38 INFO - PROCESS | 3009 | Values: 73.0 73.0 73.0 76.0 73.0 76.0 135.0 73.0 74.0 73.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.00 stddev:20.99 (21.9%) stddev-sans-first:21.70 23:10:38 INFO - PROCESS | 3009 | Values: 96.0 96.0 141.0 97.0 96.0 96.0 141.0 96.0 97.0 137.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 23:10:38 INFO - PROCESS | 3009 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 23:10:38 INFO - PROCESS | 3009 | Values: 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 146.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 23:10:38 INFO - PROCESS | 3009 | Values: 97.0 98.0 97.0 97.0 98.0 96.0 96.0 97.0 96.0 96.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:2.51 (4.1%) stddev-sans-first:2.65 23:10:38 INFO - PROCESS | 3009 | Values: 60.0 60.0 60.0 62.0 61.0 61.0 60.0 61.0 67.0 57.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 23:10:38 INFO - PROCESS | 3009 | Values: 69.0 68.0 68.0 68.0 68.0 69.0 71.0 68.0 68.0 68.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:3.02 (3.7%) stddev-sans-first:3.14 23:10:38 INFO - PROCESS | 3009 | Values: 81.0 82.0 81.0 91.0 81.0 83.0 81.0 82.0 83.0 82.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:119.50 stddev:4.74 (4.0%) stddev-sans-first:4.16 23:10:38 INFO - PROCESS | 3009 | Values: 128.0 119.0 129.0 120.0 116.0 118.0 116.0 123.0 118.0 117.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:146.50 stddev:7.17 (4.9%) stddev-sans-first:7.16 23:10:38 INFO - PROCESS | 3009 | Values: 139.0 149.0 149.0 144.0 139.0 139.0 146.0 163.0 144.0 147.0 23:10:38 INFO - PROCESS | 3009 | 23:10:38 INFO - PROCESS | 3009 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.76 (2.6%) stddev-sans-first:1.83 23:10:38 INFO - PROCESS | 3009 | Values: 67.0 68.0 67.0 66.0 68.0 68.0 67.0 70.0 72.0 67.0 23:10:38 INFO - PROCESS | 3009 | -------- Summary: end -------- 23:10:38 INFO - PROCESS | 3009 | 23:10:39 INFO - TEST-INFO | 3009: exit 0 23:10:39 INFO - TEST-OK | kraken | took 59873ms 23:10:39 INFO - TEST-START | v8_7 23:10:39 INFO - operating with platform_type : linux_ 23:10:39 INFO - Initialising browser for v8_7 test... 23:10:39 INFO - TEST-INFO | started process 3298 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUFp_YQ/profile http://localhost:35059/getInfo.html) 23:10:42 INFO - PROCESS | 3298 | 23:10:42 INFO - PROCESS | 3298 | (process:3369): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:43 INFO - PROCESS | 3298 | __metrics Screen width/height:1600/1200 23:10:43 INFO - PROCESS | 3298 | colorDepth:24 23:10:43 INFO - PROCESS | 3298 | Browser inner width/height: 1024/697 23:10:43 INFO - PROCESS | 3298 | __metrics 23:10:44 INFO - PROCESS | 3298 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:44 INFO - TEST-INFO | 3298: exit 0 23:10:44 INFO - Browser initialized. 23:10:44 INFO - Running cycle 1/1 for v8_7 test... 23:10:44 INFO - TEST-INFO | started process 3418 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUFp_YQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:46 INFO - PROCESS | 3418 | 23:10:46 INFO - PROCESS | 3418 | (process:3477): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:10:56 INFO - PROCESS | 3418 | RSS: Main: 152440832 23:10:56 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | Cycle 1(1): loaded http://localhost:35059/tests/v8_7/run.html (next: http://localhost:35059/tests/v8_7/run.html) 23:11:19 INFO - PROCESS | 3418 | RSS: Main: 153550848 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | __start_tp_report 23:11:19 INFO - PROCESS | 3418 | _x_x_mozilla_page_load 23:11:19 INFO - PROCESS | 3418 | _x_x_mozilla_page_load_details 23:11:19 INFO - PROCESS | 3418 | |i|pagename|runs| 23:11:19 INFO - PROCESS | 3418 | |0;Richards;166.00265604249668 23:11:19 INFO - PROCESS | 3418 | |1;DeltaBlue;188.5014137606032 23:11:19 INFO - PROCESS | 3418 | |2;Encrypt;280.8988764044944 23:11:19 INFO - PROCESS | 3418 | |3;Decrypt;5186.5284974093265 23:11:19 INFO - PROCESS | 3418 | |4;RayTrace;1076.4262648008612 23:11:19 INFO - PROCESS | 3418 | |5;Earley;689.6551724137931 23:11:19 INFO - PROCESS | 3418 | |6;Boyer;12500 23:11:19 INFO - PROCESS | 3418 | |7;RegExp;42291.666666666664 23:11:19 INFO - PROCESS | 3418 | |8;Splay;593.4718100890208 23:11:19 INFO - PROCESS | 3418 | |9;NavierStokes;4845.410628019324 23:11:19 INFO - PROCESS | 3418 | __end_tp_report 23:11:19 INFO - PROCESS | 3418 | __startTimestamp1453446679361__endTimestamp 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | ------- Summary: start ------- 23:11:19 INFO - PROCESS | 3418 | Number of tests: 10 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#0] Richards Cycles:1 Average:166.00 Median:166.00 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 166.0 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 188.5 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 280.9 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 5186.5 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#4] RayTrace Cycles:1 Average:1076.43 Median:1076.43 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 1076.4 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#5] Earley Cycles:1 Average:689.66 Median:689.66 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 689.7 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 12500.0 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#7] RegExp Cycles:1 Average:42291.67 Median:42291.67 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 42291.7 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#8] Splay Cycles:1 Average:593.47 Median:593.47 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 593.5 23:11:19 INFO - PROCESS | 3418 | 23:11:19 INFO - PROCESS | 3418 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 23:11:19 INFO - PROCESS | 3418 | Values: 4845.4 23:11:19 INFO - PROCESS | 3418 | -------- Summary: end -------- 23:11:19 INFO - PROCESS | 3418 | 23:11:20 INFO - TEST-INFO | 3418: exit 0 23:11:20 INFO - TEST-OK | v8_7 | took 40737ms 23:11:20 INFO - SUITE-END | took 1211s 23:11:20 INFO - Completed test suite (00:20:11) 23:11:20 INFO - Working with test: dromaeo_css 23:11:20 INFO - Generating results file: dromaeo_css 23:11:20 INFO - Working with test: kraken 23:11:20 INFO - Generating results file: kraken 23:11:20 INFO - javascript benchmark 23:11:20 INFO - Working with test: v8_7 23:11:20 INFO - Generating results file: v8_7 23:11:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:11:20 INFO - process_Request line: dromaeo_css 7014.49 graph.html#tests=[[72,64,43]] 23:11:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:20 INFO - process_Request line: kraken 1515.20 graph.html#tests=[[232,64,43]] 23:11:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:11:20 INFO - process_Request line: v8_7 20371.40 graph.html#tests=[[230,64,43]] 23:11:20 INFO - RETURN: dromaeo_css: 7014.49 23:11:20 INFO - RETURN: kraken: 1515.20 23:11:20 INFO - RETURN: v8_7: 20371.40 23:11:20 INFO - javascript benchmark 23:11:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3261.575995120634, 3261.7064464198215, 3286.408446479633, 3309.3050459403526, 3311.370839540488, 5240.659357141783, 5344.225087362335, 5344.904294619603, 5355.544778693811, 5388.057090009247, 5314.990151871142, 5355.357357117142, 5414.296141501599, 5418.916216756655, 5425.02349577076, 4802.25565037418, 4855.271709243624, 4930.852074437755, 5005.0, 5029.220470827027, 4906.460289368167, 4954.603631709472, 4979.8008079676765, 4992.400911890578, 5011.323471331379, 4772.403449568804, 4840.572031250789, 4903.754812259373, 4970.229614409773, 4980.950190498085, 4889.657723959324, 4901.1177987962155, 4939.703617782909, 4941.308216849644, 4959.330490383788, 4757.643176761722, 4863.8784030399165, 4908.214685650279, 4964.478729733362, 4992.176290911995, 5111.0, 5172.405173405069, 5219.582433405319, 5236.293100431431, 5280.2079688046715, 5815.331236907725, 5843.678597677126, 5847.590668653196, 5854.121881717734, 5859.7656093756195, 5746.79886203985, 5839.970800146015, 5839.978003849309, 5883.352831188566, 5913.8817223655715, 5471.644343117685, 5502.697351645658, 5521.337439507285, 5528.530074943675, 5557.277553918006, 5955.076963070731, 5961.880762384728, 5964.7315870785915, 5968.671723055274, 5975.671338076448, 5607.635503692247, 5721.942780572224, 5740.56945729072, 5749.68376739275, 5752.137179423036, 5660.773569057192, 5718.25662663851, 5723.055695810144, 5738.225339579187, 5779.942200577941, 5801.680907550125, 5807.186993820868, 5812.564057695689, 5813.912791308134, 5816.88366232673, 5776.913346299809, 5790.073588225863, 5794.188813566104, 5794.739236734357, 5798.333191682926, 4285.507166675872, 4379.430674012358, 4449.9777501112285, 4506.729596224237, 4512.774361281923, 3980.840766369313, 3986.063275130342, 3997.520297564253, 4013.4581831452965, 4015.8996025099605, 5348.572114230852, 5378.704171270618, 5382.838514844561, 5391.083515802323, 5432.212329212242, 5660.518855897295, 5721.942780572141, 5744.712764361765, 5779.653220806765, 5831.271091113611, 5397.73011349431, 5422.0511410503, 5434.538064264502, 5442.727863606804, 5452.509274165344, 4955.776990035385, 4973.850784476472, 4993.275974983607, 5005.6996580205305, 5010.423801262901, 5830.3586605473365, 5900.468957793733, 6087.726052327655, 6112.052631842072, 6132.054283104726, 5841.766329346779, 5848.0350742127075, 5877.500412464818, 5877.706114694333, 5918.704064796829, 6019.578629495893, 6041.18444010053, 6050.45545900871, 6061.030235162353, 6086.0, 5587.469190426903, 5661.603687741983, 5690.715464226855, 5747.051736463437, 5824.883502330014, 5820.708964551671, 5832.679202643895, 5834.124881267844, 5870.002099642986, 5897.144913987534, 5565.833025009256, 5686.800961966312, 5692.6299790513485, 5697.145428185805, 5700.828975130753, 5610.971945140248, 5732.856678582902, 5747.683877386784, 5759.424057594207, 5793.594448388572, 5567.05360088794, 5593.049181639212, 5593.468620481048, 5595.972020139873, 5604.355499117491, 5547.33431988164, 5626.943730562805, 5660.264165658438, 5665.716714164193, 5721.056025755704, 5584.162375643686, 5585.106382978704, 5586.497215250647, 5626.774929002794, 5670.971645141748], "unit": "score", "name": "dojo.html", "value": 5347.4048644293225}, {"lowerIsBetter": false, "replicates": [526.4288247251732, 527.4619887714533, 527.786246570139, 547.9808206712764, 551.9953684294585, 34520.0, 35822.462663060076, 35878.0, 36192.095197620074, 36263.63736362635, 39554.80222598883, 39921.40117898234, 40218.19563608726, 40260.590879319156, 40506.18987620246, 8436.282915952152, 8730.781730456725, 8769.079246679103, 8772.166644168825, 8782.429142105775, 8437.662493500253, 8567.400281980264, 8581.570921453902, 8595.742127736146, 8602.440841345324, 8554.443961142537, 8628.697995570155, 8675.305975521944, 8679.132086791333, 8683.913160868406, 8510.404271700952, 8586.78533036676, 8651.307895368356, 8655.134486551295, 8663.090375510576, 8405.537695426749, 8507.702230421906, 8525.701600443954, 8578.313734901192, 8584.055753867133, 38159.23681526354, 38513.422298665544, 38551.18110236221, 38806.61193388058, 38904.41643375352, 3161.0990867602623, 3392.7964322140506, 3661.121330880596, 3702.648248416396, 3708.4622729704042, 31038.534421983688, 31137.844310778528, 31499.685003149905, 31639.0, 31768.523472147936, 3739.8317075731657, 3843.673287770543, 3901.1027463683226, 3935.74417662851, 3986.919633510468, 233386.0, 234076.0, 235880.0, 236145.0, 236662.0, 54062.72968635132, 54738.0, 54843.45156548463, 54992.0, 55470.72264638651, 66587.33412665811, 67902.3209767906, 68037.3196268031, 68042.0, 68293.3170668297, 14068.226247556482, 14239.501617443548, 14502.637434064232, 14716.632084197981, 14890.478833241, 11425.714357141138, 11500.88499115015, 11559.653210403701, 11564.074874010059, 11569.247998880046, 19440.90279548593, 19870.50323741918, 19916.800831991783, 20444.693329600068, 20597.0, 7803.414743894117, 8031.477953932976, 8046.839063218703, 8158.714444994397, 8220.177982201732, 899.7255836969787, 906.4878343735768, 924.8843894513186, 1028.8919663435381, 1045.4981608827804, 31571.36857262842, 32054.519182212287, 33131.50302745461, 33218.3356332872, 33891.491627625604, 971.8833739951251, 1010.6361709784471, 1026.820306446369, 1108.6396921000546, 1171.689502281896, 14975.700485990437, 15274.770878436831, 15376.461823836336, 15434.228288585526, 15512.844871551366, 285619.0, 293753.0, 293914.0, 294459.0, 297255.0, 50870.23694644583, 51051.74474127606, 51158.0, 51408.0, 51572.0, 1300.5253082624963, 1301.7852054410916, 1303.0357535423907, 1308.2673702726504, 1350.628577141294, 28044.43911121807, 28956.0, 29360.0, 29452.410951781272, 29739.10782676523, 46533.3020004707, 46999.765001174776, 47121.76439117782, 47179.29231061605, 47295.29057064078, 301453.0, 303695.0, 304645.0, 305041.0, 305313.0, 32391.0, 43627.56372436235, 44352.556474434845, 44393.33409998917, 44453.11093778171, 40434.39348409717, 40830.387544187455, 40940.79529602333, 41672.0, 46886.531134688215, 33705.494417583264, 33978.15054623654, 34088.0, 34526.0, 41882.790586046875, 37055.0, 37384.439233412064, 39588.2082358357, 40650.39024414577, 40818.0, 36292.274154516235, 37134.44298335473, 37224.0, 37304.25391492209, 37715.81142094272, 35722.28555428929, 36763.44854827233, 36962.8151859239, 37335.626643733216, 37709.0, 26228.8688556556, 27631.723682762917, 27688.0, 27756.306092347044, 27843.860780695966], "unit": "score", "name": "ext.html", "value": 18645.546716030476}, {"lowerIsBetter": false, "replicates": [360.4773079035398, 361.1386842380924, 361.31711066085103, 361.45420415173095, 362.7424528584705, 10509.15926725862, 11004.339739615629, 15706.764398534016, 16656.0, 17954.551136221584, 16723.0, 16745.413910513136, 17086.231119599615, 17215.913920430412, 17341.566460838487, 5598.888022239553, 5932.11018347247, 5944.673042982634, 5957.970210148943, 6021.126936594192, 5738.7417566209415, 5853.941460585383, 5888.97055514724, 6061.939380606182, 6067.696615169246, 6044.395560443964, 6079.300880398767, 6130.325664176937, 6386.808395748112, 6413.8717225655455, 5659.207710920475, 6395.968020159916, 6405.7117429715545, 6753.763618273386, 6772.424343930772, 6265.530085243625, 6465.773697920597, 6495.188101487314, 6501.0, 6503.024546318043, 21457.141714331407, 21548.0, 21771.891140544198, 22222.777772222395, 22435.77564224353, 2190.353845615547, 2241.9775802242093, 2300.367398965281, 2341.0635745701857, 2352.9999750106135, 12705.809412858815, 13074.973379126252, 13574.117682350616, 13697.520586779514, 14034.0, 1901.591157901044, 1928.6046360496064, 1986.5232344237425, 2008.6986951957176, 2095.6646936490242, 60215.69892150555, 62570.061449077846, 64689.67655161741, 64957.0, 65176.3482365175, 14091.929540352437, 14667.633309167357, 14683.41266349334, 14756.926215368854, 14794.260286985607, 23372.415689607897, 23392.7660723394, 23397.181098661466, 23705.288841334786, 23710.458820176635, 6720.462363010947, 7008.0, 7101.822454438577, 7178.928210717826, 8581.699640512677, 6694.297098804653, 6769.153855768029, 6813.727450902007, 6830.521863469509, 6857.965710171417, 4369.951211709231, 4399.032212913154, 4407.845725399596, 4420.778961051935, 4425.203463376559, 1764.9205785739673, 1784.794748603901, 1794.7128459446687, 1833.7432759413693, 1847.8706490545533, 893.1827377949234, 895.1585509620935, 907.0747837206013, 978.4520668425562, 981.239539357004, 15403.229838508254, 16170.676586468206, 16206.918965405097, 16356.509304720877, 16709.33162673504, 881.5415983688446, 882.3735148044832, 885.6590212768002, 899.536738579632, 904.3307952115518, 9317.301202409846, 9562.426254424618, 9604.0, 9635.181009614262, 9712.22302215821, 462860.0, 468279.0, 470800.0, 473847.0, 478286.0, 70182.0, 70745.2925470749, 72417.2758272421, 72724.63637681778, 73581.6320918392, 1044.9216308776872, 1053.0785562632695, 1057.0222544146634, 1069.962551310716, 1070.8500809886466, 14041.789373159207, 14560.271986400427, 14816.925915370353, 14917.403303868157, 15023.24883755786, 29625.0, 30141.0, 30449.0, 30765.69234307718, 30814.383712326075, 40304.59695403009, 40940.1811963765, 40983.59016409798, 41012.0, 41078.38382424326, 7204.675789589586, 7226.132864056347, 7344.926550734638, 7589.354904833151, 7603.619819008917, 10096.899031009889, 10698.8930110701, 11107.666769996913, 11135.610253641084, 11223.438828058728, 9512.95243523778, 9530.428174309563, 9613.423194608346, 9844.310898237054, 9863.457509837028, 8684.913150868662, 9517.666881659108, 9649.614015439303, 9670.613175473183, 9808.460534670661, 3311.519829624739, 3969.8213580388374, 8026.551901669814, 9258.0, 9985.900140998498, 7111.075560177351, 7116.323949224816, 7187.425005999612, 7252.347288744038, 7382.114146302478, 9417.340786144903, 9816.460094694861, 9833.311668183445, 9951.800963980535, 10145.594176232868], "unit": "score", "name": "jquery.html", "value": 8489.199940052358}, {"lowerIsBetter": false, "replicates": [1458.117838707582, 1483.6810085831548, 1642.4415698662453, 1771.3268957796035, 1790.8477779388759, 7786.299233069023, 7812.843743125134, 7962.761117166487, 8011.038675358958, 8012.879806802888, 8022.919770802305, 8028.157043510435, 8108.594570271493, 8116.472429292092, 8116.91883081169, 2388.988055059727, 2404.110479122727, 2409.132712223598, 2417.395651087228, 2418.141559746291, 2433.7687919647606, 2445.4497738008895, 2460.3849037740565, 2461.7415171407015, 2462.704475462947, 2081.573277478121, 2127.5106725453156, 2318.4435735423544, 2408.1691816323428, 2433.2700189943034, 2350.471143992605, 2354.5055538336883, 2358.0, 2367.242482405631, 2389.7251816041203, 2316.1661801751357, 2350.083467447697, 2350.9412264693347, 2353.599888019041, 2364.598018336887, 7772.922270777276, 7805.765827025199, 7858.567778772165, 7864.842703145962, 7880.172581878935, 4793.616510679172, 4876.366072410564, 4906.31311616374, 4929.876753081166, 4941.357623508921, 3183.6338821035647, 3199.312147888192, 3308.387948229585, 3322.0, 3322.069820450278, 970.8592254123113, 1030.4744580264119, 1032.3702541449709, 1042.8279333909895, 1081.5457507846722, 11090.778184436347, 11139.665810025632, 11144.498497567629, 11192.496337664825, 11208.66374008781, 4430.601245887886, 4482.462104547475, 4545.136424079415, 4556.658250631216, 4596.310553416947, 8957.372983891066, 8998.370114092082, 9053.411528250643, 9088.500132492643, 9133.49765762876, 4984.152694042022, 5026.095302845523, 5032.647714660012, 5038.168702164102, 5042.067217564762, 4599.862004139881, 4609.423822022247, 4631.328457373662, 4636.35091087248, 4645.070985802853, 3619.167591453928, 3651.068977410743, 3672.4491326300736, 3677.8161091945294, 3678.3562876496508, 1119.0599896087326, 1134.5178299222798, 1139.3847322445952, 1142.7086093046387, 1148.465963327057, 933.2347475070377, 936.8266870628955, 1043.4730461117088, 1089.199438412766, 1242.6458459339044, 7397.334239918326, 7415.666295016737, 7450.701971921062, 7464.962675186589, 7479.177290498041, 577.9104238842986, 609.2993057983355, 613.4049971527611, 613.7391608566342, 738.75621045055, 5743.396943320891, 5769.68266745333, 5812.854678633068, 5816.302043754777, 5817.476427121579, 9224.169824715807, 9228.169464748205, 9355.29835262358, 9416.340856140141, 9502.47736374506, 9227.307951903635, 9287.071292870658, 9360.859587106199, 9389.483578403253, 9457.90542094584, 7108.68010939509, 7197.388222001084, 7257.564546127143, 7331.193568707438, 7526.698932042657, 7383.926160738324, 7443.813904652427, 7472.663730132266, 7512.39900807945, 7528.058992625922, 8257.298129659046, 8305.335573154254, 8577.528235947082, 8590.226879580618, 8639.308855291687, 8657.264132548551, 8678.652853885775, 8689.30485561141, 8692.652293908173, 8794.956025219833, 6813.4889883257965, 7043.2604576518725, 7084.22073571917, 7093.6453177341955, 7097.893531596927, 7347.191808901123, 7350.669219885011, 7397.482176247611, 7404.148522919718, 7417.332440080419, 6730.46156307504, 6964.860702786017, 6994.125734283215, 7004.264552221944, 7079.327463890922, 6154.569180157346, 6727.831804204934, 7001.50989430735, 7102.218755936946, 7127.928720712726, 7189.317014883578, 7228.0, 7266.309700578437, 7273.3817625502425, 7282.708691652275, 6292.056191571301, 6303.243610766737, 6307.211598550181, 6330.651814150266, 6334.556581039283, 6598.307177746267, 6633.303503132294, 6637.933620663732, 6638.701258443285, 6678.699458524281], "unit": "score", "name": "mootools.html", "value": 4501.358560307705}, {"lowerIsBetter": false, "replicates": [342.45207667731626, 343.4504792332267, 346.4387691939059, 350.353597612405, 351.5991769382902, 6170.352113028129, 6211.720472578733, 6260.780872669452, 6302.684865756711, 6408.647524386157, 6191.5356348273945, 6197.845053873655, 6208.751649934008, 6220.440160385564, 6233.501319894409, 4760.166970780117, 4769.833055843046, 4789.161896668086, 4796.952030479702, 4803.519648035195, 4749.240121580548, 4785.449673287581, 4786.856394308176, 4796.640251981098, 4798.280257961299, 4658.231391820363, 4697.318888761128, 4722.97638511807, 4725.929111063337, 4734.0, 4703.34153218548, 4714.669973101884, 4715.2455607102875, 4717.43390793107, 4737.313089602006, 4122.91754164915, 4124.91750164995, 4126.525449573277, 4127.484064491939, 4129.648979836717, 5892.852678683067, 5898.174255604219, 5902.3507414184405, 5909.0, 5910.67491287979, 5352.304200453916, 5477.04151773442, 5514.007478653841, 5514.641548299348, 5526.336839579236, 6629.33706629338, 6633.4693224541925, 6638.93361066388, 6647.667616619198, 6647.767328143492, 4539.886502837422, 4544.204764166291, 4547.295169248771, 4565.383673204141, 4571.588557029883, 6749.392554670103, 6855.108835851307, 6859.279775623588, 6862.519623626298, 6921.065656136408, 4624.3294722265755, 4629.675922685447, 4641.814327426932, 4643.86068417948, 4646.628269738413, 4693.389859318267, 4694.577488026094, 4696.107739529479, 4699.506551812079, 4714.3871296731895, 5453.972730136404, 5465.890682186334, 5466.01611709888, 5469.56243500519, 5474.890502189934, 6480.805575832733, 6662.6668666566475, 6683.532152749261, 6705.463562914955, 6705.530612857053, 1643.3098098798532, 1677.865770738338, 1735.6355165415152, 1737.1835237438384, 1740.199508226205, 1137.8634563852224, 1138.163449864349, 1143.0341361549476, 1143.085531574737, 1150.9942450287695, 6143.109249158847, 6173.259208894961, 6194.938050619436, 6194.969025154845, 6230.532710046765, 6702.698378572976, 6710.597364158166, 6726.192856857208, 6753.932460675429, 6758.189017317954, 6079.361667024898, 6215.65813880241, 6263.467605253513, 6279.0895320178315, 6283.340249273851, 3658.359787037258, 3682.226732386229, 3696.353138200804, 3701.241245544657, 3702.4631428442726, 7112.288771122846, 7139.571625702474, 7140.893161559967, 7144.678489467987, 7145.356917877312, 6676.132102826601, 6859.176898772179, 6889.862202755917, 6927.203371612229, 6940.167179938338, 7095.822604434828, 7097.290270972861, 7100.7869763907165, 7110.182329032227, 7113.039739635186, 6714.462842972648, 6749.122614060338, 6751.966240168767, 6753.054572359972, 6765.019072234597, 6471.158749362553, 6615.040819081302, 6628.966855165693, 6684.565503242274, 6701.865962680817, 7007.684654190675, 7049.894251586333, 7090.326418990187, 7096.716131354688, 7101.573905565682, 4808.374911261653, 4809.44691360498, 4812.759362031815, 4813.855584332476, 4839.733814640088, 6661.4004739573675, 6696.866062678817, 6698.39714425704, 6719.160104986877, 6952.721891124298, 6679.532432729662, 6727.730890764315, 6756.087928129639, 6759.425448836904, 6776.322367763381, 6734.393904548614, 6751.392374686302, 6751.864962700817, 6759.087523184307, 6770.341266389569, 6487.54587178893, 6579.80260592183, 6620.205575330991, 6631.0, 6641.767538136335, 6743.5953842769595, 6753.2909044549615, 6758.0, 6762.7294908205085, 6799.456043516408, 6543.836404089936, 6603.976383660541, 6606.240282367589, 6607.438367738796, 6615.470762339098], "unit": "score", "name": "prototype.html", "value": 4988.615934824928}, {"lowerIsBetter": false, "replicates": [744.8137965508623, 746.2574738135553, 760.8212070163512, 826.7767702720262, 830.1698301698302, 12592.559260425887, 12620.242785432869, 12628.305443200621, 12680.492780288778, 12713.809292860615, 12171.57399491018, 12299.754004919896, 12320.383980800947, 12338.383080845944, 12417.56538521152, 771.4792515052345, 792.0178978067213, 795.0618270440877, 797.0753925446484, 799.0251892690908, 786.5084322298563, 786.5162924801264, 790.3282210121408, 791.3471386106456, 793.9166387529312, 822.7408366364576, 825.228411435307, 828.8383765165795, 830.5888585150359, 831.5301854452215, 822.9917700822975, 824.814416756231, 824.8721448175543, 826.7478419082178, 828.7928017995501, 603.1856993059379, 606.854354954812, 607.0802733858164, 608.0969759906535, 609.8383928259015, 13869.583912482642, 13962.441502339894, 13968.58094257174, 13981.79027314591, 13988.650283742885, 12417.317047562381, 12459.439325230387, 12536.185147965445, 12598.61236981679, 12804.231746095264, 10211.948940255326, 10304.742381440448, 10500.317479363894, 11512.0, 11720.238184517979, 4238.766867822269, 4271.1671224111315, 4290.120525292339, 4435.911281774379, 4449.443819522559, 42902.78548607237, 42996.57003429957, 42998.0, 43293.35059974103, 43298.134037319076, 9214.549815129436, 9596.952015240018, 9752.414855108716, 9788.363756355815, 9968.352057116264, 18101.637967240582, 18460.630787384176, 18467.261309547466, 18638.627227455647, 18687.345942892207, 7194.100737407824, 7281.381082608038, 7380.852382952311, 7568.281013303727, 7675.0, 4060.3706425504092, 4143.212789569972, 4165.729227600257, 4178.8328466860985, 4188.832446702158, 3111.719945204897, 3121.282105115836, 3135.8275294859, 3141.7172454479205, 3146.2920842810186, 564.1058921609214, 583.1311346094374, 588.1648059755158, 589.5755056359415, 593.4540222994768, 558.3746204251183, 561.9241402410622, 601.5097695378253, 650.0314531348257, 669.4160540314383, 8715.346349023848, 8800.119988001148, 8885.0, 9383.155516003457, 9941.0, 531.3066448284948, 547.8137433272707, 584.9736761845727, 585.8974679431083, 685.2428066985909, 3980.86066987654, 4126.793660316972, 4148.8133034013545, 4201.306784380604, 4239.51245606753, 51925.0, 52822.0, 52845.73577132167, 52966.205506917424, 52976.20535691968, 49377.50622493729, 50768.238476422885, 50815.491845081815, 51253.74373128185, 51586.0, 42613.36079958803, 44701.0, 44853.55146448494, 45152.096958060654, 45437.772811135736, 8708.521031343336, 8892.421992570462, 9245.676401325922, 9402.717918462457, 9488.288378371511, 33144.33711325808, 33196.33607327888, 33731.83134084314, 34114.82942585271, 34220.82889585536, 38939.80530097331, 39184.0, 41921.16157676891, 42371.364429534195, 42685.78657106694, 10686.305390149615, 10746.355218686904, 10889.401082940514, 10906.34561926287, 10955.616553420592, 12035.097367697634, 12054.578089767167, 12192.390380481118, 12502.624921252376, 12678.683032924251, 11404.0, 11687.240329378563, 11709.297442153498, 12105.51577936908, 12111.576094836639, 11195.776084478102, 11224.382658953837, 11664.125190610568, 11720.648380548597, 12119.45462454174, 11701.414929253673, 11741.941290293495, 11791.646250612495, 11794.882051179378, 12113.939430302793, 9289.117533834275, 9372.297077719335, 9542.709749660171, 9880.25898057663, 10017.198624110199, 9816.901830981598, 10371.553337492202, 10377.169826413718, 10404.219683523615, 10420.583176672848], "unit": "score", "name": "yui.html", "value": 6266.570201180435}], "name": "dromaeo_css", "value": 7014.487174701064}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 111.0, 123.0, 111.0, 111.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [162.0, 129.0, 157.0, 169.0, 130.0, 149.0, 157.0, 130.0, 176.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 169.0, 164.0, 163.0, 164.0, 166.0, 172.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 76.0, 73.0, 76.0, 135.0, 73.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 97.0, 96.0, 96.0, 141.0, 96.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 97.0, 97.0, 98.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 62.0, 61.0, 61.0, 60.0, 61.0, 67.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 71.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 81.0, 91.0, 81.0, 83.0, 81.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [128.0, 119.0, 129.0, 120.0, 116.0, 118.0, 116.0, 123.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [139.0, 149.0, 149.0, 144.0, 139.0, 139.0, 146.0, 163.0, 144.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 68.0, 68.0, 67.0, 70.0, 72.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1515.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.00265604249668], "unit": "score", "name": "Richards", "value": 212.659248}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1076.4262648008612], "unit": "score", "name": "RayTrace", "value": 687.4497810000001}, {"lowerIsBetter": false, "replicates": [689.6551724137931], "unit": "score", "name": "Earley", "value": 966.3713500000002}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [42291.666666666664], "unit": "score", "name": "RegExp", "value": 21.540532019704436}, {"lowerIsBetter": false, "replicates": [593.4718100890208], "unit": "score", "name": "Splay", "value": 137.31233500000002}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20371.3983916099}]} 23:11:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20371.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1515.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7014.49"}}} 23:11:20 INFO - Return code: 0 23:11:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:11:20 INFO - # TBPL SUCCESS # 23:11:20 INFO - Running post-action listener: _resource_record_post_action 23:11:20 INFO - Running post-run listener: _resource_record_post_run 23:11:21 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 565731328; Read time: 4; Write time: 412380 23:11:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 251662336; Read time: 0; Write time: 218644 23:11:21 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314068992; Read time: 4; Write time: 193736 23:11:21 INFO - Running post-run listener: _upload_blobber_files 23:11:21 INFO - Blob upload gear active. 23:11:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:11:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:11:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:11:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:11:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:11:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:11:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:23 INFO - (blobuploader) - INFO - Done attempting. 23:11:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:11:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:11:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:11:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:11:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:11:23 INFO - (blobuploader) - INFO - Done attempting. 23:11:23 INFO - (blobuploader) - INFO - Iteration through files over. 23:11:23 INFO - Return code: 0 23:11:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:11:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:11:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/206f7403b883e234bc9cca34a2a89f3bae248ab9d4a41ab57485e5ed6c7a5201b8d4a95a68081028e80ab1a035158cd4a3a6604882b1847e7717f546a7173772", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83dcfcccce1a58145b0111b87d4a6bac59ac081bf55d3a0de7b3de80e64633b7709308424cac6ca6707a2083830c43b31b983709ad3f788e510b47c1ea32f54d"} 23:11:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:11:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:11:23 INFO - Contents: 23:11:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/206f7403b883e234bc9cca34a2a89f3bae248ab9d4a41ab57485e5ed6c7a5201b8d4a95a68081028e80ab1a035158cd4a3a6604882b1847e7717f546a7173772", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83dcfcccce1a58145b0111b87d4a6bac59ac081bf55d3a0de7b3de80e64633b7709308424cac6ca6707a2083830c43b31b983709ad3f788e510b47c1ea32f54d"} 23:11:23 INFO - Running post-run listener: copy_logs_to_upload_dir 23:11:23 INFO - Copying logs to upload dir... 23:11:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:11:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.749886 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-21 23:11:23.701201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 23:11:23.704803) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/206f7403b883e234bc9cca34a2a89f3bae248ab9d4a41ab57485e5ed6c7a5201b8d4a95a68081028e80ab1a035158cd4a3a6604882b1847e7717f546a7173772", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83dcfcccce1a58145b0111b87d4a6bac59ac081bf55d3a0de7b3de80e64633b7709308424cac6ca6707a2083830c43b31b983709ad3f788e510b47c1ea32f54d"} build_url:https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/GxKzXcsPSVO7btU1GvBFHg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/206f7403b883e234bc9cca34a2a89f3bae248ab9d4a41ab57485e5ed6c7a5201b8d4a95a68081028e80ab1a035158cd4a3a6604882b1847e7717f546a7173772", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83dcfcccce1a58145b0111b87d4a6bac59ac081bf55d3a0de7b3de80e64633b7709308424cac6ca6707a2083830c43b31b983709ad3f788e510b47c1ea32f54d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 23:11:23.734254) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:11:23.734621) ========= 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=6dbc10da6d83fee962c624be000001a8-1453444153.519820-78178917 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:11:23.784544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 23:11:23.784909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 23:11:23.785293) ========= ========= Total master_lag: 0.43 =========