builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1451599393.47 results: success (0) buildid: 20151231113015 builduid: fe2ce72207064072ab96a153974b12a7 revision: 163980e9e4646556c12c3bf7852ba6e266ee4236 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.468244) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.468734) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.469030) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006297 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.507631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.507935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.538381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.538683) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.053504 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.604768) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.605177) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.605594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.605871) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 14:03:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.9M=0s 2015-12-31 14:03:13 (64.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211430 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.829496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.829830) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.127378 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.966605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:13.966954) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 163980e9e4646556c12c3bf7852ba6e266ee4236 --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 163980e9e4646556c12c3bf7852ba6e266ee4236 --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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 14:03:14,019 truncating revision to first 12 chars 2015-12-31 14:03:14,019 Setting DEBUG logging. 2015-12-31 14:03:14,020 attempt 1/10 2015-12-31 14:03:14,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/163980e9e464?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 14:03:14,503 unpacking tar archive at: fx-team-163980e9e464/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:14.751821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:14.752151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:14.762311) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:14.762697) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 14:03:14.763195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-31 14:03:14.763489) ========= /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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:03:15 INFO - MultiFileLogger online at 20151231 14:03:15 in /builds/slave/test-pgo 14:03: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 14:03:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:03:15 INFO - {'append_to_log': False, 14:03:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:03:15 INFO - 'blob_upload_branch': 'Fx-Team', 14:03:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:03:15 INFO - 'branch': 'Fx-Team', 14:03:15 INFO - 'buildbot_json_path': 'buildprops.json', 14:03:15 INFO - 'config_files': ('talos/linux_config.py',), 14:03:15 INFO - 'default_actions': ('clobber', 14:03:15 INFO - 'read-buildbot-config', 14:03:15 INFO - 'download-and-extract', 14:03:15 INFO - 'populate-webroot', 14:03:15 INFO - 'create-virtualenv', 14:03:15 INFO - 'install', 14:03:15 INFO - 'run-tests'), 14:03:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:03:15 INFO - 'download_minidump_stackwalk': True, 14:03:15 INFO - 'download_symbols': 'ondemand', 14:03:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:03:15 INFO - 'tooltool.py': '/tools/tooltool.py', 14:03:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:03:15 INFO - '/tools/misc-python/virtualenv.py')}, 14:03:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:03:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:03:15 INFO - 'installer_path': 'installer.exe', 14:03:15 INFO - 'log_level': 'info', 14:03:15 INFO - 'log_name': 'talos', 14:03:15 INFO - 'log_to_console': True, 14:03:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:03:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:03:15 INFO - 'opt_config_files': (), 14:03:15 INFO - 'pip_index': False, 14:03:15 INFO - 'sps_profile': False, 14:03:15 INFO - 'sps_profile_interval': 0, 14:03:15 INFO - 'suite': 'dromaeojs-e10s', 14:03:15 INFO - 'system_bits': '32', 14:03:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:03:15 INFO - 'title': 'talos-linux64-ix-009', 14:03:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:03:15 INFO - 'use_talos_json': True, 14:03:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:03:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:03:15 INFO - 'work_dir': 'build'} 14:03:15 INFO - ##### 14:03:15 INFO - ##### Running clobber step. 14:03:15 INFO - ##### 14:03:15 INFO - Running pre-action listener: _resource_record_pre_action 14:03:15 INFO - Running main action method: clobber 14:03:15 INFO - rmtree: /builds/slave/test-pgo/build 14:03:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:03:16 INFO - Running post-action listener: _resource_record_post_action 14:03:16 INFO - ##### 14:03:16 INFO - ##### Running read-buildbot-config step. 14:03:16 INFO - ##### 14:03:16 INFO - Running pre-action listener: _resource_record_pre_action 14:03:16 INFO - Running main action method: read_buildbot_config 14:03:16 INFO - Using buildbot properties: 14:03:16 INFO - { 14:03:16 INFO - "project": "", 14:03:16 INFO - "product": "firefox", 14:03:16 INFO - "script_repo_revision": "production", 14:03:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:03:16 INFO - "repository": "", 14:03:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:03:16 INFO - "buildid": "20151231113015", 14:03:16 INFO - "pgo_build": "True", 14:03:16 INFO - "basedir": "/builds/slave/test-pgo", 14:03:16 INFO - "buildnumber": 117, 14:03:16 INFO - "slavename": "talos-linux64-ix-009", 14:03:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:03:16 INFO - "platform": "ubuntu64_hw", 14:03:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:03:16 INFO - "branch": "fx-team", 14:03:16 INFO - "repo_path": "integration/fx-team", 14:03:16 INFO - "revision": "163980e9e4646556c12c3bf7852ba6e266ee4236", 14:03:16 INFO - "stage_platform": "linux64-pgo", 14:03:16 INFO - "builduid": "fe2ce72207064072ab96a153974b12a7", 14:03:16 INFO - "slavebuilddir": "test" 14:03:16 INFO - } 14:03:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:03:16 INFO - Running post-action listener: _resource_record_post_action 14:03:16 INFO - ##### 14:03:16 INFO - ##### Running download-and-extract step. 14:03:16 INFO - ##### 14:03:16 INFO - Running pre-action listener: _resource_record_pre_action 14:03:16 INFO - Running main action method: download_and_extract 14:03:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:03: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')]} 14:03:16 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:03:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json 14:03:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json 14:03:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:03:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:03:24 INFO - Downloaded 1302 bytes. 14:03:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:03:24 INFO - Using the following test package requirements: 14:03:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:03:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'jsshell-linux-x86_64.zip'], 14:03:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:03:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:03:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:03:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:03:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:03:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:03:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:03:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:24 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:03:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:03:26 INFO - Downloaded 23195441 bytes. 14:03:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:03:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:03:27 INFO - Return code: 0 14:03:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:03:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:27 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:03:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:03:30 INFO - Downloaded 23195441 bytes. 14:03:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:03:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:03:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:03:31 INFO - Return code: 0 14:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:31 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:03:32 INFO - Downloaded 11132285 bytes. 14:03:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:03:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:03:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:03:32 INFO - Return code: 0 14:03: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')]} 14:03:32 INFO - https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:03:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:03:34 INFO - Downloaded 54949941 bytes. 14:03:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:34 INFO - mkdir: /builds/slave/test-pgo/properties 14:03:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:03:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:03:34 INFO - Contents: 14:03:34 INFO - build_url:https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:03:34 INFO - Running post-action listener: _resource_record_post_action 14:03:34 INFO - Running post-action listener: set_extra_try_arguments 14:03:34 INFO - ##### 14:03:34 INFO - ##### Running populate-webroot step. 14:03:34 INFO - ##### 14:03:34 INFO - Running pre-action listener: _resource_record_pre_action 14:03:34 INFO - Running main action method: populate_webroot 14:03:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:03:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:03:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:03:34 INFO - '--tppagecycles', 14:03:34 INFO - '7'], 14:03:34 INFO - 'tests': ['tsvgm']}}, 14:03:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:03:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:03:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:03:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:03:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'tests': ['damp', 'tps']}, 14:03:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['damp', 'tps']}, 14:03:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:03:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:03:34 INFO - 'other': {'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'other_l64': {'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'other_nol64': {'tests': ['a11yr', 14:03:34 INFO - 'ts_paint', 14:03:34 INFO - 'tpaint', 14:03:34 INFO - 'sessionrestore', 14:03:34 INFO - 'sessionrestore_no_auto_restore']}, 14:03:34 INFO - 'svgr': {'tests': ['tsvgx', 14:03:34 INFO - 'tsvgr_opacity', 14:03:34 INFO - 'tart', 14:03:34 INFO - 'tscrollx', 14:03:34 INFO - 'cart']}, 14:03:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['tsvgx', 14:03:34 INFO - 'tsvgr_opacity', 14:03:34 INFO - 'tart', 14:03:34 INFO - 'tscrollx', 14:03:34 INFO - 'cart']}, 14:03:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'tests': ['tp5o']}, 14:03:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'talos_options': ['--e10s'], 14:03:34 INFO - 'tests': ['tp5o']}, 14:03:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'talos_options': ['--xperf_path', 14:03:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:34 INFO - 'tests': ['tp5n']}, 14:03:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:03:34 INFO - 'talos_options': ['--e10s', 14:03:34 INFO - '--xperf_path', 14:03:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:03:34 INFO - 'tests': ['tp5n']}}, 14:03:34 INFO - 'talos.zip': {'path': '', 14:03:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:03:34 INFO - Running post-action listener: _resource_record_post_action 14:03:34 INFO - ##### 14:03:34 INFO - ##### Running create-virtualenv step. 14:03:34 INFO - ##### 14:03:34 INFO - Running pre-action listener: _resource_record_pre_action 14:03:34 INFO - Running main action method: create_virtualenv 14:03:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:03:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:03:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:03:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:03:34 INFO - Using real prefix '/usr' 14:03:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:03:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:03:36 INFO - Installing pip.................done. 14:03:36 INFO - Return code: 0 14:03:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:03:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:03:36 INFO - Using env: {'DISPLAY': ':0', 14:03:36 INFO - 'HOME': '/home/cltbld', 14:03:36 INFO - 'LANG': 'en_US.UTF-8', 14:03:36 INFO - 'LANGUAGE': 'en_US:en', 14:03:36 INFO - 'LOGNAME': 'cltbld', 14:03:36 INFO - 'MAIL': '/var/mail/cltbld', 14:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:36 INFO - 'MOZ_NO_REMOTE': '1', 14:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:36 INFO - 'NO_EM_RESTART': '1', 14:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:36 INFO - 'SHELL': '/bin/bash', 14:03:36 INFO - 'SHLVL': '1', 14:03:36 INFO - 'TERM': 'linux', 14:03:36 INFO - 'TMOUT': '86400', 14:03:36 INFO - 'USER': 'cltbld', 14:03:36 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:36 INFO - '_': '/tools/buildbot/bin/python'} 14:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:03:37 INFO - Cleaning up... 14:03:37 INFO - Return code: 0 14:03:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:03:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:03:37 INFO - Using env: {'DISPLAY': ':0', 14:03:37 INFO - 'HOME': '/home/cltbld', 14:03:37 INFO - 'LANG': 'en_US.UTF-8', 14:03:37 INFO - 'LANGUAGE': 'en_US:en', 14:03:37 INFO - 'LOGNAME': 'cltbld', 14:03:37 INFO - 'MAIL': '/var/mail/cltbld', 14:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:37 INFO - 'MOZ_NO_REMOTE': '1', 14:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:37 INFO - 'NO_EM_RESTART': '1', 14:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:37 INFO - 'SHELL': '/bin/bash', 14:03:37 INFO - 'SHLVL': '1', 14:03:37 INFO - 'TERM': 'linux', 14:03:37 INFO - 'TMOUT': '86400', 14:03:37 INFO - 'USER': 'cltbld', 14:03:37 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:37 INFO - '_': '/tools/buildbot/bin/python'} 14:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:37 INFO - Downloading/unpacking psutil>=0.7.1 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:03:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:03:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:03:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:39 INFO - Installing collected packages: psutil 14:03:39 INFO - Running setup.py install for psutil 14:03:39 INFO - building 'psutil._psutil_linux' extension 14:03:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:03:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:03:39 INFO - building 'psutil._psutil_posix' extension 14:03:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:03:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:03:40 INFO - Successfully installed psutil 14:03:40 INFO - Cleaning up... 14:03:40 INFO - Return code: 0 14:03:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:03:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:03:40 INFO - Using env: {'DISPLAY': ':0', 14:03:40 INFO - 'HOME': '/home/cltbld', 14:03:40 INFO - 'LANG': 'en_US.UTF-8', 14:03:40 INFO - 'LANGUAGE': 'en_US:en', 14:03:40 INFO - 'LOGNAME': 'cltbld', 14:03:40 INFO - 'MAIL': '/var/mail/cltbld', 14:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:40 INFO - 'MOZ_NO_REMOTE': '1', 14:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:40 INFO - 'NO_EM_RESTART': '1', 14:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:40 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:40 INFO - 'SHELL': '/bin/bash', 14:03:40 INFO - 'SHLVL': '1', 14:03:40 INFO - 'TERM': 'linux', 14:03:40 INFO - 'TMOUT': '86400', 14:03:40 INFO - 'USER': 'cltbld', 14:03:40 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:40 INFO - '_': '/tools/buildbot/bin/python'} 14:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:03:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:03:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:03:42 INFO - Installing collected packages: mozsystemmonitor 14:03:42 INFO - Running setup.py install for mozsystemmonitor 14:03:42 INFO - Successfully installed mozsystemmonitor 14:03:42 INFO - Cleaning up... 14:03:42 INFO - Return code: 0 14:03:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:03:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:03:42 INFO - Using env: {'DISPLAY': ':0', 14:03:42 INFO - 'HOME': '/home/cltbld', 14:03:42 INFO - 'LANG': 'en_US.UTF-8', 14:03:42 INFO - 'LANGUAGE': 'en_US:en', 14:03:42 INFO - 'LOGNAME': 'cltbld', 14:03:42 INFO - 'MAIL': '/var/mail/cltbld', 14:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:42 INFO - 'MOZ_NO_REMOTE': '1', 14:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:42 INFO - 'NO_EM_RESTART': '1', 14:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:42 INFO - 'SHELL': '/bin/bash', 14:03:42 INFO - 'SHLVL': '1', 14:03:42 INFO - 'TERM': 'linux', 14:03:42 INFO - 'TMOUT': '86400', 14:03:42 INFO - 'USER': 'cltbld', 14:03:42 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:42 INFO - '_': '/tools/buildbot/bin/python'} 14:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:03:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:03:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:03:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:03:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:03:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:44 INFO - Downloading docopt-0.6.1.tar.gz 14:03:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:03:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:03:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:03:44 INFO - Running setup.py install for blobuploader 14:03:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:03:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:03:44 INFO - Running setup.py install for requests 14:03:45 INFO - Running setup.py install for docopt 14:03:45 INFO - Successfully installed blobuploader requests docopt 14:03:45 INFO - Cleaning up... 14:03:45 INFO - Return code: 0 14:03:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:45 INFO - Using env: {'DISPLAY': ':0', 14:03:45 INFO - 'HOME': '/home/cltbld', 14:03:45 INFO - 'LANG': 'en_US.UTF-8', 14:03:45 INFO - 'LANGUAGE': 'en_US:en', 14:03:45 INFO - 'LOGNAME': 'cltbld', 14:03:45 INFO - 'MAIL': '/var/mail/cltbld', 14:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:45 INFO - 'MOZ_NO_REMOTE': '1', 14:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:45 INFO - 'NO_EM_RESTART': '1', 14:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:45 INFO - 'SHELL': '/bin/bash', 14:03:45 INFO - 'SHLVL': '1', 14:03:45 INFO - 'TERM': 'linux', 14:03:45 INFO - 'TMOUT': '86400', 14:03:45 INFO - 'USER': 'cltbld', 14:03:45 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:45 INFO - '_': '/tools/buildbot/bin/python'} 14:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:45 INFO - Running setup.py (path:/tmp/pip-XFmucW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:45 INFO - Running setup.py (path:/tmp/pip-x5q4mD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:45 INFO - Running setup.py (path:/tmp/pip-0ebMIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:45 INFO - Running setup.py (path:/tmp/pip-7HCHpV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:45 INFO - Running setup.py (path:/tmp/pip-uRLFTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:46 INFO - Running setup.py (path:/tmp/pip-Ud7xHm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:46 INFO - Running setup.py (path:/tmp/pip-z69x6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:46 INFO - Running setup.py (path:/tmp/pip-y76n0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:46 INFO - Running setup.py (path:/tmp/pip-gncS7i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:46 INFO - Running setup.py (path:/tmp/pip-6b0bqp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:46 INFO - Running setup.py (path:/tmp/pip-NnuZ0X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:46 INFO - Running setup.py (path:/tmp/pip-70qm9U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:46 INFO - Running setup.py (path:/tmp/pip-meeiVG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:46 INFO - Running setup.py (path:/tmp/pip-Y5J3Kr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:46 INFO - Running setup.py (path:/tmp/pip-UZwYEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:46 INFO - Running setup.py (path:/tmp/pip-pRQ6oZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:46 INFO - Running setup.py (path:/tmp/pip-P71H2G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:03:46 INFO - Running setup.py install for manifestparser 14:03:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for mozcrash 14:03:47 INFO - Running setup.py install for mozdebug 14:03:47 INFO - Running setup.py install for mozdevice 14:03:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for mozfile 14:03:47 INFO - Running setup.py install for mozhttpd 14:03:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for mozinfo 14:03:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for mozInstall 14:03:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for mozleak 14:03:47 INFO - Running setup.py install for mozlog 14:03:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:03:47 INFO - Running setup.py install for moznetwork 14:03:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Running setup.py install for mozprocess 14:03:48 INFO - Running setup.py install for mozprofile 14:03:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Running setup.py install for mozrunner 14:03:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Running setup.py install for mozscreenshot 14:03:48 INFO - Running setup.py install for moztest 14:03:48 INFO - Running setup.py install for mozversion 14:03:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:48 INFO - Cleaning up... 14:03:48 INFO - Return code: 0 14:03:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:03:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:48 INFO - Using env: {'DISPLAY': ':0', 14:03:48 INFO - 'HOME': '/home/cltbld', 14:03:48 INFO - 'LANG': 'en_US.UTF-8', 14:03:48 INFO - 'LANGUAGE': 'en_US:en', 14:03:48 INFO - 'LOGNAME': 'cltbld', 14:03:48 INFO - 'MAIL': '/var/mail/cltbld', 14:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:48 INFO - 'MOZ_NO_REMOTE': '1', 14:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:48 INFO - 'NO_EM_RESTART': '1', 14:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:48 INFO - 'SHELL': '/bin/bash', 14:03:48 INFO - 'SHLVL': '1', 14:03:48 INFO - 'TERM': 'linux', 14:03:48 INFO - 'TMOUT': '86400', 14:03:48 INFO - 'USER': 'cltbld', 14:03:48 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:48 INFO - '_': '/tools/buildbot/bin/python'} 14:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:48 INFO - Running setup.py (path:/tmp/pip-78Umyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:48 INFO - Running setup.py (path:/tmp/pip-q8Rltq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:49 INFO - Running setup.py (path:/tmp/pip-rvDcod-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:49 INFO - Running setup.py (path:/tmp/pip-sD4fa0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:49 INFO - Running setup.py (path:/tmp/pip-2JWE0Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:49 INFO - Running setup.py (path:/tmp/pip-EoISss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:49 INFO - Running setup.py (path:/tmp/pip-qo8Id2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:49 INFO - Running setup.py (path:/tmp/pip-3pBod9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:49 INFO - Running setup.py (path:/tmp/pip-FGtPx6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:49 INFO - Running setup.py (path:/tmp/pip-qolT3b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:49 INFO - Running setup.py (path:/tmp/pip-BUQZGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:49 INFO - Running setup.py (path:/tmp/pip-uTa9CA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:49 INFO - Running setup.py (path:/tmp/pip-EqVIAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:49 INFO - Running setup.py (path:/tmp/pip-gmAUBF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:49 INFO - Running setup.py (path:/tmp/pip-VDqEjS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:49 INFO - Running setup.py (path:/tmp/pip-vEDscc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:03:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:50 INFO - Running setup.py (path:/tmp/pip-rb1QAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03: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 14:03:51 INFO - Downloading blessings-1.5.1.tar.gz 14:03:51 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:03:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:51 INFO - Installing collected packages: blessings 14:03:51 INFO - Running setup.py install for blessings 14:03:51 INFO - Successfully installed blessings 14:03:51 INFO - Cleaning up... 14:03:52 INFO - Return code: 0 14:03:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:52 INFO - Reading from file tmpfile_stdout 14:03:52 INFO - Current package versions: 14:03:52 INFO - argparse == 1.2.1 14:03:52 INFO - blessings == 1.5.1 14:03:52 INFO - blobuploader == 1.2.4 14:03:52 INFO - docopt == 0.6.1 14:03:52 INFO - manifestparser == 1.1 14:03:52 INFO - mozInstall == 1.12 14:03:52 INFO - mozcrash == 0.16 14:03:52 INFO - mozdebug == 0.1 14:03:52 INFO - mozdevice == 0.47 14:03:52 INFO - mozfile == 1.2 14:03:52 INFO - mozhttpd == 0.7 14:03:52 INFO - mozinfo == 0.9 14:03:52 INFO - mozleak == 0.1 14:03:52 INFO - mozlog == 3.1 14:03:52 INFO - moznetwork == 0.27 14:03:52 INFO - mozprocess == 0.22 14:03:52 INFO - mozprofile == 0.28 14:03:52 INFO - mozrunner == 6.11 14:03:52 INFO - mozscreenshot == 0.1 14:03:52 INFO - mozsystemmonitor == 0.0 14:03:52 INFO - moztest == 0.7 14:03:52 INFO - mozversion == 1.4 14:03:52 INFO - psutil == 3.1.1 14:03:52 INFO - requests == 1.2.3 14:03:52 INFO - wsgiref == 0.1.2 14:03:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:03:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:52 INFO - Using env: {'DISPLAY': ':0', 14:03:52 INFO - 'HOME': '/home/cltbld', 14:03:52 INFO - 'LANG': 'en_US.UTF-8', 14:03:52 INFO - 'LANGUAGE': 'en_US:en', 14:03:52 INFO - 'LOGNAME': 'cltbld', 14:03:52 INFO - 'MAIL': '/var/mail/cltbld', 14:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:52 INFO - 'MOZ_NO_REMOTE': '1', 14:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:52 INFO - 'NO_EM_RESTART': '1', 14:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:52 INFO - 'SHELL': '/bin/bash', 14:03:52 INFO - 'SHLVL': '1', 14:03:52 INFO - 'TERM': 'linux', 14:03:52 INFO - 'TMOUT': '86400', 14:03:52 INFO - 'USER': 'cltbld', 14:03:52 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:52 INFO - '_': '/tools/buildbot/bin/python'} 14:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:52 INFO - Cleaning up... 14:03:52 INFO - Return code: 0 14:03:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:03:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:03:52 INFO - Using env: {'DISPLAY': ':0', 14:03:52 INFO - 'HOME': '/home/cltbld', 14:03:52 INFO - 'LANG': 'en_US.UTF-8', 14:03:52 INFO - 'LANGUAGE': 'en_US:en', 14:03:52 INFO - 'LOGNAME': 'cltbld', 14:03:52 INFO - 'MAIL': '/var/mail/cltbld', 14:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:52 INFO - 'MOZ_NO_REMOTE': '1', 14:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:52 INFO - 'NO_EM_RESTART': '1', 14:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:52 INFO - 'SHELL': '/bin/bash', 14:03:52 INFO - 'SHLVL': '1', 14:03:52 INFO - 'TERM': 'linux', 14:03:52 INFO - 'TMOUT': '86400', 14:03:52 INFO - 'USER': 'cltbld', 14:03:52 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:52 INFO - '_': '/tools/buildbot/bin/python'} 14:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:52 INFO - Downloading/unpacking jsonschema 14:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:03:54 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:03:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:54 INFO - warning: no files found matching '*.txt' 14:03:54 INFO - no previously-included directories found matching 'build' 14:03:54 INFO - no previously-included directories found matching 'dist' 14:03:54 INFO - no previously-included directories found matching '.git*' 14:03:54 INFO - Installing collected packages: jsonschema, functools32 14:03:54 INFO - Running setup.py install for functools32 14:03:54 INFO - warning: no files found matching '*.txt' 14:03:54 INFO - no previously-included directories found matching 'build' 14:03:54 INFO - no previously-included directories found matching 'dist' 14:03:54 INFO - no previously-included directories found matching '.git*' 14:03:54 INFO - Successfully installed jsonschema functools32 14:03:54 INFO - Cleaning up... 14:03:54 INFO - Return code: 0 14:03:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6bfb1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d36c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, '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': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:03:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:03:54 INFO - Using env: {'DISPLAY': ':0', 14:03:54 INFO - 'HOME': '/home/cltbld', 14:03:54 INFO - 'LANG': 'en_US.UTF-8', 14:03:54 INFO - 'LANGUAGE': 'en_US:en', 14:03:54 INFO - 'LOGNAME': 'cltbld', 14:03:54 INFO - 'MAIL': '/var/mail/cltbld', 14:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:54 INFO - 'MOZ_NO_REMOTE': '1', 14:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:54 INFO - 'NO_EM_RESTART': '1', 14:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:54 INFO - 'SHELL': '/bin/bash', 14:03:54 INFO - 'SHLVL': '1', 14:03:54 INFO - 'TERM': 'linux', 14:03:54 INFO - 'TMOUT': '86400', 14:03:54 INFO - 'USER': 'cltbld', 14:03:54 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:54 INFO - '_': '/tools/buildbot/bin/python'} 14:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:55 INFO - Downloading/unpacking flake8 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:03:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:03:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:03:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:03:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:57 INFO - no previously-included directories found matching 'docs/_build' 14:03:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:57 INFO - Running setup.py install for pep8 14:03:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:57 INFO - no previously-included directories found matching 'docs/_build' 14:03:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:57 INFO - Cleaning up... 14:03:57 INFO - Return code: 0 14:03:57 INFO - Running post-action listener: _resource_record_post_action 14:03:57 INFO - Running post-action listener: _start_resource_monitoring 14:03:57 INFO - Starting resource monitoring. 14:03:57 INFO - ##### 14:03:57 INFO - ##### Running install step. 14:03:57 INFO - ##### 14:03:57 INFO - Running pre-action listener: _resource_record_pre_action 14:03:57 INFO - Running main action method: install 14:03:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:57 INFO - Reading from file tmpfile_stdout 14:03:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:57 INFO - Reading from file tmpfile_stdout 14:03:57 INFO - Output received: 14:03:57 INFO - Usage: mozinstall [options] installer 14:03:57 INFO - Options: 14:03:57 INFO - -h, --help show this help message and exit 14:03:57 INFO - -d DEST, --destination=DEST 14:03:57 INFO - Directory to install application into. [default: 14:03:57 INFO - "/builds/slave/test-pgo"] 14:03:57 INFO - --app=APP Application being installed. [default: firefox] 14:03:57 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:03:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:04:13 INFO - Reading from file tmpfile_stdout 14:04:13 INFO - Output received: 14:04:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:04:13 INFO - Running post-action listener: _resource_record_post_action 14:04:13 INFO - ##### 14:04:13 INFO - ##### Running run-tests step. 14:04:13 INFO - ##### 14:04:13 INFO - Running pre-action listener: _resource_record_pre_action 14:04:13 INFO - Running main action method: run_tests 14:04:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:04:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:04:13 INFO - Python 2.7.3 14:04:13 INFO - Return code: 0 14:04:13 INFO - grabbing minidump binary from tooltool 14:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:13 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 0x23d0e40>, '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 0x23d1740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23d1bf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:04:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:04:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:04:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:04:13 INFO - Return code: 0 14:04:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:04:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:04:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:04:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:04:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:04:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:04:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:04:14 INFO - Return code: 0 14:04:14 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:04:14 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 14:04:14 INFO - Using env: {'DISPLAY': ':0', 14:04:14 INFO - 'HOME': '/home/cltbld', 14:04:14 INFO - 'LANG': 'en_US.UTF-8', 14:04:14 INFO - 'LANGUAGE': 'en_US:en', 14:04:14 INFO - 'LOGNAME': 'cltbld', 14:04:14 INFO - 'MAIL': '/var/mail/cltbld', 14:04:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:04:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:04:14 INFO - 'MOZ_NO_REMOTE': '1', 14:04:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:04:14 INFO - 'NO_EM_RESTART': '1', 14:04:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:04:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:04:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:04:14 INFO - 'SHELL': '/bin/bash', 14:04:14 INFO - 'SHLVL': '1', 14:04:14 INFO - 'TERM': 'linux', 14:04:14 INFO - 'TMOUT': '86400', 14:04:14 INFO - 'USER': 'cltbld', 14:04:14 INFO - 'XDG_SESSION_COOKIE': 'a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681', 14:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:04:14 INFO - '_': '/tools/buildbot/bin/python'} 14:04:14 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/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:04:15 INFO - mozversion application_buildid: 20151231113015 14:04:15 INFO - mozversion application_changeset: 163980e9e4646556c12c3bf7852ba6e266ee4236 14:04:15 INFO - mozversion application_display_name: Nightly 14:04:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:04:15 INFO - mozversion application_name: Firefox 14:04:15 INFO - mozversion application_remotingname: firefox 14:04:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:04:15 INFO - mozversion application_vendor: Mozilla 14:04:15 INFO - mozversion application_version: 46.0a1 14:04:15 INFO - mozversion platform_buildid: 20151231113015 14:04:15 INFO - mozversion platform_changeset: 163980e9e4646556c12c3bf7852ba6e266ee4236 14:04:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:04:15 INFO - mozversion platform_version: 46.0a1 14:04:15 INFO - using testdate: 1451599455 14:04:15 INFO - actual date: 1451599455 14:04:15 INFO - starting webserver on 'localhost:33454' 14:04:15 INFO - SUITE-START | Running 3 tests 14:04:15 INFO - TEST-START | dromaeo_css 14:04:15 INFO - operating with platform_type : linux_ 14:04:15 INFO - Initialising browser for dromaeo_css test... 14:04:15 INFO - TEST-INFO | started process 17050 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphusPwr/profile http://localhost:33454/getInfo.html) 14:04:19 INFO - PROCESS | 17050 | __metrics Screen width/height:1600/1200 14:04:19 INFO - PROCESS | 17050 | colorDepth:24 14:04:19 INFO - PROCESS | 17050 | Browser inner width/height: 1024/697 14:04:19 INFO - PROCESS | 17050 | __metrics 14:04:19 INFO - PROCESS | 17050 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:04:20 INFO - TEST-INFO | 17050: exit 0 14:04:20 INFO - Browser initialized. 14:04:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:04:20 INFO - TEST-INFO | started process 17184 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphusPwr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:04:32 INFO - PROCESS | 17184 | RSS: Main: 150806528 14:04:32 INFO - PROCESS | 17184 | 14:05:22 INFO - PROCESS | 17184 | 1451599522229 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:07:31 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33454/tests/dromaeo/cssquery-ext.html) 14:07:32 INFO - PROCESS | 17184 | RSS: Main: 158003200 14:07:32 INFO - PROCESS | 17184 | 14:10:34 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-ext.html (next: http://localhost:33454/tests/dromaeo/cssquery-jquery.html) 14:10:35 INFO - PROCESS | 17184 | RSS: Main: 153219072 14:10:35 INFO - PROCESS | 17184 | 14:13:37 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33454/tests/dromaeo/cssquery-mootools.html) 14:13:37 INFO - PROCESS | 17184 | RSS: Main: 154251264 14:13:37 INFO - PROCESS | 17184 | 14:16:39 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33454/tests/dromaeo/cssquery-prototype.html) 14:16:39 INFO - PROCESS | 17184 | RSS: Main: 152838144 14:16:39 INFO - PROCESS | 17184 | 14:19:42 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33454/tests/dromaeo/cssquery-yui.html) 14:19:42 INFO - PROCESS | 17184 | RSS: Main: 153890816 14:19:42 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | Cycle 1(1): loaded http://localhost:33454/tests/dromaeo/cssquery-yui.html (next: http://localhost:33454/tests/dromaeo/cssquery-dojo.html) 14:22:45 INFO - PROCESS | 17184 | RSS: Main: 155328512 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | __start_tp_report 14:22:45 INFO - PROCESS | 17184 | _x_x_mozilla_page_load 14:22:45 INFO - PROCESS | 17184 | _x_x_mozilla_page_load_details 14:22:45 INFO - PROCESS | 17184 | |i|pagename|runs| 14:22:45 INFO - PROCESS | 17184 | |0;dojo.html;3167.5407065975432;3242.513622956558;3257.478803391458;3266.542684024237;3278.8360581970896;5298.470152984709;5417.997670430973;5489.176623506481;5498.505134537891;5498.697571633558;5307.336582927134;5375;5448.318960129984;5512.476314750093;5517.420670829565;5018.046571151488;5066.771995260222;5104.438511763703;5112.8977420451565;5117.872053198681;5007.699538027712;5021.6986980781085;5034.748262586874;5072.543471087602;5104.106781313274;4875.537338798382;4896.926546101811;4991.800327986876;4996.1756310208775;5002.624803139779;4898.412190537123;4923.433805112422;4972.950270497321;4976.477469865685;4996.800127994912;4887.413510378742;4913.06651736169;4916.1888288432365;4932.482089380635;4945.975270123662;5101.846944591668;5179.04187725272;5187.066328060948;5245.711485868275;5264.578833693296;5897.262842144732;5914.112883067532;5921.230240068763;5925.585209035369;5930.673812940287;5940.851478713067;5988.31134419543;5993.310769261503;5993.370696076893;6006.699665016732;5325.547328477084;5441.945580544183;5459.754311056012;5518.613697041209;5558.249636299129;5911.615744976649;5913.881722365529;5919.733611987471;5938.198343223609;5939.970300148471;5661.179129026351;5666.546676265889;5670.461306175906;5671.914921276184;5679.829605111853;5692.14617807324;5757.740901659436;5781.653100813965;5848.152017957373;5918.615290006222;5839.182514447981;5863.091220860688;5876.500497457764;5882.617629854046;5900.291964964146;5712.285964254468;5836.824895253149;5860.150278209636;5863.970680146572;5878.5297176225795;4435.157320109169;4466.486354069259;4478.977605112019;4486.461624605003;4514.142312960593;3958.980205099014;3961.3859851723028;3963.4054891766464;3978.5822488638855;4001.6998725095737;5214.869628259248;5352.839414817562;5415.323084614423;5416.647917885325;5429.294191755125;5787.565932554991;5813.128030795415;5833.941660583425;5839.883202335929;5850.707464626837;5355.434497048206;5377.596680248997;5451.618386712971;5489.560835133179;5529.170624406372;5010.123228435083;5033.697978121324;5042.268871013755;5052.520010598987;5090.847274581768;5888.587798854125;5971.910421343683;5973.611715238496;5977.67122808241;5998.4601385875485;5743.798967036134;5782.826515204551;5855.531557475307;5885.911711324419;5910.970445147746;5855.473007429352;5950.642961422329;5966.761329546943;5989.311229208697;6009.06859436788;5651.6043876928225;5762.394948530344;5820.359760426434;5847.298324201123;5849.210356601974;5828;5837.124431335334;5908.940910590839;5918.852028699317;5959.7020148991505;5718.828435146952;5761.164631128547;5781.4507621775865;5792.594518383673;5801.912971305349;5684.77260909559;5692.573057020657;5724.255846739898;5748.48263656273;5776.682282474504;5618.494335509824;5660.603757736919;5673.865226954543;5695.345035320991;5751.1373294006235;5761.884762304814;5775.94224057754;5776;5831.912521312099;5837.066069428871;5425.159100339453;5533.6403133796175;5575.8884822304135;5665.093585026376;5673.262475878109 14:22:45 INFO - PROCESS | 17184 | |1;ext.html;521.8486638874726;553.8255449533399;579.7912751409492;598.4613847537216;608.2609629300399;35969.46045809312;36849.631503684956;37118.62881371189;37163;37242.8137859311;39794.8010259949;40436.59563404365;40629;40666.7966660167;40678.38982415266;8504.829903401927;8675.566221688921;8676.60955257015;8682.392232543725;8694.47833130011;8418.747437576883;8491.363147763912;8581.313494920392;8632.13678632138;8706.172913573231;8603.397762156652;8624.655013799473;8657.047724750273;8727.738167854974;8761.167689069529;8640;8691.391602587853;8718.258947989396;8759.51822649754;8777.605007774666;8565;8611.569421528899;8674.306055515544;8716.25911797498;8730.301575873978;39140.41289380633;39753.40369894454;39980.20039599192;40048.59951400478;40176.598234017576;2659.2258653903505;3031.7119873611973;3042.3154790172257;3128.562001319817;3160.146760374686;26784;26996.460070798475;27324.72675273242;27520;27649.585256220973;3629.310431018098;3821.7515861468914;4055.1484188320487;4061.431399604058;4065.9796701016307;275609;279150;279209;279693;280231;53810.461895381326;60296.39703602996;60965.64688942151;61138.08292875611;61232.38767612356;47779.5222047782;65131.34868651348;65166.674166628865;65765;65784.34215657877;13455.327233638474;13578.25319607431;13598.524051658145;13625.523106691218;13689;9933.453660048623;10059;10085.596576136872;10087.69736907894;10137.442440665687;19443.51391215231;19489.415317540497;19671.803281966997;19679;20213.494662633257;7877.3304269136615;8128.091122545907;8157.959210203911;8205.138460461685;8222.218889205516;876.7063033883593;905.542700936023;909.9727008189765;914.3325372477996;957.7557722780647;25988.740112598633;26029.219123426326;26304.86847565788;26373.604395934075;26425.73574264271;997.1972562087589;1009.1271050541229;1013.4476710192963;1040.661784919904;1088.9945550272198;14044.789328160086;14056.929715351358;14089.2250926198;14103.647408814657;14240.715185696228;407611;416213;418281;418384;418772;53726.462735372144;54358.72820635871;54395.45604543983;54453.45546544484;54512.18231726527;1327.2103098656478;1330.8602596727399;1342.812006319116;1343.0531475309883;1353.8781509664177;26551.867240663672;27412.177634670992;27419.86290068537;27680.446391071662;27847;42064.57935420729;42353.78823105865;42655.57344426516;42762;42874.57125428706;302088;304393;304504;305407;305878;32335.191620209684;42118.57881421147;42180.78909605432;42198.789006056;42552;37862.62137378701;38725.41911871268;39057.21885562216;39088;39610.60389396069;34778.82610587032;36768.81615592012;36994.630053700195;37390.8130459346;38265.23469530538;36708.44937325996;36836;36898;37060.44409333808;37208;37130.07174820651;37575.81212093922;38558.6144138555;38750.418743719434;39068.218635627694;29202.707972919998;30412.695873040986;31289;31306.373872521966;31464.528032079994;23912.521749564563;24719.50560988806;25132.49735005326;25529.106481273808;25608.23175304744 14:22:45 INFO - PROCESS | 17184 | |2;jquery.html;357.51378125748994;363.8399104394068;367.713183716701;371.0482612099963;371.5133175540043;14168.291585420713;15166.620834479143;16553.83446165538;17427.477175684733;18061.548461288476;14183.858161418382;14357.641058973531;14781.482648107318;14930.253487325617;14953.626159346022;5368.785248590052;5369.838904832861;5540.612157149001;5582.358028826676;5585.245991791117;5056.797728090872;5254.632175747699;5260.0268950244135;5263.763130659129;5538.501534861862;5149.201873709562;5179.792808287664;5203.895922081556;5218.556422704075;5516.420775818541;5445.754941027643;5467.835964921059;5472.945270547283;5473.534749546293;5514.0901751211;5179.093658609766;5196.792128314863;5298.655587386807;5304.098303288411;5451.64564303319;19672.90163549173;20017.399478015683;20129.698054529195;21098.472538186514;21125.154993800228;1957.3932081054918;1959.5101224693826;1977.6539105656452;2028.7971202879742;2152.440365504964;9528.047195280486;9605.279604029725;10430.37417754937;11978.70053248667;12546.498140074385;1744.6336269383444;1754.4999675092538;1787.1421717575636;1817.3366721146817;1845.2342277954633;57758.42241577573;60748.39251607472;61916.380836191514;62609;63250.367496325365;10092.444915529717;10347;10351.275410721328;10379.481025948673;10440.843387349196;13390.397432115578;13474.393652285671;13480.25858577768;13599.660008499668;13608.183508989492;7031.1211098612675;7110.07569016035;7130.857382852314;7234.987101805751;7366.7053317866685;6516.934830651633;6518.967405163039;6550.574212676256;6568.770093046721;6595.142631457879;4311.461067366579;4365.388845561624;4385.649148068147;4395.648348132142;4494.685372023992;1781.153951872876;1791.1223500484668;1837.173272027593;1848.593309471914;1879;823.995880020596;839.1985653700701;860.8966923969039;864.9740507784777;965.8309795785709;16150.35398584067;16520.42178523746;16579.088150151856;16704.331826727037;16898.74651880223;810.7365106340463;826.2159310358544;841.7516832534417;932.2681694869494;932.9253659707207;8864.379493435397;9118.726438206731;9316.906830931604;9405.776362763172;9417.576209070608;489674;499801;504257;517979;585289;80066.5996670013;81768.59115704383;82252.58873705713;82935.17064829395;84889.57555212307;1065.041462683591;1067.1196263083143;1067.7117178361955;1105.3699391347016;1126.6000569797604;14093.436262549792;14275.64310892236;14286.714265714836;14520.63698407506;14775.704485910006;31288.687113128577;31488;32082.839585802856;32101.197470063435;32219.838900805345;44854.833792314166;45433;46315.76842115768;47952;49296.75351623362;9342.065793420876;9515.33392662507;9551.235901128031;9627.374220675634;9629.32594718363;14098.50655227062;14303.356348964113;16315.120459195123;16519.09144997037;17405.564860878578;13769.518066868011;13926.30368481592;14053.789193162314;14180.645483862985;14381.92809035948;4630.722156670476;10851;14249.857501424853;14732.705345892808;14909.403623854925;9055.411398259092;9304.16262536375;15061.472848450252;15259.923700381427;15478.613034673774;14604.415823367372;14764.778528322298;15110.54668359951;15171.468998584996;15211.619709507351;15638.45265415705;15943.521694349189;16110.919445402698;16179.271932762818;16303.429379971643 14:22:45 INFO - PROCESS | 17184 | |3;mootools.html;1462.466199837059;1467.8165229346332;1542.403612261309;1705.24969013634;1720.0539703163256;7818.765437036884;7835.686572537099;7865.685372585097;7935.127136015041;7943.285104340608;7898.565578893173;7969.36245100392;8018.118007019223;8018.158093400197;8045;2264.8867556622145;2305;2308.6883270758485;2310.2260742651233;2311.237291693737;2272.397814579138;2302.182725132579;2303.965440518385;2307.688462057626;2313.3985163857433;2177.2053200581754;2201.1965632544166;2240.5182885679574;2294.8737819419925;2298.678185054094;2237.865728056322;2261.6155253606926;2301.7928386445215;2302.574023805593;2316.3166865774638;2299.4596269876565;2316.980528567425;2338.368640467081;2348.6242201247887;2353.1058197884863;7733.188015258429;7760.107587627439;7820.296173344426;7820.491668041559;7837.608119593998;4551.499335073139;4621.075784843045;4629.23617603095;4636.605888499482;4638.327442520849;3019.531972544259;3035.104644129965;3077.692230776927;3092.1651154188244;3094;1010.2978429991159;1010.4897027001391;1907.961840763177;1939.4763413878175;1942.6794578894608;10530;10650.360978341325;10659.78680426395;10681.679549613524;10732.785344293148;4096.344584866407;4125.319322311845;4177.749335039907;4178.456800615901;4216.810243539048;8649.524276164746;8844.778880527909;8864.911350886538;8904.465732056098;8912.153345432303;4464.2633965396;4494.595486406174;4509.255972764523;4515.938754392715;4516.299973504112;4063.4717486726536;4137.834486620502;4142.544320124784;4154.293770059097;4188.183304255702;3473.8089405082965;3544.1316877364693;3546.5921419036627;3549.716022718176;3552.3960926642535;1055.2718624149466;1083.3662307550014;1087.5649740104022;1091.1052936592077;1091.110744743032;942.5805516545072;955.7610597350663;1108.2740804772886;1169.5964892112208;1306.8431788185478;7190.604516751524;7299.0511233540365;7373.446991475661;7374.705011799575;7377.88933166003;614.3978900677362;616.9259688837368;621.6177051113533;623.0654018971543;769.5075151902787;5198.610104242197;5252;5335.466453354634;5349.170878513759;5356.491133342326;9365.15713585767;9589.520523973773;9611.951940240393;9724.17344525709;9745.610175592898;9266.999999999865;9553.665621703207;9595.328327017181;9605.519724013911;9653.758656033515;7389.593572353572;7410.629468526552;7461.776146715607;7485.625718714043;7493.213212612597;6853.828654283683;6867.107276054081;6901.482388820959;6930.203026651798;7100;8400.075991641037;8434.114417986024;8496.362772792188;8584.399092063495;8666;8496.660133594834;8741.082186370593;8747.125287471457;8827.293816494537;8877.422967507091;7033.824154396181;7038.929610704033;7043.788686339213;7111.2533184017;7113.0753002109395;7382.040334756447;7401.5189012714;7432.070991126109;7457.552546847207;7700.152983171734;7039.612821294878;7212.4951253411755;7246.456515761444;7372.852542949218;7516.361109305771;6986.615736134561;7116.715331386894;7128.251533588898;7132.750353737594;7169.247229040876;6987.7204911802955;7027.297270273137;7031.402330801735;7032.402245809163;7033.366996970297;6452.193475815523;6478.1578394808375;6484.221893372825;6493.22081350241;6496.285408604956;6542.051402546699;6723.125993620798;6736.191657001191;6768.187817461936;6771.830704232433 14:22:45 INFO - PROCESS | 17184 | |4;prototype.html;334.50159262698577;342.49482014029303;343.666643355945;347.7044512164659;348.2651605113211;6203.782867599635;6224.439800417961;6342.58773179743;6347.111404403376;6363.331850155736;6102.938970610304;6220.129181914535;6231.968840155804;6267.968660156705;6271.435570798627;4775.403074615681;4822.469528351896;4834.419869615651;4834.4923783002805;4878.219484882419;4871.658983871131;4875.24433712775;4888.780004899771;4890.242012488052;4901.117798796233;4751.809927602892;4788.90422191556;4797.2324428091515;4828.879278018043;4853.126437241295;4813.278008298766;4822.228443449048;4823.758812059383;4842.104210720992;4854.902901941977;4252.298370768819;4260.573942605745;4265.253580623378;4265.786710664454;4265.957340426618;5972.850678733023;6004.879902401927;6013.5489838261865;6056.4851987581105;6058;5482.506574408322;5666.999999999959;5680.517156041741;5697.430256974311;5728.140778883201;6686.465082793414;6689.5986240825705;6695.062691223233;6698.39714425704;6699.933000669979;4749.453812811502;4760.690555113906;4761.333413322138;4765.833195838164;4776.689515181537;6806.217285012238;6972.407345375598;6988.650567471606;7001.159860816683;7016.999999999949;4853.538913803183;4877.439094504107;4880.121578115903;4881.658283920163;4887;4947.505249475095;4948.950510494849;4952.579030782352;4953.653244272867;4958.355413796256;5499.230107784913;5667.206591077253;5672.319321681424;5673.319201695823;5682.7442765075675;6691.130153080166;6707.262201157869;6724.6301453419555;6725.361090696376;6733.192016957996;1677.9832201677827;1694.9152542372833;1698.898066116037;1699.3627389728852;1727.3090763694372;1150.269578817457;1180.8760080191457;1190.7856585814636;1195.0439648281515;1206.6138835572708;6165.722542485599;6182.412670796267;6202.689865506707;6228.875422491525;6259.593126446857;6792.72829086831;6798.76204332846;6803.863922721617;6826.283240259701;6859.485538584626;6045.788397406158;6155.692215389213;6188.8762224755255;6195.659238741822;6238.906416403757;3699.741018128759;3714.9628503714616;3716.554013518395;3726.5900750917376;3740.8129593520216;6997.845355516384;7039.648017599202;7044.154701435758;7053;7061.858762824818;6942.340477654615;6976.093107895941;7038.331358520933;7080.256573059857;7109.715611375487;7083.6458177090935;7097.787066388017;7122.964385178041;7129.2870712929325;7163.42692584592;6939.722411103499;6955.408790252885;6955.408790252885;6955.860882782417;6974.058502102152;6569.737210511526;6815.284395138638;6862.897056544056;6871.690773915086;6892.483063770137;7097.822554435974;7117.75087871922;7140.393066589398;7174;7174.784756457315;4711.481737008858;4719.197736384892;4737.928931066106;4765.356676848581;4776.164171269945;6821.556598821061;6949.409300209337;6965.164180298397;6967.65161741921;7013.263607321362;6828.829279268058;6833.350831670983;6842.3499767524;6852.862942741217;6868.175818901764;6751.257361690112;6814.318568143146;6829.760958366433;6849.657517124024;6861.897071544031;6552.57408268461;6678.899816502853;6686.699098540675;6695.631740254333;6705.2959439258175;6821.522493425413;6822.795316140325;6831.2144103428745;6850.794476165723;6866.862662746817;6605.53761236728;6649.73401063952;6655.600663960178;6667.733290668513;6670.599764014175 14:22:45 INFO - PROCESS | 17184 | |5;yui.html;739.6893304811979;842.4187310755578;853.0701535326493;856.4818284937617;864.628209869756;13701.862981370183;13906.652333691663;13919.582412527616;13919.886409087274;13933.860661393383;12937.805932911015;12989.545365912196;12998.220106793598;13060.542880999166;13168.407421666025;823.4606332851992;826.5495305058757;838.7190291252438;840.1472505407016;840.3529282452508;830.2610676497922;831.5135645647304;835.6949713354643;836.6235194162621;839.8026463781007;864.3776480933718;867.7049803066956;874.0341922176;875.5622188905547;878.2227728460326;852.5907564369076;864.2955990867486;866.5797088412115;867.5922316511229;870.3950754225816;636.3763511758457;636.4812677667686;639.8240483866928;641.9888675336364;644.0307337457144;12779.169353991962;12913.354332283348;12925.224486530838;12940.805887911594;13012.934935325358;11840.526378944833;11970.640880773592;12336.444859981322;12386.81419778704;12457.875421245762;9777.120059194636;9798.118169364792;10115;10169.13562347194;10464.372137671764;3584.8349286482;3633.2370202257557;3661.1030297577;3668.1196512836996;3766.0961369271454;49252.50747492515;49823.75088124572;49934.25098623524;49961.25058124131;49990.50009499895;8690.956545217234;8972.065090084556;9108.407953483002;9390.342676012613;9569.61721531145;17231.56921076958;17294;17372.13139343053;17415.564610884576;17522.29910803579;7413.184549699528;7432.442566807511;7544.8491030180185;7548.131964824115;7700.306972372401;4096.754194748325;4201.831926722958;4235.195312890541;4346.869593912188;4455;3225.3388055448577;3226.9838650807064;3252.5609042779397;3264.8204348761046;3282.2450836307785;558.3272157050744;575.6287194759441;577.8353169346716;579.6608983744557;585.9677717725481;445.3408954746928;453.0079126712489;483.8862867226199;500.6670564074922;544.3060098374604;7780.533168009937;7984.880226796603;7988.720394786154;8072.192780721881;8257.876131858027;452.1183691801001;488.16280079663545;522.7151202594595;554.7586799742126;564.7345747498669;3579.2304654499408;3727.5154229949935;3765.962340376616;3861.942070868939;3926.842926282917;61350.38649613536;61905.38094618996;62007.379926201065;62822;62900.37099628945;49336;51801.48198518042;52345.7382713084;53868.73065634725;54300.72849635727;47975.76012119987;49386;49791.50208497941;50172.498275016784;50199.74900125476;7004.439644828503;7221.386182174574;7253.165885923187;7517.436192285491;7758.340541054074;35296.47055294121;37436.625633743315;37644.62355376411;37988.81005594954;38021.04947376338;41812.3728144072;42727.359089613055;44207;44362;46759.53240467552;9691.12779849817;9731.61073557078;9853.458059806779;9869.506524673594;9954.10413062799;10768.300060496043;10820.350778953289;10986.121110310996;11007.61473348429;11274.718132046437;10309.74225644365;10520.473976301002;10560.683179504627;10852;10973.835392469278;10121.848172277569;10358.637447689294;10544.209184311054;10556.155507559222;10563;10023.097921187129;10065.496725163859;10348.793024139324;10455.68632941013;10683;8583.914160858312;8669.783255418664;8936.642534298555;8973.32700047486;8990.370674052754;8576.44253123545;9010.684626038057;9146.131117543822;9342.019087995934;9457.29070319715 14:22:45 INFO - PROCESS | 17184 | __end_tp_report 14:22:45 INFO - PROCESS | 17184 | __start_cc_report 14:22:45 INFO - PROCESS | 17184 | _x_x_mozilla_cycle_collect,315 14:22:45 INFO - PROCESS | 17184 | __end_cc_report 14:22:45 INFO - PROCESS | 17184 | __startTimestamp1451600565520__endTimestamp 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | ------- Summary: start ------- 14:22:45 INFO - PROCESS | 17184 | Number of tests: 6 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#0] dojo.html Cycles:165 Average:5419.13 Median:5665.09 stddev:606.54 (10.7%) stddev-sans-first:582.11 14:22:45 INFO - PROCESS | 17184 | Values: 3167.5 3242.5 3257.5 3266.5 3278.8 5298.5 5418.0 5489.2 5498.5 5498.7 5307.3 5375.0 5448.3 5512.5 5517.4 5018.0 5066.8 5104.4 5112.9 5117.9 5007.7 5021.7 5034.7 5072.5 5104.1 4875.5 4896.9 4991.8 4996.2 5002.6 4898.4 4923.4 4973.0 4976.5 4996.8 4887.4 4913.1 4916.2 4932.5 4946.0 5101.8 5179.0 5187.1 5245.7 5264.6 5897.3 5914.1 5921.2 5925.6 5930.7 5940.9 5988.3 5993.3 5993.4 6006.7 5325.5 5441.9 5459.8 5518.6 5558.2 5911.6 5913.9 5919.7 5938.2 5940.0 5661.2 5666.5 5670.5 5671.9 5679.8 5692.1 5757.7 5781.7 5848.2 5918.6 5839.2 5863.1 5876.5 5882.6 5900.3 5712.3 5836.8 5860.2 5864.0 5878.5 4435.2 4466.5 4479.0 4486.5 4514.1 3959.0 3961.4 3963.4 3978.6 4001.7 5214.9 5352.8 5415.3 5416.6 5429.3 5787.6 5813.1 5833.9 5839.9 5850.7 5355.4 5377.6 5451.6 5489.6 5529.2 5010.1 5033.7 5042.3 5052.5 5090.8 5888.6 5971.9 5973.6 5977.7 5998.5 5743.8 5782.8 5855.5 5885.9 5911.0 5855.5 5950.6 5966.8 5989.3 6009.1 5651.6 5762.4 5820.4 5847.3 5849.2 5828.0 5837.1 5908.9 5918.9 5959.7 5718.8 5761.2 5781.5 5792.6 5801.9 5684.8 5692.6 5724.3 5748.5 5776.7 5618.5 5660.6 5673.9 5695.3 5751.1 5761.9 5775.9 5776.0 5831.9 5837.1 5425.2 5533.6 5575.9 5665.1 5673.3 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#1] ext.html Cycles:180 Average:49494.61 Median:38737.92 stddev:89125.32 (230.1%) stddev-sans-first:89299.49 14:22:45 INFO - PROCESS | 17184 | Values: 521.8 553.8 579.8 598.5 608.3 35969.5 36849.6 37118.6 37163.0 37242.8 39794.8 40436.6 40629.0 40666.8 40678.4 8504.8 8675.6 8676.6 8682.4 8694.5 8418.7 8491.4 8581.3 8632.1 8706.2 8603.4 8624.7 8657.0 8727.7 8761.2 8640.0 8691.4 8718.3 8759.5 8777.6 8565.0 8611.6 8674.3 8716.3 8730.3 39140.4 39753.4 39980.2 40048.6 40176.6 2659.2 3031.7 3042.3 3128.6 3160.1 26784.0 26996.5 27324.7 27520.0 27649.6 3629.3 3821.8 4055.1 4061.4 4066.0 275609.0 279150.0 279209.0 279693.0 280231.0 53810.5 60296.4 60965.6 61138.1 61232.4 47779.5 65131.3 65166.7 65765.0 65784.3 13455.3 13578.3 13598.5 13625.5 13689.0 9933.5 10059.0 10085.6 10087.7 10137.4 19443.5 19489.4 19671.8 19679.0 20213.5 7877.3 8128.1 8158.0 8205.1 8222.2 876.7 905.5 910.0 914.3 957.8 25988.7 26029.2 26304.9 26373.6 26425.7 997.2 1009.1 1013.4 1040.7 1089.0 14044.8 14056.9 14089.2 14103.6 14240.7 407611.0 416213.0 418281.0 418384.0 418772.0 53726.5 54358.7 54395.5 54453.5 54512.2 1327.2 1330.9 1342.8 1343.1 1353.9 26551.9 27412.2 27419.9 27680.4 27847.0 42064.6 42353.8 42655.6 42762.0 42874.6 302088.0 304393.0 304504.0 305407.0 305878.0 32335.2 42118.6 42180.8 42198.8 42552.0 37862.6 38725.4 39057.2 39088.0 39610.6 34778.8 36768.8 36994.6 37390.8 38265.2 36708.4 36836.0 36898.0 37060.4 37208.0 37130.1 37575.8 38558.6 38750.4 39068.2 29202.7 30412.7 31289.0 31306.4 31464.5 23912.5 24719.5 25132.5 25529.1 25608.2 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#2] jquery.html Cycles:180 Average:28237.90 Median:360.68 stddev:85135.56 (23604.4%) stddev-sans-first:85348.65 14:22:45 INFO - PROCESS | 17184 | Values: 357.5 363.8 367.7 371.0 371.5 14168.3 15166.6 16553.8 17427.5 18061.5 14183.9 14357.6 14781.5 14930.3 14953.6 5368.8 5369.8 5540.6 5582.4 5585.2 5056.8 5254.6 5260.0 5263.8 5538.5 5149.2 5179.8 5203.9 5218.6 5516.4 5445.8 5467.8 5472.9 5473.5 5514.1 5179.1 5196.8 5298.7 5304.1 5451.6 19672.9 20017.4 20129.7 21098.5 21125.2 1957.4 1959.5 1977.7 2028.8 2152.4 9528.0 9605.3 10430.4 11978.7 12546.5 1744.6 1754.5 1787.1 1817.3 1845.2 57758.4 60748.4 61916.4 62609.0 63250.4 10092.4 10347.0 10351.3 10379.5 10440.8 13390.4 13474.4 13480.3 13599.7 13608.2 7031.1 7110.1 7130.9 7235.0 7366.7 6516.9 6519.0 6550.6 6568.8 6595.1 4311.5 4365.4 4385.6 4395.6 4494.7 1781.2 1791.1 1837.2 1848.6 1879.0 824.0 839.2 860.9 865.0 965.8 16150.4 16520.4 16579.1 16704.3 16898.7 810.7 826.2 841.8 932.3 932.9 8864.4 9118.7 9316.9 9405.8 9417.6 489674.0 499801.0 504257.0 517979.0 585289.0 80066.6 81768.6 82252.6 82935.2 84889.6 1065.0 1067.1 1067.7 1105.4 1126.6 14093.4 14275.6 14286.7 14520.6 14775.7 31288.7 31488.0 32082.8 32101.2 32219.8 44854.8 45433.0 46315.8 47952.0 49296.8 9342.1 9515.3 9551.2 9627.4 9629.3 14098.5 14303.4 16315.1 16519.1 17405.6 13769.5 13926.3 14053.8 14180.6 14381.9 4630.7 10851.0 14249.9 14732.7 14909.4 9055.4 9304.2 15061.5 15259.9 15478.6 14604.4 14764.8 15110.5 15171.5 15211.6 15638.5 15943.5 16110.9 16179.3 16303.4 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#3] mootools.html Cycles:180 Average:5475.58 Median:6494.75 stddev:2865.60 (44.1%) stddev-sans-first:2857.77 14:22:45 INFO - PROCESS | 17184 | Values: 1462.5 1467.8 1542.4 1705.2 1720.1 7818.8 7835.7 7865.7 7935.1 7943.3 7898.6 7969.4 8018.1 8018.2 8045.0 2264.9 2305.0 2308.7 2310.2 2311.2 2272.4 2302.2 2304.0 2307.7 2313.4 2177.2 2201.2 2240.5 2294.9 2298.7 2237.9 2261.6 2301.8 2302.6 2316.3 2299.5 2317.0 2338.4 2348.6 2353.1 7733.2 7760.1 7820.3 7820.5 7837.6 4551.5 4621.1 4629.2 4636.6 4638.3 3019.5 3035.1 3077.7 3092.2 3094.0 1010.3 1010.5 1908.0 1939.5 1942.7 10530.0 10650.4 10659.8 10681.7 10732.8 4096.3 4125.3 4177.7 4178.5 4216.8 8649.5 8844.8 8864.9 8904.5 8912.2 4464.3 4494.6 4509.3 4515.9 4516.3 4063.5 4137.8 4142.5 4154.3 4188.2 3473.8 3544.1 3546.6 3549.7 3552.4 1055.3 1083.4 1087.6 1091.1 1091.1 942.6 955.8 1108.3 1169.6 1306.8 7190.6 7299.1 7373.4 7374.7 7377.9 614.4 616.9 621.6 623.1 769.5 5198.6 5252.0 5335.5 5349.2 5356.5 9365.2 9589.5 9612.0 9724.2 9745.6 9267.0 9553.7 9595.3 9605.5 9653.8 7389.6 7410.6 7461.8 7485.6 7493.2 6853.8 6867.1 6901.5 6930.2 7100.0 8400.1 8434.1 8496.4 8584.4 8666.0 8496.7 8741.1 8747.1 8827.3 8877.4 7033.8 7038.9 7043.8 7111.3 7113.1 7382.0 7401.5 7432.1 7457.6 7700.2 7039.6 7212.5 7246.5 7372.9 7516.4 6986.6 7116.7 7128.3 7132.8 7169.2 6987.7 7027.3 7031.4 7032.4 7033.4 6452.2 6478.2 6484.2 6493.2 6496.3 6542.1 6723.1 6736.2 6768.2 6771.8 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#4] prototype.html Cycles:180 Average:5614.57 Median:6226.66 stddev:1676.62 (26.9%) stddev-sans-first:1633.82 14:22:45 INFO - PROCESS | 17184 | Values: 334.5 342.5 343.7 347.7 348.3 6203.8 6224.4 6342.6 6347.1 6363.3 6102.9 6220.1 6232.0 6268.0 6271.4 4775.4 4822.5 4834.4 4834.5 4878.2 4871.7 4875.2 4888.8 4890.2 4901.1 4751.8 4788.9 4797.2 4828.9 4853.1 4813.3 4822.2 4823.8 4842.1 4854.9 4252.3 4260.6 4265.3 4265.8 4266.0 5972.9 6004.9 6013.5 6056.5 6058.0 5482.5 5667.0 5680.5 5697.4 5728.1 6686.5 6689.6 6695.1 6698.4 6699.9 4749.5 4760.7 4761.3 4765.8 4776.7 6806.2 6972.4 6988.7 7001.2 7017.0 4853.5 4877.4 4880.1 4881.7 4887.0 4947.5 4949.0 4952.6 4953.7 4958.4 5499.2 5667.2 5672.3 5673.3 5682.7 6691.1 6707.3 6724.6 6725.4 6733.2 1678.0 1694.9 1698.9 1699.4 1727.3 1150.3 1180.9 1190.8 1195.0 1206.6 6165.7 6182.4 6202.7 6228.9 6259.6 6792.7 6798.8 6803.9 6826.3 6859.5 6045.8 6155.7 6188.9 6195.7 6238.9 3699.7 3715.0 3716.6 3726.6 3740.8 6997.8 7039.6 7044.2 7053.0 7061.9 6942.3 6976.1 7038.3 7080.3 7109.7 7083.6 7097.8 7123.0 7129.3 7163.4 6939.7 6955.4 6955.4 6955.9 6974.1 6569.7 6815.3 6862.9 6871.7 6892.5 7097.8 7117.8 7140.4 7174.0 7174.8 4711.5 4719.2 4737.9 4765.4 4776.2 6821.6 6949.4 6965.2 6967.7 7013.3 6828.8 6833.4 6842.3 6852.9 6868.2 6751.3 6814.3 6829.8 6849.7 6861.9 6552.6 6678.9 6686.7 6695.6 6705.3 6821.5 6822.8 6831.2 6850.8 6866.9 6605.5 6649.7 6655.6 6667.7 6670.6 14:22:45 INFO - PROCESS | 17184 | 14:22:45 INFO - PROCESS | 17184 | [#5] yui.html Cycles:180 Average:13835.89 Median:49975.88 stddev:16783.55 (33.6%) stddev-sans-first:16801.82 14:22:45 INFO - PROCESS | 17184 | Values: 739.7 842.4 853.1 856.5 864.6 13701.9 13906.7 13919.6 13919.9 13933.9 12937.8 12989.5 12998.2 13060.5 13168.4 823.5 826.5 838.7 840.1 840.4 830.3 831.5 835.7 836.6 839.8 864.4 867.7 874.0 875.6 878.2 852.6 864.3 866.6 867.6 870.4 636.4 636.5 639.8 642.0 644.0 12779.2 12913.4 12925.2 12940.8 13012.9 11840.5 11970.6 12336.4 12386.8 12457.9 9777.1 9798.1 10115.0 10169.1 10464.4 3584.8 3633.2 3661.1 3668.1 3766.1 49252.5 49823.8 49934.3 49961.3 49990.5 8691.0 8972.1 9108.4 9390.3 9569.6 17231.6 17294.0 17372.1 17415.6 17522.3 7413.2 7432.4 7544.8 7548.1 7700.3 4096.8 4201.8 4235.2 4346.9 4455.0 3225.3 3227.0 3252.6 3264.8 3282.2 558.3 575.6 577.8 579.7 586.0 445.3 453.0 483.9 500.7 544.3 7780.5 7984.9 7988.7 8072.2 8257.9 452.1 488.2 522.7 554.8 564.7 3579.2 3727.5 3766.0 3861.9 3926.8 61350.4 61905.4 62007.4 62822.0 62900.4 49336.0 51801.5 52345.7 53868.7 54300.7 47975.8 49386.0 49791.5 50172.5 50199.7 7004.4 7221.4 7253.2 7517.4 7758.3 35296.5 37436.6 37644.6 37988.8 38021.0 41812.4 42727.4 44207.0 44362.0 46759.5 9691.1 9731.6 9853.5 9869.5 9954.1 10768.3 10820.4 10986.1 11007.6 11274.7 10309.7 10520.5 10560.7 10852.0 10973.8 10121.8 10358.6 10544.2 10556.2 10563.0 10023.1 10065.5 10348.8 10455.7 10683.0 8583.9 8669.8 8936.6 8973.3 8990.4 8576.4 9010.7 9146.1 9342.0 9457.3 14:22:45 INFO - PROCESS | 17184 | -------- Summary: end -------- 14:22:45 INFO - PROCESS | 17184 | 14:22:46 INFO - TEST-INFO | 17184: exit 0 14:22:46 INFO - TEST-OK | dromaeo_css | took 1111110ms 14:22:46 INFO - TEST-START | kraken 14:22:46 INFO - operating with platform_type : linux_ 14:22:46 INFO - Initialising browser for kraken test... 14:22:46 INFO - TEST-INFO | started process 17433 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2byCtb/profile http://localhost:33454/getInfo.html) 14:22:50 INFO - PROCESS | 17433 | __metrics Screen width/height:1600/1200 14:22:50 INFO - PROCESS | 17433 | colorDepth:24 14:22:50 INFO - PROCESS | 17433 | Browser inner width/height: 1024/697 14:22:50 INFO - PROCESS | 17433 | __metrics 14:22:50 INFO - PROCESS | 17433 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:51 INFO - TEST-INFO | 17433: exit 0 14:22:51 INFO - Browser initialized. 14:22:51 INFO - Running cycle 1/1 for kraken test... 14:22:51 INFO - TEST-INFO | started process 17554 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2byCtb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:03 INFO - PROCESS | 17554 | RSS: Main: 150577152 14:23:03 INFO - PROCESS | 17554 | 14:23:05 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33454/tests/kraken/driver.html?testName=audio-beat-detection) 14:23:06 INFO - PROCESS | 17554 | RSS: Main: 152182784 14:23:06 INFO - PROCESS | 17554 | 14:23:08 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33454/tests/kraken/driver.html?testName=audio-dft) 14:23:09 INFO - PROCESS | 17554 | RSS: Main: 152223744 14:23:09 INFO - PROCESS | 17554 | 14:23:12 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33454/tests/kraken/driver.html?testName=audio-fft) 14:23:13 INFO - PROCESS | 17554 | RSS: Main: 145420288 14:23:13 INFO - PROCESS | 17554 | 14:23:15 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33454/tests/kraken/driver.html?testName=audio-oscillator) 14:23:15 INFO - PROCESS | 17554 | RSS: Main: 146427904 14:23:15 INFO - PROCESS | 17554 | 14:23:18 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33454/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:23:18 INFO - PROCESS | 17554 | RSS: Main: 145932288 14:23:18 INFO - PROCESS | 17554 | 14:23:21 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33454/tests/kraken/driver.html?testName=imaging-darkroom) 14:23:22 INFO - PROCESS | 17554 | RSS: Main: 147841024 14:23:22 INFO - PROCESS | 17554 | 14:23:25 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33454/tests/kraken/driver.html?testName=imaging-desaturate) 14:23:26 INFO - PROCESS | 17554 | RSS: Main: 148463616 14:23:26 INFO - PROCESS | 17554 | 14:23:29 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33454/tests/kraken/driver.html?testName=json-parse-financial) 14:23:29 INFO - PROCESS | 17554 | RSS: Main: 148455424 14:23:29 INFO - PROCESS | 17554 | 14:23:31 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33454/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:23:31 INFO - PROCESS | 17554 | RSS: Main: 148684800 14:23:31 INFO - PROCESS | 17554 | 14:23:33 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:23:34 INFO - PROCESS | 17554 | RSS: Main: 149524480 14:23:34 INFO - PROCESS | 17554 | 14:23:36 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:23:37 INFO - PROCESS | 17554 | RSS: Main: 148865024 14:23:37 INFO - PROCESS | 17554 | 14:23:39 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:23:40 INFO - PROCESS | 17554 | RSS: Main: 148824064 14:23:40 INFO - PROCESS | 17554 | 14:23:42 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:23:43 INFO - PROCESS | 17554 | RSS: Main: 149544960 14:23:43 INFO - PROCESS | 17554 | 14:23:44 INFO - PROCESS | 17554 | Cycle 1(1): loaded http://localhost:33454/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33454/tests/kraken/driver.html?testName=ai-astar) 14:23:45 INFO - PROCESS | 17554 | RSS: Main: 149401600 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | __start_tp_report 14:23:45 INFO - PROCESS | 17554 | _x_x_mozilla_page_load 14:23:45 INFO - PROCESS | 17554 | _x_x_mozilla_page_load_details 14:23:45 INFO - PROCESS | 17554 | |i|pagename|runs| 14:23:45 INFO - PROCESS | 17554 | |0;ai-astar;115;108;111;113;111;123;112;112;113;113 14:23:45 INFO - PROCESS | 17554 | |1;audio-beat-detection;155;127;160;163;127;158;152;126;172;127 14:23:45 INFO - PROCESS | 17554 | |2;audio-dft;162;162;162;165;164;161;164;169;164;164 14:23:45 INFO - PROCESS | 17554 | |3;audio-fft;74;72;74;72;72;73;154;75;75;71 14:23:45 INFO - PROCESS | 17554 | |4;audio-oscillator;95;96;142;95;97;95;138;96;96;141 14:23:45 INFO - PROCESS | 17554 | |5;imaging-gaussian-blur;109;109;110;110;110;109;110;109;109;113 14:23:45 INFO - PROCESS | 17554 | |6;imaging-darkroom;146;147;146;147;146;147;146;149;146;147 14:23:45 INFO - PROCESS | 17554 | |7;imaging-desaturate;96;96;97;97;96;95;97;96;96;96 14:23:45 INFO - PROCESS | 17554 | |8;json-parse-financial;62;61;60;61;60;61;61;63;57;61 14:23:45 INFO - PROCESS | 17554 | |9;json-stringify-tinderbox;69;68;69;68;69;69;68;68;69;68 14:23:45 INFO - PROCESS | 17554 | |10;stanford-crypto-aes;90;89;91;88;88;87;97;88;87;90 14:23:45 INFO - PROCESS | 17554 | |11;stanford-crypto-ccm;118;122;118;125;118;119;126;125;119;119 14:23:45 INFO - PROCESS | 17554 | |12;stanford-crypto-pbkdf2;141;142;153;150;155;149;157;150;151;139 14:23:45 INFO - PROCESS | 17554 | |13;stanford-crypto-sha256-iterative;67;68;68;68;68;66;67;67;67;68 14:23:45 INFO - PROCESS | 17554 | __end_tp_report 14:23:45 INFO - PROCESS | 17554 | __start_cc_report 14:23:45 INFO - PROCESS | 17554 | _x_x_mozilla_cycle_collect,764 14:23:45 INFO - PROCESS | 17554 | __end_cc_report 14:23:45 INFO - PROCESS | 17554 | __startTimestamp1451600625179__endTimestamp 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | ------- Summary: start ------- 14:23:45 INFO - PROCESS | 17554 | Number of tests: 14 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.93 (3.5%) stddev-sans-first:4.11 14:23:45 INFO - PROCESS | 17554 | Values: 115.0 108.0 111.0 113.0 111.0 123.0 112.0 112.0 113.0 113.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:156.50 stddev:17.95 (11.5%) stddev-sans-first:18.79 14:23:45 INFO - PROCESS | 17554 | Values: 155.0 127.0 160.0 163.0 127.0 158.0 152.0 126.0 172.0 127.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.26 (1.4%) stddev-sans-first:2.32 14:23:45 INFO - PROCESS | 17554 | Values: 162.0 162.0 162.0 165.0 164.0 161.0 164.0 169.0 164.0 164.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#3] audio-fft Cycles:10 Average:81.20 Median:73.50 stddev:25.62 (34.9%) stddev-sans-first:27.04 14:23:45 INFO - PROCESS | 17554 | Values: 74.0 72.0 74.0 72.0 72.0 73.0 154.0 75.0 75.0 71.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:21.58 (22.6%) stddev-sans-first:22.28 14:23:45 INFO - PROCESS | 17554 | Values: 95.0 96.0 142.0 95.0 97.0 95.0 138.0 96.0 96.0 141.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:1.23 (1.1%) stddev-sans-first:1.27 14:23:45 INFO - PROCESS | 17554 | Values: 109.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 113.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 14:23:45 INFO - PROCESS | 17554 | Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 149.0 146.0 147.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:23:45 INFO - PROCESS | 17554 | Values: 96.0 96.0 97.0 97.0 96.0 95.0 97.0 96.0 96.0 96.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:61.00 stddev:1.57 (2.6%) stddev-sans-first:1.59 14:23:45 INFO - PROCESS | 17554 | Values: 62.0 61.0 60.0 61.0 60.0 61.0 61.0 63.0 57.0 61.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 14:23:45 INFO - PROCESS | 17554 | Values: 69.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 69.0 68.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:89.50 stddev:2.95 (3.3%) stddev-sans-first:3.13 14:23:45 INFO - PROCESS | 17554 | Values: 90.0 89.0 91.0 88.0 88.0 87.0 97.0 88.0 87.0 90.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:120.50 stddev:3.28 (2.7%) stddev-sans-first:3.31 14:23:45 INFO - PROCESS | 17554 | Values: 118.0 122.0 118.0 125.0 118.0 119.0 126.0 125.0 119.0 119.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:150.50 stddev:6.09 (4.0%) stddev-sans-first:5.79 14:23:45 INFO - PROCESS | 17554 | Values: 141.0 142.0 153.0 150.0 155.0 149.0 157.0 150.0 151.0 139.0 14:23:45 INFO - PROCESS | 17554 | 14:23:45 INFO - PROCESS | 17554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 14:23:45 INFO - PROCESS | 17554 | Values: 67.0 68.0 68.0 68.0 68.0 66.0 67.0 67.0 67.0 68.0 14:23:45 INFO - PROCESS | 17554 | -------- Summary: end -------- 14:23:45 INFO - PROCESS | 17554 | 14:23:46 INFO - TEST-INFO | 17554: exit 0 14:23:46 INFO - TEST-OK | kraken | took 60047ms 14:23:46 INFO - TEST-START | v8_7 14:23:46 INFO - operating with platform_type : linux_ 14:23:46 INFO - Initialising browser for v8_7 test... 14:23:46 INFO - TEST-INFO | started process 17840 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl_wjNb/profile http://localhost:33454/getInfo.html) 14:23:50 INFO - PROCESS | 17840 | __metrics Screen width/height:1600/1200 14:23:50 INFO - PROCESS | 17840 | colorDepth:24 14:23:50 INFO - PROCESS | 17840 | Browser inner width/height: 1024/697 14:23:50 INFO - PROCESS | 17840 | __metrics 14:23:50 INFO - PROCESS | 17840 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:51 INFO - TEST-INFO | 17840: exit 0 14:23:51 INFO - Browser initialized. 14:23:51 INFO - Running cycle 1/1 for v8_7 test... 14:23:51 INFO - TEST-INFO | started process 17960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl_wjNb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:03 INFO - PROCESS | 17960 | RSS: Main: 150773760 14:24:03 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | Cycle 1(1): loaded http://localhost:33454/tests/v8_7/run.html (next: http://localhost:33454/tests/v8_7/run.html) 14:24:24 INFO - PROCESS | 17960 | RSS: Main: 147095552 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | __start_tp_report 14:24:24 INFO - PROCESS | 17960 | _x_x_mozilla_page_load 14:24:24 INFO - PROCESS | 17960 | _x_x_mozilla_page_load_details 14:24:24 INFO - PROCESS | 17960 | |i|pagename|runs| 14:24:24 INFO - PROCESS | 17960 | |0;Richards;168.40687100033682 14:24:24 INFO - PROCESS | 17960 | |1;DeltaBlue;187.75816748028538 14:24:24 INFO - PROCESS | 17960 | |2;Encrypt;279.79854504756577 14:24:24 INFO - PROCESS | 17960 | |3;Decrypt;5180.412371134021 14:24:24 INFO - PROCESS | 17960 | |4;RayTrace;1091.703056768559 14:24:24 INFO - PROCESS | 17960 | |5;Earley;723.589001447178 14:24:24 INFO - PROCESS | 17960 | |6;Boyer;12243.90243902439 14:24:24 INFO - PROCESS | 17960 | |7;RegExp;25150 14:24:24 INFO - PROCESS | 17960 | |8;Splay;629.3266205160478 14:24:24 INFO - PROCESS | 17960 | |9;NavierStokes;4826.923076923077 14:24:24 INFO - PROCESS | 17960 | __end_tp_report 14:24:24 INFO - PROCESS | 17960 | __startTimestamp1451600664868__endTimestamp 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | ------- Summary: start ------- 14:24:24 INFO - PROCESS | 17960 | Number of tests: 10 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#0] Richards Cycles:1 Average:168.41 Median:168.41 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 168.4 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#1] DeltaBlue Cycles:1 Average:187.76 Median:187.76 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 187.8 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 279.8 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 5180.4 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#4] RayTrace Cycles:1 Average:1091.70 Median:1091.70 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 1091.7 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 723.6 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 12243.9 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#7] RegExp Cycles:1 Average:25150.00 Median:25150.00 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 25150.0 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#8] Splay Cycles:1 Average:629.33 Median:629.33 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 629.3 14:24:24 INFO - PROCESS | 17960 | 14:24:24 INFO - PROCESS | 17960 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:24:24 INFO - PROCESS | 17960 | Values: 4826.9 14:24:24 INFO - PROCESS | 17960 | -------- Summary: end -------- 14:24:24 INFO - PROCESS | 17960 | 14:24:25 INFO - TEST-INFO | 17960: exit 0 14:24:25 INFO - TEST-OK | v8_7 | took 39540ms 14:24:25 INFO - SUITE-END | took 1210s 14:24:25 INFO - Completed test suite (00:20:10) 14:24:25 INFO - Working with test: dromaeo_css 14:24:25 INFO - Generating results file: dromaeo_css 14:24:25 INFO - Working with test: kraken 14:24:25 INFO - Generating results file: kraken 14:24:25 INFO - javascript benchmark 14:24:25 INFO - Working with test: v8_7 14:24:25 INFO - Generating results file: v8_7 14:24:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:24:25 INFO - process_Request line: dromaeo_css 7017.19 graph.html#tests=[[72,64,43]] 14:24:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:26 INFO - process_Request line: kraken 1522.20 graph.html#tests=[[232,64,43]] 14:24:26 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:24:26 INFO - process_Request line: v8_7 21207.17 graph.html#tests=[[230,64,43]] 14:24:26 INFO - RETURN: dromaeo_css: 7017.19 14:24:26 INFO - RETURN: kraken: 1522.20 14:24:26 INFO - RETURN: v8_7: 21207.17 14:24:26 INFO - javascript benchmark 14:24:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.5407065975432, 3242.513622956558, 3257.478803391458, 3266.542684024237, 3278.8360581970896, 5298.470152984709, 5417.997670430973, 5489.176623506481, 5498.505134537891, 5498.697571633558, 5307.336582927134, 5375.0, 5448.318960129984, 5512.476314750093, 5517.420670829565, 5018.046571151488, 5066.771995260222, 5104.438511763703, 5112.8977420451565, 5117.872053198681, 5007.699538027712, 5021.6986980781085, 5034.748262586874, 5072.543471087602, 5104.106781313274, 4875.537338798382, 4896.926546101811, 4991.800327986876, 4996.1756310208775, 5002.624803139779, 4898.412190537123, 4923.433805112422, 4972.950270497321, 4976.477469865685, 4996.800127994912, 4887.413510378742, 4913.06651736169, 4916.1888288432365, 4932.482089380635, 4945.975270123662, 5101.846944591668, 5179.04187725272, 5187.066328060948, 5245.711485868275, 5264.578833693296, 5897.262842144732, 5914.112883067532, 5921.230240068763, 5925.585209035369, 5930.673812940287, 5940.851478713067, 5988.31134419543, 5993.310769261503, 5993.370696076893, 6006.699665016732, 5325.547328477084, 5441.945580544183, 5459.754311056012, 5518.613697041209, 5558.249636299129, 5911.615744976649, 5913.881722365529, 5919.733611987471, 5938.198343223609, 5939.970300148471, 5661.179129026351, 5666.546676265889, 5670.461306175906, 5671.914921276184, 5679.829605111853, 5692.14617807324, 5757.740901659436, 5781.653100813965, 5848.152017957373, 5918.615290006222, 5839.182514447981, 5863.091220860688, 5876.500497457764, 5882.617629854046, 5900.291964964146, 5712.285964254468, 5836.824895253149, 5860.150278209636, 5863.970680146572, 5878.5297176225795, 4435.157320109169, 4466.486354069259, 4478.977605112019, 4486.461624605003, 4514.142312960593, 3958.980205099014, 3961.3859851723028, 3963.4054891766464, 3978.5822488638855, 4001.6998725095737, 5214.869628259248, 5352.839414817562, 5415.323084614423, 5416.647917885325, 5429.294191755125, 5787.565932554991, 5813.128030795415, 5833.941660583425, 5839.883202335929, 5850.707464626837, 5355.434497048206, 5377.596680248997, 5451.618386712971, 5489.560835133179, 5529.170624406372, 5010.123228435083, 5033.697978121324, 5042.268871013755, 5052.520010598987, 5090.847274581768, 5888.587798854125, 5971.910421343683, 5973.611715238496, 5977.67122808241, 5998.4601385875485, 5743.798967036134, 5782.826515204551, 5855.531557475307, 5885.911711324419, 5910.970445147746, 5855.473007429352, 5950.642961422329, 5966.761329546943, 5989.311229208697, 6009.06859436788, 5651.6043876928225, 5762.394948530344, 5820.359760426434, 5847.298324201123, 5849.210356601974, 5828.0, 5837.124431335334, 5908.940910590839, 5918.852028699317, 5959.7020148991505, 5718.828435146952, 5761.164631128547, 5781.4507621775865, 5792.594518383673, 5801.912971305349, 5684.77260909559, 5692.573057020657, 5724.255846739898, 5748.48263656273, 5776.682282474504, 5618.494335509824, 5660.603757736919, 5673.865226954543, 5695.345035320991, 5751.1373294006235, 5761.884762304814, 5775.94224057754, 5776.0, 5831.912521312099, 5837.066069428871, 5425.159100339453, 5533.6403133796175, 5575.8884822304135, 5665.093585026376, 5673.262475878109], "unit": "score", "name": "dojo.html", "value": 5379.296108462595}, {"lowerIsBetter": false, "replicates": [521.8486638874726, 553.8255449533399, 579.7912751409492, 598.4613847537216, 608.2609629300399, 35969.46045809312, 36849.631503684956, 37118.62881371189, 37163.0, 37242.8137859311, 39794.8010259949, 40436.59563404365, 40629.0, 40666.7966660167, 40678.38982415266, 8504.829903401927, 8675.566221688921, 8676.60955257015, 8682.392232543725, 8694.47833130011, 8418.747437576883, 8491.363147763912, 8581.313494920392, 8632.13678632138, 8706.172913573231, 8603.397762156652, 8624.655013799473, 8657.047724750273, 8727.738167854974, 8761.167689069529, 8640.0, 8691.391602587853, 8718.258947989396, 8759.51822649754, 8777.605007774666, 8565.0, 8611.569421528899, 8674.306055515544, 8716.25911797498, 8730.301575873978, 39140.41289380633, 39753.40369894454, 39980.20039599192, 40048.59951400478, 40176.598234017576, 2659.2258653903505, 3031.7119873611973, 3042.3154790172257, 3128.562001319817, 3160.146760374686, 26784.0, 26996.460070798475, 27324.72675273242, 27520.0, 27649.585256220973, 3629.310431018098, 3821.7515861468914, 4055.1484188320487, 4061.431399604058, 4065.9796701016307, 275609.0, 279150.0, 279209.0, 279693.0, 280231.0, 53810.461895381326, 60296.39703602996, 60965.64688942151, 61138.08292875611, 61232.38767612356, 47779.5222047782, 65131.34868651348, 65166.674166628865, 65765.0, 65784.34215657877, 13455.327233638474, 13578.25319607431, 13598.524051658145, 13625.523106691218, 13689.0, 9933.453660048623, 10059.0, 10085.596576136872, 10087.69736907894, 10137.442440665687, 19443.51391215231, 19489.415317540497, 19671.803281966997, 19679.0, 20213.494662633257, 7877.3304269136615, 8128.091122545907, 8157.959210203911, 8205.138460461685, 8222.218889205516, 876.7063033883593, 905.542700936023, 909.9727008189765, 914.3325372477996, 957.7557722780647, 25988.740112598633, 26029.219123426326, 26304.86847565788, 26373.604395934075, 26425.73574264271, 997.1972562087589, 1009.1271050541229, 1013.4476710192963, 1040.661784919904, 1088.9945550272198, 14044.789328160086, 14056.929715351358, 14089.2250926198, 14103.647408814657, 14240.715185696228, 407611.0, 416213.0, 418281.0, 418384.0, 418772.0, 53726.462735372144, 54358.72820635871, 54395.45604543983, 54453.45546544484, 54512.18231726527, 1327.2103098656478, 1330.8602596727399, 1342.812006319116, 1343.0531475309883, 1353.8781509664177, 26551.867240663672, 27412.177634670992, 27419.86290068537, 27680.446391071662, 27847.0, 42064.57935420729, 42353.78823105865, 42655.57344426516, 42762.0, 42874.57125428706, 302088.0, 304393.0, 304504.0, 305407.0, 305878.0, 32335.191620209684, 42118.57881421147, 42180.78909605432, 42198.789006056, 42552.0, 37862.62137378701, 38725.41911871268, 39057.21885562216, 39088.0, 39610.60389396069, 34778.82610587032, 36768.81615592012, 36994.630053700195, 37390.8130459346, 38265.23469530538, 36708.44937325996, 36836.0, 36898.0, 37060.44409333808, 37208.0, 37130.07174820651, 37575.81212093922, 38558.6144138555, 38750.418743719434, 39068.218635627694, 29202.707972919998, 30412.695873040986, 31289.0, 31306.373872521966, 31464.528032079994, 23912.521749564563, 24719.50560988806, 25132.49735005326, 25529.106481273808, 25608.23175304744], "unit": "score", "name": "ext.html", "value": 18296.63840002463}, {"lowerIsBetter": false, "replicates": [357.51378125748994, 363.8399104394068, 367.713183716701, 371.0482612099963, 371.5133175540043, 14168.291585420713, 15166.620834479143, 16553.83446165538, 17427.477175684733, 18061.548461288476, 14183.858161418382, 14357.641058973531, 14781.482648107318, 14930.253487325617, 14953.626159346022, 5368.785248590052, 5369.838904832861, 5540.612157149001, 5582.358028826676, 5585.245991791117, 5056.797728090872, 5254.632175747699, 5260.0268950244135, 5263.763130659129, 5538.501534861862, 5149.201873709562, 5179.792808287664, 5203.895922081556, 5218.556422704075, 5516.420775818541, 5445.754941027643, 5467.835964921059, 5472.945270547283, 5473.534749546293, 5514.0901751211, 5179.093658609766, 5196.792128314863, 5298.655587386807, 5304.098303288411, 5451.64564303319, 19672.90163549173, 20017.399478015683, 20129.698054529195, 21098.472538186514, 21125.154993800228, 1957.3932081054918, 1959.5101224693826, 1977.6539105656452, 2028.7971202879742, 2152.440365504964, 9528.047195280486, 9605.279604029725, 10430.37417754937, 11978.70053248667, 12546.498140074385, 1744.6336269383444, 1754.4999675092538, 1787.1421717575636, 1817.3366721146817, 1845.2342277954633, 57758.42241577573, 60748.39251607472, 61916.380836191514, 62609.0, 63250.367496325365, 10092.444915529717, 10347.0, 10351.275410721328, 10379.481025948673, 10440.843387349196, 13390.397432115578, 13474.393652285671, 13480.25858577768, 13599.660008499668, 13608.183508989492, 7031.1211098612675, 7110.07569016035, 7130.857382852314, 7234.987101805751, 7366.7053317866685, 6516.934830651633, 6518.967405163039, 6550.574212676256, 6568.770093046721, 6595.142631457879, 4311.461067366579, 4365.388845561624, 4385.649148068147, 4395.648348132142, 4494.685372023992, 1781.153951872876, 1791.1223500484668, 1837.173272027593, 1848.593309471914, 1879.0, 823.995880020596, 839.1985653700701, 860.8966923969039, 864.9740507784777, 965.8309795785709, 16150.35398584067, 16520.42178523746, 16579.088150151856, 16704.331826727037, 16898.74651880223, 810.7365106340463, 826.2159310358544, 841.7516832534417, 932.2681694869494, 932.9253659707207, 8864.379493435397, 9118.726438206731, 9316.906830931604, 9405.776362763172, 9417.576209070608, 489674.0, 499801.0, 504257.0, 517979.0, 585289.0, 80066.5996670013, 81768.59115704383, 82252.58873705713, 82935.17064829395, 84889.57555212307, 1065.041462683591, 1067.1196263083143, 1067.7117178361955, 1105.3699391347016, 1126.6000569797604, 14093.436262549792, 14275.64310892236, 14286.714265714836, 14520.63698407506, 14775.704485910006, 31288.687113128577, 31488.0, 32082.839585802856, 32101.197470063435, 32219.838900805345, 44854.833792314166, 45433.0, 46315.76842115768, 47952.0, 49296.75351623362, 9342.065793420876, 9515.33392662507, 9551.235901128031, 9627.374220675634, 9629.32594718363, 14098.50655227062, 14303.356348964113, 16315.120459195123, 16519.09144997037, 17405.564860878578, 13769.518066868011, 13926.30368481592, 14053.789193162314, 14180.645483862985, 14381.92809035948, 4630.722156670476, 10851.0, 14249.857501424853, 14732.705345892808, 14909.403623854925, 9055.411398259092, 9304.16262536375, 15061.472848450252, 15259.923700381427, 15478.613034673774, 14604.415823367372, 14764.778528322298, 15110.54668359951, 15171.468998584996, 15211.619709507351, 15638.45265415705, 15943.521694349189, 16110.919445402698, 16179.271932762818, 16303.429379971643], "unit": "score", "name": "jquery.html", "value": 8768.419829149458}, {"lowerIsBetter": false, "replicates": [1462.466199837059, 1467.8165229346332, 1542.403612261309, 1705.24969013634, 1720.0539703163256, 7818.765437036884, 7835.686572537099, 7865.685372585097, 7935.127136015041, 7943.285104340608, 7898.565578893173, 7969.36245100392, 8018.118007019223, 8018.158093400197, 8045.0, 2264.8867556622145, 2305.0, 2308.6883270758485, 2310.2260742651233, 2311.237291693737, 2272.397814579138, 2302.182725132579, 2303.965440518385, 2307.688462057626, 2313.3985163857433, 2177.2053200581754, 2201.1965632544166, 2240.5182885679574, 2294.8737819419925, 2298.678185054094, 2237.865728056322, 2261.6155253606926, 2301.7928386445215, 2302.574023805593, 2316.3166865774638, 2299.4596269876565, 2316.980528567425, 2338.368640467081, 2348.6242201247887, 2353.1058197884863, 7733.188015258429, 7760.107587627439, 7820.296173344426, 7820.491668041559, 7837.608119593998, 4551.499335073139, 4621.075784843045, 4629.23617603095, 4636.605888499482, 4638.327442520849, 3019.531972544259, 3035.104644129965, 3077.692230776927, 3092.1651154188244, 3094.0, 1010.2978429991159, 1010.4897027001391, 1907.961840763177, 1939.4763413878175, 1942.6794578894608, 10530.0, 10650.360978341325, 10659.78680426395, 10681.679549613524, 10732.785344293148, 4096.344584866407, 4125.319322311845, 4177.749335039907, 4178.456800615901, 4216.810243539048, 8649.524276164746, 8844.778880527909, 8864.911350886538, 8904.465732056098, 8912.153345432303, 4464.2633965396, 4494.595486406174, 4509.255972764523, 4515.938754392715, 4516.299973504112, 4063.4717486726536, 4137.834486620502, 4142.544320124784, 4154.293770059097, 4188.183304255702, 3473.8089405082965, 3544.1316877364693, 3546.5921419036627, 3549.716022718176, 3552.3960926642535, 1055.2718624149466, 1083.3662307550014, 1087.5649740104022, 1091.1052936592077, 1091.110744743032, 942.5805516545072, 955.7610597350663, 1108.2740804772886, 1169.5964892112208, 1306.8431788185478, 7190.604516751524, 7299.0511233540365, 7373.446991475661, 7374.705011799575, 7377.88933166003, 614.3978900677362, 616.9259688837368, 621.6177051113533, 623.0654018971543, 769.5075151902787, 5198.610104242197, 5252.0, 5335.466453354634, 5349.170878513759, 5356.491133342326, 9365.15713585767, 9589.520523973773, 9611.951940240393, 9724.17344525709, 9745.610175592898, 9266.999999999865, 9553.665621703207, 9595.328327017181, 9605.519724013911, 9653.758656033515, 7389.593572353572, 7410.629468526552, 7461.776146715607, 7485.625718714043, 7493.213212612597, 6853.828654283683, 6867.107276054081, 6901.482388820959, 6930.203026651798, 7100.0, 8400.075991641037, 8434.114417986024, 8496.362772792188, 8584.399092063495, 8666.0, 8496.660133594834, 8741.082186370593, 8747.125287471457, 8827.293816494537, 8877.422967507091, 7033.824154396181, 7038.929610704033, 7043.788686339213, 7111.2533184017, 7113.0753002109395, 7382.040334756447, 7401.5189012714, 7432.070991126109, 7457.552546847207, 7700.152983171734, 7039.612821294878, 7212.4951253411755, 7246.456515761444, 7372.852542949218, 7516.361109305771, 6986.615736134561, 7116.715331386894, 7128.251533588898, 7132.750353737594, 7169.247229040876, 6987.7204911802955, 7027.297270273137, 7031.402330801735, 7032.402245809163, 7033.366996970297, 6452.193475815523, 6478.1578394808375, 6484.221893372825, 6493.22081350241, 6496.285408604956, 6542.051402546699, 6723.125993620798, 6736.191657001191, 6768.187817461936, 6771.830704232433], "unit": "score", "name": "mootools.html", "value": 4463.6897015402565}, {"lowerIsBetter": false, "replicates": [334.50159262698577, 342.49482014029303, 343.666643355945, 347.7044512164659, 348.2651605113211, 6203.782867599635, 6224.439800417961, 6342.58773179743, 6347.111404403376, 6363.331850155736, 6102.938970610304, 6220.129181914535, 6231.968840155804, 6267.968660156705, 6271.435570798627, 4775.403074615681, 4822.469528351896, 4834.419869615651, 4834.4923783002805, 4878.219484882419, 4871.658983871131, 4875.24433712775, 4888.780004899771, 4890.242012488052, 4901.117798796233, 4751.809927602892, 4788.90422191556, 4797.2324428091515, 4828.879278018043, 4853.126437241295, 4813.278008298766, 4822.228443449048, 4823.758812059383, 4842.104210720992, 4854.902901941977, 4252.298370768819, 4260.573942605745, 4265.253580623378, 4265.786710664454, 4265.957340426618, 5972.850678733023, 6004.879902401927, 6013.5489838261865, 6056.4851987581105, 6058.0, 5482.506574408322, 5666.999999999959, 5680.517156041741, 5697.430256974311, 5728.140778883201, 6686.465082793414, 6689.5986240825705, 6695.062691223233, 6698.39714425704, 6699.933000669979, 4749.453812811502, 4760.690555113906, 4761.333413322138, 4765.833195838164, 4776.689515181537, 6806.217285012238, 6972.407345375598, 6988.650567471606, 7001.159860816683, 7016.999999999949, 4853.538913803183, 4877.439094504107, 4880.121578115903, 4881.658283920163, 4887.0, 4947.505249475095, 4948.950510494849, 4952.579030782352, 4953.653244272867, 4958.355413796256, 5499.230107784913, 5667.206591077253, 5672.319321681424, 5673.319201695823, 5682.7442765075675, 6691.130153080166, 6707.262201157869, 6724.6301453419555, 6725.361090696376, 6733.192016957996, 1677.9832201677827, 1694.9152542372833, 1698.898066116037, 1699.3627389728852, 1727.3090763694372, 1150.269578817457, 1180.8760080191457, 1190.7856585814636, 1195.0439648281515, 1206.6138835572708, 6165.722542485599, 6182.412670796267, 6202.689865506707, 6228.875422491525, 6259.593126446857, 6792.72829086831, 6798.76204332846, 6803.863922721617, 6826.283240259701, 6859.485538584626, 6045.788397406158, 6155.692215389213, 6188.8762224755255, 6195.659238741822, 6238.906416403757, 3699.741018128759, 3714.9628503714616, 3716.554013518395, 3726.5900750917376, 3740.8129593520216, 6997.845355516384, 7039.648017599202, 7044.154701435758, 7053.0, 7061.858762824818, 6942.340477654615, 6976.093107895941, 7038.331358520933, 7080.256573059857, 7109.715611375487, 7083.6458177090935, 7097.787066388017, 7122.964385178041, 7129.2870712929325, 7163.42692584592, 6939.722411103499, 6955.408790252885, 6955.408790252885, 6955.860882782417, 6974.058502102152, 6569.737210511526, 6815.284395138638, 6862.897056544056, 6871.690773915086, 6892.483063770137, 7097.822554435974, 7117.75087871922, 7140.393066589398, 7174.0, 7174.784756457315, 4711.481737008858, 4719.197736384892, 4737.928931066106, 4765.356676848581, 4776.164171269945, 6821.556598821061, 6949.409300209337, 6965.164180298397, 6967.65161741921, 7013.263607321362, 6828.829279268058, 6833.350831670983, 6842.3499767524, 6852.862942741217, 6868.175818901764, 6751.257361690112, 6814.318568143146, 6829.760958366433, 6849.657517124024, 6861.897071544031, 6552.57408268461, 6678.899816502853, 6686.699098540675, 6695.631740254333, 6705.2959439258175, 6821.522493425413, 6822.795316140325, 6831.2144103428745, 6850.794476165723, 6866.862662746817, 6605.53761236728, 6649.73401063952, 6655.600663960178, 6667.733290668513, 6670.599764014175], "unit": "score", "name": "prototype.html", "value": 5067.196875671986}, {"lowerIsBetter": false, "replicates": [739.6893304811979, 842.4187310755578, 853.0701535326493, 856.4818284937617, 864.628209869756, 13701.862981370183, 13906.652333691663, 13919.582412527616, 13919.886409087274, 13933.860661393383, 12937.805932911015, 12989.545365912196, 12998.220106793598, 13060.542880999166, 13168.407421666025, 823.4606332851992, 826.5495305058757, 838.7190291252438, 840.1472505407016, 840.3529282452508, 830.2610676497922, 831.5135645647304, 835.6949713354643, 836.6235194162621, 839.8026463781007, 864.3776480933718, 867.7049803066956, 874.0341922176, 875.5622188905547, 878.2227728460326, 852.5907564369076, 864.2955990867486, 866.5797088412115, 867.5922316511229, 870.3950754225816, 636.3763511758457, 636.4812677667686, 639.8240483866928, 641.9888675336364, 644.0307337457144, 12779.169353991962, 12913.354332283348, 12925.224486530838, 12940.805887911594, 13012.934935325358, 11840.526378944833, 11970.640880773592, 12336.444859981322, 12386.81419778704, 12457.875421245762, 9777.120059194636, 9798.118169364792, 10115.0, 10169.13562347194, 10464.372137671764, 3584.8349286482, 3633.2370202257557, 3661.1030297577, 3668.1196512836996, 3766.0961369271454, 49252.50747492515, 49823.75088124572, 49934.25098623524, 49961.25058124131, 49990.50009499895, 8690.956545217234, 8972.065090084556, 9108.407953483002, 9390.342676012613, 9569.61721531145, 17231.56921076958, 17294.0, 17372.13139343053, 17415.564610884576, 17522.29910803579, 7413.184549699528, 7432.442566807511, 7544.8491030180185, 7548.131964824115, 7700.306972372401, 4096.754194748325, 4201.831926722958, 4235.195312890541, 4346.869593912188, 4455.0, 3225.3388055448577, 3226.9838650807064, 3252.5609042779397, 3264.8204348761046, 3282.2450836307785, 558.3272157050744, 575.6287194759441, 577.8353169346716, 579.6608983744557, 585.9677717725481, 445.3408954746928, 453.0079126712489, 483.8862867226199, 500.6670564074922, 544.3060098374604, 7780.533168009937, 7984.880226796603, 7988.720394786154, 8072.192780721881, 8257.876131858027, 452.1183691801001, 488.16280079663545, 522.7151202594595, 554.7586799742126, 564.7345747498669, 3579.2304654499408, 3727.5154229949935, 3765.962340376616, 3861.942070868939, 3926.842926282917, 61350.38649613536, 61905.38094618996, 62007.379926201065, 62822.0, 62900.37099628945, 49336.0, 51801.48198518042, 52345.7382713084, 53868.73065634725, 54300.72849635727, 47975.76012119987, 49386.0, 49791.50208497941, 50172.498275016784, 50199.74900125476, 7004.439644828503, 7221.386182174574, 7253.165885923187, 7517.436192285491, 7758.340541054074, 35296.47055294121, 37436.625633743315, 37644.62355376411, 37988.81005594954, 38021.04947376338, 41812.3728144072, 42727.359089613055, 44207.0, 44362.0, 46759.53240467552, 9691.12779849817, 9731.61073557078, 9853.458059806779, 9869.506524673594, 9954.10413062799, 10768.300060496043, 10820.350778953289, 10986.121110310996, 11007.61473348429, 11274.718132046437, 10309.74225644365, 10520.473976301002, 10560.683179504627, 10852.0, 10973.835392469278, 10121.848172277569, 10358.637447689294, 10544.209184311054, 10556.155507559222, 10563.0, 10023.097921187129, 10065.496725163859, 10348.793024139324, 10455.68632941013, 10683.0, 8583.914160858312, 8669.783255418664, 8936.642534298555, 8973.32700047486, 8990.370674052754, 8576.44253123545, 9010.684626038057, 9146.131117543822, 9342.019087995934, 9457.29070319715], "unit": "score", "name": "yui.html", "value": 6115.913498204787}], "name": "dromaeo_css", "value": 7017.185821080832}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 111.0, 113.0, 111.0, 123.0, 112.0, 112.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [155.0, 127.0, 160.0, 163.0, 127.0, 158.0, 152.0, 126.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 165.0, 164.0, 161.0, 164.0, 169.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 74.0, 72.0, 72.0, 73.0, 154.0, 75.0, 75.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 95.0, 97.0, 95.0, 138.0, 96.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 113.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 149.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 63.0, 57.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [90.0, 89.0, 91.0, 88.0, 88.0, 87.0, 97.0, 88.0, 87.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.5}, {"lowerIsBetter": true, "replicates": [118.0, 122.0, 118.0, 125.0, 118.0, 119.0, 126.0, 125.0, 119.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.9}, {"lowerIsBetter": true, "replicates": [141.0, 142.0, 153.0, 150.0, 155.0, 149.0, 157.0, 150.0, 151.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 66.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1522.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.40687100033682], "unit": "score", "name": "Richards", "value": 209.62327599999995}, {"lowerIsBetter": false, "replicates": [187.75816748028538], "unit": "score", "name": "DeltaBlue", "value": 352.14446799999996}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1091.703056768559], "unit": "score", "name": "RayTrace", "value": 677.8299240000001}, {"lowerIsBetter": false, "replicates": [723.589001447178], "unit": "score", "name": "Earley", "value": 921.051866}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25150.0], "unit": "score", "name": "RegExp", "value": 36.22206759443341}, {"lowerIsBetter": false, "replicates": [629.3266205160478], "unit": "score", "name": "Splay", "value": 129.48919900000004}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21207.171588356367}]} 14:24:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21207.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1522.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7017.19"}}} 14:24:26 INFO - Return code: 0 14:24:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:24:26 INFO - # TBPL SUCCESS # 14:24:26 INFO - Running post-action listener: _resource_record_post_action 14:24:26 INFO - Running post-run listener: _resource_record_post_run 14:24:27 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 9592832; Write bytes: 556752896; Read time: 2472; Write time: 655956 14:24:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235397120; Read time: 0; Write time: 366324 14:24:27 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 7856128; Write bytes: 321351680; Read time: 2396; Write time: 289632 14:24:27 INFO - Running post-run listener: _upload_blobber_files 14:24:27 INFO - Blob upload gear active. 14:24:27 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:24:27 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 14:24:27 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'] 14:24:27 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 14:24:27 INFO - (blobuploader) - INFO - Open directory for files ... 14:24:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:24:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:24:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:28 INFO - (blobuploader) - INFO - Done attempting. 14:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:24:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:24:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:24:29 INFO - (blobuploader) - INFO - Done attempting. 14:24:29 INFO - (blobuploader) - INFO - Iteration through files over. 14:24:29 INFO - Return code: 0 14:24:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:24:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:24:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b6bc0ab620c7d2f5abd3c37dc9f554cdf8c34ad44adcca0d8f5a21f8223d2dae32b935dc62970aa9a0e9e27779b6cb59263aa3705fa9de243555678fee593c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01e7ee05a8873fee353be18a546fd90a4e71e836f3dcd3eb1435aaf46a73eda23cb592b353460e71f26947bed796aec92bf2725d1ee8bc7650da2ae393ec2a5"} 14:24:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:24:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:24:29 INFO - Contents: 14:24:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b6bc0ab620c7d2f5abd3c37dc9f554cdf8c34ad44adcca0d8f5a21f8223d2dae32b935dc62970aa9a0e9e27779b6cb59263aa3705fa9de243555678fee593c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01e7ee05a8873fee353be18a546fd90a4e71e836f3dcd3eb1435aaf46a73eda23cb592b353460e71f26947bed796aec92bf2725d1ee8bc7650da2ae393ec2a5"} 14:24:29 INFO - Copying logs to upload dir... 14:24:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.481221 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-31 14:24:29.263807) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:29.266841) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 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/4b6bc0ab620c7d2f5abd3c37dc9f554cdf8c34ad44adcca0d8f5a21f8223d2dae32b935dc62970aa9a0e9e27779b6cb59263aa3705fa9de243555678fee593c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01e7ee05a8873fee353be18a546fd90a4e71e836f3dcd3eb1435aaf46a73eda23cb592b353460e71f26947bed796aec92bf2725d1ee8bc7650da2ae393ec2a5"} build_url:https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/QTRcrkpjQO2wNtnonOtWjw/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/4b6bc0ab620c7d2f5abd3c37dc9f554cdf8c34ad44adcca0d8f5a21f8223d2dae32b935dc62970aa9a0e9e27779b6cb59263aa3705fa9de243555678fee593c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d01e7ee05a8873fee353be18a546fd90a4e71e836f3dcd3eb1435aaf46a73eda23cb592b353460e71f26947bed796aec92bf2725d1ee8bc7650da2ae393ec2a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:29.291204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:29.291507) ========= 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=a732b360c9c0c9a4a8cfc42c000001d9-1451592512.681009-1683843681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 14:24:29.373371) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 14:24:29.373751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 14:24:29.374066) ========= ========= Total master_lag: 0.19 =========