builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1452880873.38 results: success (0) buildid: 20160115073123 builduid: 57cfa3be1f394d90be356b87c613d90d revision: 02398f2be72b9bbf5ee79348b73ef122c915aae0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.381762) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.382185) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.382475) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.409292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.409892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.453887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.454148) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.502955) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.503229) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.503577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.503872) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 10:01: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.4M=0s 2016-01-15 10:01:13 (33.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.685884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.686151) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019547 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:13.735261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 10:01:13.735609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 02398f2be72b9bbf5ee79348b73ef122c915aae0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 02398f2be72b9bbf5ee79348b73ef122c915aae0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 10:01:13,852 truncating revision to first 12 chars 2016-01-15 10:01:13,852 Setting DEBUG logging. 2016-01-15 10:01:13,852 attempt 1/10 2016-01-15 10:01:13,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/02398f2be72b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 10:01:15,050 unpacking tar archive at: mozilla-central-02398f2be72b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.541806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 10:01:15.290361) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.290677) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003825 script_repo_revision: '%(revision)s' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.339104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.339391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.349350) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.349610) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 10:01:15.349980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-15 10:01:15.350252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:01:15 INFO - MultiFileLogger online at 20160115 10:01:15 in /builds/slave/test-pgo 10:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:01:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:01:15 INFO - {'append_to_log': False, 10:01:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:01:15 INFO - 'blob_upload_branch': 'Firefox', 10:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:01:15 INFO - 'branch': 'Firefox', 10:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:01:15 INFO - 'config_files': ('talos/linux_config.py',), 10:01:15 INFO - 'default_actions': ('clobber', 10:01:15 INFO - 'read-buildbot-config', 10:01:15 INFO - 'download-and-extract', 10:01:15 INFO - 'populate-webroot', 10:01:15 INFO - 'create-virtualenv', 10:01:15 INFO - 'install', 10:01:15 INFO - 'run-tests'), 10:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:01:15 INFO - 'download_minidump_stackwalk': True, 10:01:15 INFO - 'download_symbols': 'ondemand', 10:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:01:15 INFO - 'installer_path': 'installer.exe', 10:01:15 INFO - 'log_level': 'info', 10:01:15 INFO - 'log_name': 'talos', 10:01:15 INFO - 'log_to_console': True, 10:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:01:15 INFO - 'opt_config_files': (), 10:01:15 INFO - 'pip_index': False, 10:01:15 INFO - 'sps_profile': False, 10:01:15 INFO - 'sps_profile_interval': 0, 10:01:15 INFO - 'suite': 'dromaeojs-e10s', 10:01:15 INFO - 'system_bits': '32', 10:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:01:15 INFO - 'title': 'talos-linux64-ix-044', 10:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:01:15 INFO - 'use_talos_json': True, 10:01:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:01:15 INFO - 'work_dir': 'build'} 10:01:15 INFO - ##### 10:01:15 INFO - ##### Running clobber step. 10:01:15 INFO - ##### 10:01:15 INFO - Running pre-action listener: _resource_record_pre_action 10:01:15 INFO - Running main action method: clobber 10:01:15 INFO - rmtree: /builds/slave/test-pgo/build 10:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:01:15 INFO - Running post-action listener: _resource_record_post_action 10:01:15 INFO - ##### 10:01:15 INFO - ##### Running read-buildbot-config step. 10:01:15 INFO - ##### 10:01:15 INFO - Running pre-action listener: _resource_record_pre_action 10:01:15 INFO - Running main action method: read_buildbot_config 10:01:15 INFO - Using buildbot properties: 10:01:15 INFO - { 10:01:15 INFO - "project": "", 10:01:15 INFO - "product": "firefox", 10:01:15 INFO - "script_repo_revision": "production", 10:01:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:01:15 INFO - "repository": "", 10:01:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:01:15 INFO - "buildid": "20160115073123", 10:01:15 INFO - "pgo_build": "True", 10:01:15 INFO - "basedir": "/builds/slave/test-pgo", 10:01:15 INFO - "buildnumber": 302, 10:01:15 INFO - "slavename": "talos-linux64-ix-044", 10:01:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:01:16 INFO - "platform": "ubuntu64_hw", 10:01:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:01:16 INFO - "branch": "mozilla-central", 10:01:16 INFO - "repo_path": "mozilla-central", 10:01:16 INFO - "revision": "02398f2be72b9bbf5ee79348b73ef122c915aae0", 10:01:16 INFO - "stage_platform": "linux64-pgo", 10:01:16 INFO - "builduid": "57cfa3be1f394d90be356b87c613d90d", 10:01:16 INFO - "slavebuilddir": "test" 10:01:16 INFO - } 10:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:01:16 INFO - Running post-action listener: _resource_record_post_action 10:01:16 INFO - ##### 10:01:16 INFO - ##### Running download-and-extract step. 10:01:16 INFO - ##### 10:01:16 INFO - Running pre-action listener: _resource_record_pre_action 10:01:16 INFO - Running main action method: download_and_extract 10:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:01: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')]} 10:01:16 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json 10:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json 10:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:01:20 INFO - Downloaded 1448 bytes. 10:01:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:01:20 INFO - Using the following test package requirements: 10:01:20 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:20 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:01:20 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:01:20 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'jsshell-linux-x86_64.zip'], 10:01:20 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:01:20 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:20 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:01:20 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:01:20 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:01:20 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:01:20 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:01:20 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:01:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:01:20 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')]} 10:01:20 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:23 INFO - Downloaded 22440718 bytes. 10:01:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:24 INFO - Return code: 0 10:01:24 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 10:01: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')]} 10:01:24 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:01:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:01:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:32 INFO - Downloaded 22440718 bytes. 10:01:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:33 INFO - Return code: 0 10:01:33 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')]} 10:01:33 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:35 INFO - Downloaded 11132144 bytes. 10:01:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:01:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:01:35 INFO - Return code: 0 10:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:35 INFO - https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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 10:01:38 INFO - Downloaded 55929998 bytes. 10:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:38 INFO - mkdir: /builds/slave/test-pgo/properties 10:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:01:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:01:38 INFO - Contents: 10:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:01:38 INFO - Running post-action listener: _resource_record_post_action 10:01:38 INFO - Running post-action listener: set_extra_try_arguments 10:01:38 INFO - ##### 10:01:38 INFO - ##### Running populate-webroot step. 10:01:38 INFO - ##### 10:01:38 INFO - Running pre-action listener: _resource_record_pre_action 10:01:38 INFO - Running main action method: populate_webroot 10:01:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:01:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:01:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:01:38 INFO - '--tppagecycles', 10:01:38 INFO - '7'], 10:01:38 INFO - 'tests': ['tsvgm']}}, 10:01:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:01:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:01:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:01:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:01:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['damp', 'tps']}, 10:01:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['damp', 'tps']}, 10:01:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:01:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:01:38 INFO - 'other': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'other_l64': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'other_nol64': {'tests': ['a11yr', 10:01:38 INFO - 'ts_paint', 10:01:38 INFO - 'tpaint', 10:01:38 INFO - 'sessionrestore', 10:01:38 INFO - 'sessionrestore_no_auto_restore']}, 10:01:38 INFO - 'svgr': {'tests': ['tsvgx', 10:01:38 INFO - 'tsvgr_opacity', 10:01:38 INFO - 'tart', 10:01:38 INFO - 'tscrollx', 10:01:38 INFO - 'cart']}, 10:01:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['tsvgx', 10:01:38 INFO - 'tsvgr_opacity', 10:01:38 INFO - 'tart', 10:01:38 INFO - 'tscrollx', 10:01:38 INFO - 'cart']}, 10:01:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'tests': ['tp5o']}, 10:01:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--e10s'], 10:01:38 INFO - 'tests': ['tp5o']}, 10:01:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--xperf_path', 10:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:38 INFO - 'tests': ['tp5n']}, 10:01:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:01:38 INFO - 'talos_options': ['--e10s', 10:01:38 INFO - '--xperf_path', 10:01:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:01:38 INFO - 'tests': ['tp5n']}}, 10:01:38 INFO - 'talos.zip': {'path': '', 10:01:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:01:38 INFO - Running post-action listener: _resource_record_post_action 10:01:38 INFO - ##### 10:01:38 INFO - ##### Running create-virtualenv step. 10:01:38 INFO - ##### 10:01:38 INFO - Running pre-action listener: _resource_record_pre_action 10:01:38 INFO - Running main action method: create_virtualenv 10:01:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:01:38 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 10:01:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:01:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:01:38 INFO - Using real prefix '/usr' 10:01:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:01:39 INFO - Installing distribute.............................................................................................................................................................................................done. 10:01:41 INFO - Installing pip.................done. 10:01:41 INFO - Return code: 0 10:01:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:41 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 10:01:41 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 10:01:41 INFO - Using env: {'DISPLAY': ':0', 10:01:41 INFO - 'HOME': '/home/cltbld', 10:01:41 INFO - 'LANG': 'en_US.UTF-8', 10:01:41 INFO - 'LANGUAGE': 'en_US:en', 10:01:41 INFO - 'LOGNAME': 'cltbld', 10:01:41 INFO - 'MAIL': '/var/mail/cltbld', 10:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:41 INFO - 'MOZ_NO_REMOTE': '1', 10:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:41 INFO - 'NO_EM_RESTART': '1', 10:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:41 INFO - 'SHELL': '/bin/bash', 10:01:41 INFO - 'SHLVL': '1', 10:01:41 INFO - 'TERM': 'linux', 10:01:41 INFO - 'TMOUT': '86400', 10:01:41 INFO - 'USER': 'cltbld', 10:01:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:41 INFO - '_': '/tools/buildbot/bin/python'} 10:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:41 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 10:01:41 INFO - Cleaning up... 10:01:41 INFO - Return code: 0 10:01:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:41 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:41 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 10:01:41 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 10:01:41 INFO - Using env: {'DISPLAY': ':0', 10:01:41 INFO - 'HOME': '/home/cltbld', 10:01:41 INFO - 'LANG': 'en_US.UTF-8', 10:01:41 INFO - 'LANGUAGE': 'en_US:en', 10:01:41 INFO - 'LOGNAME': 'cltbld', 10:01:41 INFO - 'MAIL': '/var/mail/cltbld', 10:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:41 INFO - 'MOZ_NO_REMOTE': '1', 10:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:41 INFO - 'NO_EM_RESTART': '1', 10:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:41 INFO - 'SHELL': '/bin/bash', 10:01:41 INFO - 'SHLVL': '1', 10:01:41 INFO - 'TERM': 'linux', 10:01:41 INFO - 'TMOUT': '86400', 10:01:41 INFO - 'USER': 'cltbld', 10:01:41 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:41 INFO - '_': '/tools/buildbot/bin/python'} 10:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:41 INFO - Downloading/unpacking psutil>=0.7.1 10:01:41 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 10:01:41 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 10:01:41 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 10:01:41 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 10:01:41 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 10:01:41 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 10:01:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:43 INFO - Installing collected packages: psutil 10:01:43 INFO - Running setup.py install for psutil 10:01:43 INFO - building 'psutil._psutil_linux' extension 10:01:43 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 10:01:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:01:43 INFO - building 'psutil._psutil_posix' extension 10:01:43 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 10:01:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:01:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:01:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:01:44 INFO - Successfully installed psutil 10:01:44 INFO - Cleaning up... 10:01:44 INFO - Return code: 0 10:01:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:01:44 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')]} 10:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 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')]} 10:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:44 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:44 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 10:01:44 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 10:01:44 INFO - Using env: {'DISPLAY': ':0', 10:01:44 INFO - 'HOME': '/home/cltbld', 10:01:44 INFO - 'LANG': 'en_US.UTF-8', 10:01:44 INFO - 'LANGUAGE': 'en_US:en', 10:01:44 INFO - 'LOGNAME': 'cltbld', 10:01:44 INFO - 'MAIL': '/var/mail/cltbld', 10:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:44 INFO - 'MOZ_NO_REMOTE': '1', 10:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:44 INFO - 'NO_EM_RESTART': '1', 10:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:44 INFO - 'SHELL': '/bin/bash', 10:01:44 INFO - 'SHLVL': '1', 10:01:44 INFO - 'TERM': 'linux', 10:01:44 INFO - 'TMOUT': '86400', 10:01:44 INFO - 'USER': 'cltbld', 10:01:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:44 INFO - '_': '/tools/buildbot/bin/python'} 10:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:01:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:01:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:01:46 INFO - Installing collected packages: mozsystemmonitor 10:01:46 INFO - Running setup.py install for mozsystemmonitor 10:01:46 INFO - Successfully installed mozsystemmonitor 10:01:46 INFO - Cleaning up... 10:01:46 INFO - Return code: 0 10:01:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:01:46 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')]} 10:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:46 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')]} 10:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:46 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:46 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 10:01:46 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 10:01:46 INFO - Using env: {'DISPLAY': ':0', 10:01:46 INFO - 'HOME': '/home/cltbld', 10:01:46 INFO - 'LANG': 'en_US.UTF-8', 10:01:46 INFO - 'LANGUAGE': 'en_US:en', 10:01:46 INFO - 'LOGNAME': 'cltbld', 10:01:46 INFO - 'MAIL': '/var/mail/cltbld', 10:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:46 INFO - 'MOZ_NO_REMOTE': '1', 10:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:46 INFO - 'NO_EM_RESTART': '1', 10:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:46 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:46 INFO - 'SHELL': '/bin/bash', 10:01:46 INFO - 'SHLVL': '1', 10:01:46 INFO - 'TERM': 'linux', 10:01:46 INFO - 'TMOUT': '86400', 10:01:46 INFO - 'USER': 'cltbld', 10:01:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:46 INFO - '_': '/tools/buildbot/bin/python'} 10:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:01:46 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 10:01:46 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 10:01:46 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 10:01:46 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 10:01:46 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 10:01:46 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 10:01:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:01:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:01:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:48 INFO - Downloading docopt-0.6.1.tar.gz 10:01:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:01:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:01:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:01:48 INFO - Running setup.py install for blobuploader 10:01:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:01:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:01:48 INFO - Running setup.py install for requests 10:01:49 INFO - Running setup.py install for docopt 10:01:49 INFO - Successfully installed blobuploader requests docopt 10:01:49 INFO - Cleaning up... 10:01:49 INFO - Return code: 0 10:01:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:49 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:49 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 10:01:49 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 10:01:49 INFO - Using env: {'DISPLAY': ':0', 10:01:49 INFO - 'HOME': '/home/cltbld', 10:01:49 INFO - 'LANG': 'en_US.UTF-8', 10:01:49 INFO - 'LANGUAGE': 'en_US:en', 10:01:49 INFO - 'LOGNAME': 'cltbld', 10:01:49 INFO - 'MAIL': '/var/mail/cltbld', 10:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:49 INFO - 'MOZ_NO_REMOTE': '1', 10:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:49 INFO - 'NO_EM_RESTART': '1', 10:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:49 INFO - 'SHELL': '/bin/bash', 10:01:49 INFO - 'SHLVL': '1', 10:01:49 INFO - 'TERM': 'linux', 10:01:49 INFO - 'TMOUT': '86400', 10:01:49 INFO - 'USER': 'cltbld', 10:01:49 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:49 INFO - '_': '/tools/buildbot/bin/python'} 10:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:49 INFO - Running setup.py (path:/tmp/pip-OuUV8E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:49 INFO - Running setup.py (path:/tmp/pip-NCiL9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:49 INFO - Running setup.py (path:/tmp/pip-zjNUwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:49 INFO - Running setup.py (path:/tmp/pip-4EV1ay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:49 INFO - Running setup.py (path:/tmp/pip-4jIu_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:49 INFO - Running setup.py (path:/tmp/pip-TWfjtK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:50 INFO - Running setup.py (path:/tmp/pip-UG5ZgW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:50 INFO - Running setup.py (path:/tmp/pip-bAEjEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:50 INFO - Running setup.py (path:/tmp/pip-3DZfwn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:50 INFO - Running setup.py (path:/tmp/pip-QbgQKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:50 INFO - Running setup.py (path:/tmp/pip-liIgIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:50 INFO - Running setup.py (path:/tmp/pip-vDzuph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:50 INFO - Running setup.py (path:/tmp/pip-6qOeGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:50 INFO - Running setup.py (path:/tmp/pip-1lJjJd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:50 INFO - Running setup.py (path:/tmp/pip-yEm8Ku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:50 INFO - Running setup.py (path:/tmp/pip-xhstdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:50 INFO - Running setup.py (path:/tmp/pip-ahtF0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:01:50 INFO - Running setup.py install for manifestparser 10:01:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:01:50 INFO - Running setup.py install for mozcrash 10:01:51 INFO - Running setup.py install for mozdebug 10:01:51 INFO - Running setup.py install for mozdevice 10:01:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for mozfile 10:01:51 INFO - Running setup.py install for mozhttpd 10:01:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for mozinfo 10:01:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for mozInstall 10:01:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for mozleak 10:01:51 INFO - Running setup.py install for mozlog 10:01:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for moznetwork 10:01:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:01:51 INFO - Running setup.py install for mozprocess 10:01:52 INFO - Running setup.py install for mozprofile 10:01:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:01:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:01:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:01:52 INFO - Running setup.py install for mozrunner 10:01:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:01:52 INFO - Running setup.py install for mozscreenshot 10:01:52 INFO - Running setup.py install for moztest 10:01:52 INFO - Running setup.py install for mozversion 10:01:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:01:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:01:52 INFO - Cleaning up... 10:01:52 INFO - Return code: 0 10:01:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01: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')]} 10:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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')]} 10:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01: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/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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01: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/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 10:01: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/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 10:01:52 INFO - Using env: {'DISPLAY': ':0', 10:01:52 INFO - 'HOME': '/home/cltbld', 10:01:52 INFO - 'LANG': 'en_US.UTF-8', 10:01:52 INFO - 'LANGUAGE': 'en_US:en', 10:01:52 INFO - 'LOGNAME': 'cltbld', 10:01:52 INFO - 'MAIL': '/var/mail/cltbld', 10:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:52 INFO - 'MOZ_NO_REMOTE': '1', 10:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:52 INFO - 'NO_EM_RESTART': '1', 10:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:52 INFO - 'SHELL': '/bin/bash', 10:01:52 INFO - 'SHLVL': '1', 10:01:52 INFO - 'TERM': 'linux', 10:01:52 INFO - 'TMOUT': '86400', 10:01:52 INFO - 'USER': 'cltbld', 10:01:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:52 INFO - '_': '/tools/buildbot/bin/python'} 10:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:52 INFO - Running setup.py (path:/tmp/pip-fR6SO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:01:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:52 INFO - Running setup.py (path:/tmp/pip-j57OOc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:53 INFO - Running setup.py (path:/tmp/pip-Oa7b_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:53 INFO - Running setup.py (path:/tmp/pip-mAWR3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:53 INFO - Running setup.py (path:/tmp/pip-Yexo3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:53 INFO - Running setup.py (path:/tmp/pip-Q5Bbn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:53 INFO - Running setup.py (path:/tmp/pip-YvFwKm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:53 INFO - Running setup.py (path:/tmp/pip-riXFsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:53 INFO - Running setup.py (path:/tmp/pip-tYuukH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:53 INFO - Running setup.py (path:/tmp/pip-lXGdQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:53 INFO - Running setup.py (path:/tmp/pip-S024Nq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:01:53 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)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:53 INFO - Running setup.py (path:/tmp/pip-xzRGbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:53 INFO - Running setup.py (path:/tmp/pip-5IaCx1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:53 INFO - Running setup.py (path:/tmp/pip-KlvCtn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:53 INFO - Running setup.py (path:/tmp/pip-1U4C0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:01:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:53 INFO - Running setup.py (path:/tmp/pip-mdP_7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:01:54 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)) 10:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:54 INFO - Running setup.py (path:/tmp/pip-xOgHtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:01:54 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)) 10:01:54 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)) 10:01:54 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)) 10:01:54 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)) 10:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:01:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:55 INFO - Downloading blessings-1.5.1.tar.gz 10:01:55 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 10:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:01:55 INFO - Installing collected packages: blessings 10:01:55 INFO - Running setup.py install for blessings 10:01:55 INFO - Successfully installed blessings 10:01:55 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:01:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:01:56 INFO - Reading from file tmpfile_stdout 10:01:56 INFO - Current package versions: 10:01:56 INFO - argparse == 1.2.1 10:01:56 INFO - blessings == 1.5.1 10:01:56 INFO - blobuploader == 1.2.4 10:01:56 INFO - docopt == 0.6.1 10:01:56 INFO - manifestparser == 1.1 10:01:56 INFO - mozInstall == 1.12 10:01:56 INFO - mozcrash == 0.16 10:01:56 INFO - mozdebug == 0.1 10:01:56 INFO - mozdevice == 0.48 10:01:56 INFO - mozfile == 1.2 10:01:56 INFO - mozhttpd == 0.7 10:01:56 INFO - mozinfo == 0.9 10:01:56 INFO - mozleak == 0.1 10:01:56 INFO - mozlog == 3.1 10:01:56 INFO - moznetwork == 0.27 10:01:56 INFO - mozprocess == 0.22 10:01:56 INFO - mozprofile == 0.28 10:01:56 INFO - mozrunner == 6.11 10:01:56 INFO - mozscreenshot == 0.1 10:01:56 INFO - mozsystemmonitor == 0.0 10:01:56 INFO - moztest == 0.7 10:01:56 INFO - mozversion == 1.4 10:01:56 INFO - psutil == 3.1.1 10:01:56 INFO - requests == 1.2.3 10:01:56 INFO - wsgiref == 0.1.2 10:01:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:01:56 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')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:56 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 10:01:56 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 10:01:56 INFO - Using env: {'DISPLAY': ':0', 10:01:56 INFO - 'HOME': '/home/cltbld', 10:01:56 INFO - 'LANG': 'en_US.UTF-8', 10:01:56 INFO - 'LANGUAGE': 'en_US:en', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MAIL': '/var/mail/cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SHLVL': '1', 10:01:56 INFO - 'TERM': 'linux', 10:01:56 INFO - 'TMOUT': '86400', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - '_': '/tools/buildbot/bin/python'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 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)) 10:01:56 INFO - Cleaning up... 10:01:56 INFO - Return code: 0 10:01:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:01:56 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')]} 10:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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')]} 10:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:56 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:56 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 10:01:56 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 10:01:56 INFO - Using env: {'DISPLAY': ':0', 10:01:56 INFO - 'HOME': '/home/cltbld', 10:01:56 INFO - 'LANG': 'en_US.UTF-8', 10:01:56 INFO - 'LANGUAGE': 'en_US:en', 10:01:56 INFO - 'LOGNAME': 'cltbld', 10:01:56 INFO - 'MAIL': '/var/mail/cltbld', 10:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:56 INFO - 'MOZ_NO_REMOTE': '1', 10:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:56 INFO - 'NO_EM_RESTART': '1', 10:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:56 INFO - 'SHELL': '/bin/bash', 10:01:56 INFO - 'SHLVL': '1', 10:01:56 INFO - 'TERM': 'linux', 10:01:56 INFO - 'TMOUT': '86400', 10:01:56 INFO - 'USER': 'cltbld', 10:01:56 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:56 INFO - '_': '/tools/buildbot/bin/python'} 10:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:56 INFO - Downloading/unpacking jsonschema 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01: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 10:01:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:01:58 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 10:01:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:01:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:01:58 INFO - warning: no files found matching '*.txt' 10:01:58 INFO - no previously-included directories found matching 'build' 10:01:58 INFO - no previously-included directories found matching 'dist' 10:01:58 INFO - no previously-included directories found matching '.git*' 10:01:58 INFO - Installing collected packages: jsonschema, functools32 10:01:58 INFO - Running setup.py install for functools32 10:01:58 INFO - warning: no files found matching '*.txt' 10:01:58 INFO - no previously-included directories found matching 'build' 10:01:58 INFO - no previously-included directories found matching 'dist' 10:01:58 INFO - no previously-included directories found matching '.git*' 10:01:58 INFO - Successfully installed jsonschema functools32 10:01:58 INFO - Cleaning up... 10:01:58 INFO - Return code: 0 10:01:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:01:58 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 0x7fdabfe63f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c61480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', '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 10:01:58 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 10:01:58 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 10:01:58 INFO - Using env: {'DISPLAY': ':0', 10:01:58 INFO - 'HOME': '/home/cltbld', 10:01:58 INFO - 'LANG': 'en_US.UTF-8', 10:01:58 INFO - 'LANGUAGE': 'en_US:en', 10:01:58 INFO - 'LOGNAME': 'cltbld', 10:01:58 INFO - 'MAIL': '/var/mail/cltbld', 10:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:58 INFO - 'MOZ_NO_REMOTE': '1', 10:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:58 INFO - 'NO_EM_RESTART': '1', 10:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:01:58 INFO - 'SHELL': '/bin/bash', 10:01:58 INFO - 'SHLVL': '1', 10:01:58 INFO - 'TERM': 'linux', 10:01:58 INFO - 'TMOUT': '86400', 10:01:58 INFO - 'USER': 'cltbld', 10:01:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:58 INFO - '_': '/tools/buildbot/bin/python'} 10:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:01:59 INFO - Downloading/unpacking flake8 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:01:59 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 10:02:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:02:00 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 10:02:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:02:00 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 10:02:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:01 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 10:02:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:01 INFO - no previously-included directories found matching 'docs/_build' 10:02:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:02:01 INFO - Running setup.py install for pep8 10:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:02:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:02:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:02:01 INFO - no previously-included directories found matching 'docs/_build' 10:02:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:02:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:02:01 INFO - Cleaning up... 10:02:01 INFO - Return code: 0 10:02:01 INFO - Running post-action listener: _resource_record_post_action 10:02:01 INFO - Running post-action listener: _start_resource_monitoring 10:02:01 INFO - Starting resource monitoring. 10:02:01 INFO - ##### 10:02:01 INFO - ##### Running install step. 10:02:01 INFO - ##### 10:02:01 INFO - Running pre-action listener: _resource_record_pre_action 10:02:01 INFO - Running main action method: install 10:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:02:01 INFO - Reading from file tmpfile_stdout 10:02:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:02:01 INFO - Reading from file tmpfile_stdout 10:02:01 INFO - Output received: 10:02:01 INFO - Usage: mozinstall [options] installer 10:02:01 INFO - Options: 10:02:01 INFO - -h, --help show this help message and exit 10:02:01 INFO - -d DEST, --destination=DEST 10:02:01 INFO - Directory to install application into. [default: 10:02:01 INFO - "/builds/slave/test-pgo"] 10:02:01 INFO - --app=APP Application being installed. [default: firefox] 10:02:01 INFO - mkdir: /builds/slave/test-pgo/build/application 10:02:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:02:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:02:18 INFO - Reading from file tmpfile_stdout 10:02:18 INFO - Output received: 10:02:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:02:18 INFO - Running post-action listener: _resource_record_post_action 10:02:18 INFO - ##### 10:02:18 INFO - ##### Running run-tests step. 10:02:18 INFO - ##### 10:02:18 INFO - Running pre-action listener: _resource_record_pre_action 10:02:18 INFO - Running main action method: run_tests 10:02:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:02:18 INFO - Python 2.7.3 10:02:18 INFO - Return code: 0 10:02:18 INFO - grabbing minidump binary from tooltool 10:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:02:18 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 0x2cf0660>, '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 0x2cf1560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf1a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:02:18 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 10:02:18 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 10:02:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:02:18 INFO - Return code: 0 10:02:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:02:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:02:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:02:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:02:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:02:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:02:19 INFO - Return code: 0 10:02:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:02:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:02:19 INFO - Using env: {'DISPLAY': ':0', 10:02:19 INFO - 'HOME': '/home/cltbld', 10:02:19 INFO - 'LANG': 'en_US.UTF-8', 10:02:19 INFO - 'LANGUAGE': 'en_US:en', 10:02:19 INFO - 'LOGNAME': 'cltbld', 10:02:19 INFO - 'MAIL': '/var/mail/cltbld', 10:02:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:19 INFO - 'MOZ_NO_REMOTE': '1', 10:02:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:19 INFO - 'NO_EM_RESTART': '1', 10:02:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:02:19 INFO - 'PWD': '/builds/slave/test-pgo', 10:02:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:02:19 INFO - 'SHELL': '/bin/bash', 10:02:19 INFO - 'SHLVL': '1', 10:02:19 INFO - 'TERM': 'linux', 10:02:19 INFO - 'TMOUT': '86400', 10:02:19 INFO - 'USER': 'cltbld', 10:02:19 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622', 10:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:19 INFO - '_': '/tools/buildbot/bin/python'} 10:02:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:02:19 INFO - mozversion application_buildid: 20160115073123 10:02:19 INFO - mozversion application_changeset: 02398f2be72b9bbf5ee79348b73ef122c915aae0 10:02:19 INFO - mozversion application_display_name: Nightly 10:02:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:02:19 INFO - mozversion application_name: Firefox 10:02:19 INFO - mozversion application_remotingname: firefox 10:02:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:02:19 INFO - mozversion application_vendor: Mozilla 10:02:19 INFO - mozversion application_version: 46.0a1 10:02:19 INFO - mozversion platform_buildid: 20160115073123 10:02:19 INFO - mozversion platform_changeset: 02398f2be72b9bbf5ee79348b73ef122c915aae0 10:02:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:02:19 INFO - mozversion platform_version: 46.0a1 10:02:19 INFO - using testdate: 1452880939 10:02:19 INFO - actual date: 1452880939 10:02:19 INFO - starting webserver on 'localhost:38425' 10:02:19 INFO - SUITE-START | Running 3 tests 10:02:19 INFO - TEST-START | dromaeo_css 10:02:19 INFO - operating with platform_type : linux_ 10:02:19 INFO - Initialising browser for dromaeo_css test... 10:02:19 INFO - TEST-INFO | started process 10443 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYrRWiO/profile http://localhost:38425/getInfo.html) 10:02:23 INFO - PROCESS | 10443 | 10:02:23 INFO - PROCESS | 10443 | (process:10527): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:02:23 INFO - PROCESS | 10443 | __metrics Screen width/height:1600/1200 10:02:23 INFO - PROCESS | 10443 | colorDepth:24 10:02:23 INFO - PROCESS | 10443 | Browser inner width/height: 1024/697 10:02:23 INFO - PROCESS | 10443 | __metrics 10:02:24 INFO - PROCESS | 10443 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:02:24 INFO - TEST-INFO | 10443: exit 0 10:02:24 INFO - Browser initialized. 10:02:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:02:24 INFO - TEST-INFO | started process 10576 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYrRWiO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:02:26 INFO - PROCESS | 10576 | 10:02:26 INFO - PROCESS | 10576 | (process:10634): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:02:36 INFO - PROCESS | 10576 | RSS: Main: 150630400 10:02:36 INFO - PROCESS | 10576 | 10:03:26 INFO - PROCESS | 10576 | 1452881006348 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] 10:05:35 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38425/tests/dromaeo/cssquery-ext.html) 10:05:36 INFO - PROCESS | 10576 | RSS: Main: 156364800 10:05:36 INFO - PROCESS | 10576 | 10:08:38 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-ext.html (next: http://localhost:38425/tests/dromaeo/cssquery-jquery.html) 10:08:39 INFO - PROCESS | 10576 | RSS: Main: 152952832 10:08:39 INFO - PROCESS | 10576 | 10:11:41 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38425/tests/dromaeo/cssquery-mootools.html) 10:11:41 INFO - PROCESS | 10576 | RSS: Main: 152104960 10:11:41 INFO - PROCESS | 10576 | 10:14:43 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38425/tests/dromaeo/cssquery-prototype.html) 10:14:44 INFO - PROCESS | 10576 | RSS: Main: 150970368 10:14:44 INFO - PROCESS | 10576 | 10:17:46 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38425/tests/dromaeo/cssquery-yui.html) 10:17:47 INFO - PROCESS | 10576 | RSS: Main: 151953408 10:17:47 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | Cycle 1(1): loaded http://localhost:38425/tests/dromaeo/cssquery-yui.html (next: http://localhost:38425/tests/dromaeo/cssquery-dojo.html) 10:20:49 INFO - PROCESS | 10576 | RSS: Main: 153432064 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | __start_tp_report 10:20:49 INFO - PROCESS | 10576 | _x_x_mozilla_page_load 10:20:49 INFO - PROCESS | 10576 | _x_x_mozilla_page_load_details 10:20:49 INFO - PROCESS | 10576 | |i|pagename|runs| 10:20:49 INFO - PROCESS | 10576 | |0;dojo.html;3292.539044533767;3294.2093897464606;3315.0883507035564;3330.6169790474073;3344.1138098403926;5370.91943620845;5373.838784836461;5400;5418.40397556269;5432.809851655193;5410.161424979125;5415.593830462712;5504.80733174339;5531.197976293435;5583.748731307091;4973.179425394815;5000.549950504454;5075.746212689369;5077.796888124471;5084.4661310562415;5071.644984851062;5072.112380333427;5142.845714628548;5143.639945203838;5148.922766158511;4887.14474966883;4907.460179380283;4949.653524253304;4970.726610036447;4983.551480366748;5037.143685573461;5051.772670229849;5051.797928082872;5062.063518249099;5064.037832811754;5003.324551185579;5028.522290382408;5030.220315851049;5040.873978150539;5047.798088076509;5223.981323641891;5236.8690782730355;5298.443663415324;5302.0721373759825;5343.118385466393;5852.034414321632;5853.414658534155;5873.383294754032;5876.265466816648;5877.265341832271;5931.495822855062;5938.435848594377;5941.2276404067625;5946.316173640001;5947.10793380992;5445.809396671137;5504.311961004874;5543.113101903717;5605.467480589419;5651.463111004448;5859.384764599656;5907;5926.377730338339;5930.11048342752;5956.255468066492;5652.3217213934595;5691;5698.914516282176;5704.971475142598;5727.799527016535;5791.710414479259;5863.2670916135485;5951;5958.136070269787;6001.849953751192;5775.422457754191;5821.76712931478;5833.854153646193;5834.299884013861;5837.824865254049;5746.88506229873;5763.135529670583;5801.7389217485315;5827.4172582741385;5829.708514574254;4421.955780442218;4439.733615983051;4492.820287188541;4495.775211239425;4533.637309015271;3948.861789837342;3950.762954222756;3958.762474251554;3991.5808840071954;3996;5387.595930305243;5388.084025715638;5389;5400.270963419966;5413.702246376487;5793.507551858055;5863.149843272701;5886.587938844325;5893.6463812171405;5957.910631340534;5460.290162278958;5465.207544906046;5477.507024367826;5484.725763711798;5509.090999984957;4878.170710979142;4946.579540739005;4958.628102892298;4980.427250866197;5031.82388616404;6046.425589568984;6107.938920610826;6109.435031337442;6109.550212586144;6112.042504713611;5805.535557155502;5822.475977162076;5827.59206855533;5855.59010869235;5881.735321910439;5844.532437405082;5962.493188079062;6055.485283750931;6055.576109672281;6059.3637668045985;5797.2173756542325;5820.82537523875;5823.475887170006;5829.446202610745;5880.441358071148;5842.7662893485485;5888.705564721832;5918.3489816121055;5929.199558059607;5934.376890426615;5612.045952188219;5699.401562836008;5758.568107392046;5764.07774756037;5765.7117144141785;5739.053056245672;5744.511716504144;5746.798862039808;5751.9137212941005;5763.625364351304;5579.079451890392;5590.580706447114;5608.551315894637;5608.635438696471;5624.072028115315;5537.667739935617;5670.74481648335;5699.686517241592;5709.286339207599;5752.827415177551;5655;5659.434056594308;5659.830205093854;5663.971680141738;5666.603337766317 10:20:49 INFO - PROCESS | 10576 | |1;ext.html;536.5546596325049;544.1103795294697;546.8386825886363;558.260305095748;592.5526227698084;37330.81334593327;37647;37794.8110259449;37955;37996;40403.59596404035;40858.795706021425;40927.38608920861;41015.79492102543;41080.79459602698;8383.455075420108;8560.229579337858;8604.053554109043;8609.096044915288;8659.870101948476;8392.496450212977;8444.0289366723;8483.321334293241;8484.872726909101;8525.403221774479;8623.09457506959;8647.394682372236;8668.39321247513;8734.388592798507;8759;8590.355723320776;8649.394542382035;8664.350173736995;8684.305255579538;8698.304135669132;8437.451565648213;8546.2308392245;8576.05663377028;8625.525596092213;8647.740567782914;38372.232555349015;38612.80693596542;38666.806665966775;38749.61250387516;38807;3250.593675790526;3260.2990357073104;3401.795892246473;3699.278640665071;4007.7996100195164;29423.558646620317;29860.253493662614;29890.70109298901;31668.683313167036;31670.366592668248;3449.844756985942;3468.0982944434627;3493.807840568768;3526.4886591444097;3607.404778211618;205489;205898;205988;206006;207208.96395518078;57430;57445.71277143671;57567;57655.71172144113;57701;60892.39107608956;64939.67530162319;65602;65624.67187664127;65713.6714316435;13978.580642580739;14157.646058848612;14177.22025288619;14192.787108193384;14217.715645687029;10432.217583681255;10458.163346932228;10463.319884207502;10476.842847357295;10529.10502607287;19487.317943871898;19952.600947980958;19971.301004464774;19973.300934467516;20047.799522004883;7788.14330423653;7798.454108212484;7964;7996.200379962073;8110;871.904090550039;928.6331898899897;951.1962391778935;1035.6427032673716;1036.4972988100765;30697.846510767304;31630.209244769067;31984.520232196537;32024.199395015312;32593;1001.6994901529512;1026.6714651311659;1028.4240825137947;1088.0262165361958;1131.5982826096617;15195.620109497351;15260.618484537754;15408.152551609544;15469.613259668598;15887.761683574756;392703;396353;397232;397800;397981;54893.451065488836;55227;55291.44708552863;55331;55352;1301.2322729589587;1303.9739205215842;1316.4207748590588;1321;1323.8146659467682;28971.855140725005;29288.70711292945;29319.853400733715;29684.703152968195;29941.251468712584;46177.538224617325;46365.768171158925;46474;46630.76684616555;46703.53296466992;286687;286984;287218.150366468;287546;288355;32844.507332389556;43632.34551481667;43679.78160109179;44639;44762.3285650722;40509.59490405176;40515;41046;41645.37531937084;46134;35633;36079.842575105904;36222.01557828584;36974.26051479009;37580.2483950314;37011.44482832814;39142.412863806494;40207.396889046104;40944.795276023426;42758.57241427671;36924.44613330749;38296.2340753189;39387.2122557553;39533;39647.2070558593;28899.566506502;31401.68598314079;32211;32325.51511727279;34190.82904585461;25076;25227.49545009126;25652.35869103213;26045.609315860656;27302.31744206331 10:20:49 INFO - PROCESS | 10576 | |2;jquery.html;365.14555939102513;366.24370674557036;368.3939918833518;368.5742966873261;371.1852483798064;15527.378904843807;16860.83139168608;17137;17719.55701107473;18149.818501814978;11041.227114102016;11535.538578456852;16500.17499125045;16516.917415412936;16614.501564953072;4940.258961155829;5482.862928426782;5542.057850165482;5542.528885044776;5568.66588004719;4468.3074123510905;5047.343845300106;5433.293671822657;5482.533984611313;5503.20203570482;5022.5730812880765;5026.698398096108;5045.520675535837;5264.6051546134;5280.313559237294;5163.302954101205;5230.267762513251;5275.577953763709;5285.6300058995885;5580.107182850725;5366.517013468807;5384.138537833927;5399.784008639689;5400.216968539579;5404.486573775485;14498.637534061732;19500;20263.696044559343;20415.591688166154;20455.5908881823;1963.1264087481077;2029.6143732690741;2084.176750183669;2090.6131767450433;2098.380977611608;9458.52707364629;10530.31552949056;12799.168054076456;12939.741205175938;13024.283664398454;1776.4759395978217;1831.3123576281455;1832.175521015535;1864.1983946902826;1879.2764785557658;55251.44748552544;55687.443125569036;55895.161572576035;57319.42680573224;57853.71073144607;9653.613855445845;10022.198224142052;10152.492375381202;10168.186545076376;10175.084242418217;13124.606261812161;13162.407691653898;13269.800952985714;13303.002274829427;13316.533921312901;6834.419074378634;6855.108835851307;6869.622170780655;7059.329363710439;7176;6466.870662586722;6634.137562116894;6790.5925644461495;6799.864002719918;6854.34883686049;4298.183345164409;4406.228909940747;4446.799894004777;4447.755373454426;4481.529439408815;1721.340528882879;1773.5034190426702;1778.2531336838558;1810.5654642885877;1815.972760408595;822.5681517203516;893.6023469555985;896.4755617963565;962.5331714118647;1005.8893521712606;15522.689546209012;15940.963837350535;16150.515484535483;16395.672086558203;16661.91669041647;831.7296878514506;845.6955496021427;861.6897916749965;875.6935072724496;925.1303774451993;7356.337929586363;9622.759431014281;9631.855522167172;9646.324757266924;9748.415095094317;474596;481667;501817;506146;513326;66631.66684166549;69417.30582694108;69510.65244673744;70861.6456917712;73201;1128.2158899564724;1159.7390587118;1162.3607016141257;1169.2107827216764;1170.7131752720638;15034.774478383051;15239.847601523843;15357.769633455731;15428.151451670266;15830.762538561701;32256.677433225366;32768.836155819066;33098.338033239685;33169.170770730925;33393;41478.79260603798;42848.57151428446;42886.78556607322;43205;43453.56546434622;6936.7225310987;7121;7269.890951635624;7491.625418728932;7497.62511874415;9579.281553883626;10727.249092563447;11477.196596238184;11660.358680272328;11751.47118379692;8772.517511536927;9347.953260233655;9452.723882275804;9464.858027129461;9511.524423778921;9010.729678109667;9516.666916657883;9685.225181985565;9973.750656233653;10033.297669163088;9920.75198120024;10017.298789084694;10133.493325333851;10328.690139295833;10334;7314.561126332437;7532.623368831427;7569.848603028019;7584.772456826304;7607.695692172472;8670.30637548982;10023.799524009624;10026.248031397528;10214.540345684314;10256.38461692301 10:20:49 INFO - PROCESS | 10576 | |3;mootools.html;1476.37254166979;1499.5726218027864;1677.412905483081;1732.0733407626922;1817.2004318100035;7848.4113691473085;7933.087694915086;8036.638351274192;8072.031356237259;8079.596020198988;8043.6380362883665;8093.595320233994;8156.592170391472;8164.591770411471;8171.713990010351;2389.247387073075;2432;2440.3045132137345;2447.7674620911075;2449.6937882764655;2401;2417.2748175547354;2443.7922776564014;2445.6576079348906;2446.902123915041;2335.4628435459854;2370.5851475991717;2387.85672859629;2397.077125306752;2406.362313986795;2395.1257790906366;2416.5891798394314;2424.3454267347806;2426.065964603623;2429.1012325439524;2429.975700242993;2435.8173137014796;2443.1571107967725;2446.2905757330354;2451.8161137914726;8049.235322644339;8075.838483230303;8092.554909479976;8094;8104.594770261463;4935.70385776851;5002;5015.899682006339;5027.622928280357;5034.823781167678;3293.8965446575426;3412.5904891412943;3414.6756058174433;3422.110251334671;3480.4953281774256;1059.5602824827688;1079.5465904320204;1099.8625171853519;1102.3000394749392;1153.7692461507647;10619.203559732974;10696.732581685443;10710.785784284348;10711.089557387553;10722.249442538947;4239.554846741109;4333.609975102256;4338.110687309094;4394.428724265825;4506.481754598198;8722.25860801839;8789.780255493535;8795.340349473816;8812.854328937325;8818;4891.26631005352;4902.044101400193;4915.778789954461;4918.9508104919205;4956.529129732669;4519.570640789119;4525.185466616041;4546.613537849254;4551.2717965126085;4583.312503124558;3609.3864043112735;3660.9816950915074;3673.4673472346362;3678.3746763050344;3693.926121477555;1055.5091882274778;1106.5352551928208;1120.4957769003818;1126.0822429719751;1137.7440075983004;1053.5311786255043;1112.8275117356823;1165.4289398194824;1231.7105480212142;1327.1108357400565;7333.230010848891;7336.926630733731;7377.594232317167;7388.371988381048;7455.85088298231;620.5904103291806;630.1618846933567;633.8542135308904;640.1549954060596;771.2981187119694;5492.5605951523785;5581.134924086773;5597.048501754712;5617.691026993554;5714.142878568248;9646.469444180637;9956.352837065568;9960.352577082467;10057.949710251401;10084.394936303845;9763.560639771227;9852.113309802153;9973.052560006789;9989.95105513925;10050;7693.384529237647;7698.42261830365;7792.376609871197;7819.218078192135;7848.058233012075;7284.854302913806;7375.483716139819;7505.286997735207;7524.510906791041;7546.886796698163;8271.875921861056;8444.535550544533;8638.611262493328;8872.112788721077;9063.90936090657;8557.914420855712;8613.26787223093;8655.264302534355;8752.387332886638;8794.472331660121;6878.55289406187;7207.243239459991;7250.093738282715;7295.927040729524;7316.707331706672;7427.4800763946005;7505.587192704235;7527.924720752722;7549.811254718676;7550.5469671819865;6456.289808121197;7059.647017649199;7145.606991615511;7150.713971441084;7274.199838017919;6941.652917354011;7029.015937768614;7053.506254562131;7135.785926422215;7281.017062696468;7213.1704853942465;7283.890741638986;7292.197858235696;7299;7308.415326773739;6386.297507274289;6386.489080873426;6406.263279722705;6413.326600706859;6413.775517856852;6350;6414.807555773335;6420.743170273324;6426.003969384753;6426.518011149089 10:20:49 INFO - PROCESS | 10576 | |4;prototype.html;336.67510852027794;348.25647243135904;351.9331327047861;358.2905846424082;360.6411620437663;6104.755809767615;6207.627542347456;6231.6884155792195;6232.096346029823;6261.749530018805;6086.330503644595;6181.969090154555;6183.628982261068;6197.163382943301;6228.626282423058;4823.614110871122;4825.083234185494;4836.395450568679;4836.6856154350035;4837.467878533358;4799.928001079987;4806.110869489138;4825.131476334259;4825.541573550507;4841.2012018016985;4713.717176969393;4795.568398844103;4805.255185446262;4806;4809.615230781529;4776.761161941907;4781.187198176319;4793.7363445010515;4797.30439086334;4798.5201479852085;4202.075543380452;4223.957760422418;4224.429701990222;4224.619784219435;4227.408162857202;5911.231539899829;5914.674692891889;5939.4357536034;5948.97025514874;5958.40415958405;5407.810726624549;5616.943830561683;5619;5624.397046841671;5631.831045068655;6630.038644396535;6635.369639884203;6642.302558231413;6649.368310010541;6659.833504162386;4689.062187562501;4690.9530904690855;4694.178518759203;4694.530546945312;4696.459907110692;6693.933060669428;6872.450203983669;6941.444684425284;6945.652717364112;6961.373476387099;4659.347691323217;4685.648576356787;4693.741844198602;4698.271767875985;4703.95296047042;4726.858194254178;4733.668643194943;4739.95260047402;4743.0988112258565;4748.287756836433;5480.808171713971;5506.64206826555;5513.807016754395;5514.035043867307;5525.171224316385;6470.514711396664;6594.637294948824;6628.204615446178;6647.933520664828;6674.098996635489;1655.213773457598;1670.189957870456;1729.7405389191722;1731.1171302635494;1739.1738924011247;1155.2433156282648;1170.0931777872047;1171.812509998396;1173.0146676791367;1177.587844254521;6230.532710046765;6282.089097080898;6301.558890877686;6303.590266632654;6326.2724786649205;6741.224759152662;6761.661916904135;6771.052052712625;6776.322367763184;6782.694778734969;6131.662758548323;6284.497240220771;6286.371362863677;6296.779612713533;6299.055141728777;3663.578688450862;3681.4537894084547;3686.668199862025;3693.3905905525826;3701.3892707702926;7086.397656199178;7095.361417472453;7096.574205547684;7112.25321341262;7130.750423735144;6870.484713646497;6968.1638203414905;6983.580985140908;6986.790396288119;7025.89461158083;7180.640967951582;7183.784486465414;7232.45756568249;7254.310840470147;7274.599897005715;6890.896636550356;6897.586144831326;6905.551139175937;6918.688659010256;6928.722851086101;6764.76568815615;6773.491988100814;6823.351781580742;6853.211880633591;6876.277990811093;7211.531250468703;7221.4222862171955;7223.205447400886;7227.421806255382;7252.347288744038;4679.227927391942;4710.905781884411;4713.363695901009;4717.528247175255;4744.478107408251;6771.695273712793;6912.4815638828295;6921.550099243533;6932.93067069343;6989;6721.361470660279;6731.1922569292;6741.393274605309;6747.392734653905;6747.831304217434;6669.933300667125;6707.564008339442;6741.325867413416;6753.3921947025;6758.966205168943;6444.871102577828;6557.442617377576;6612.636305003271;6619.172603424572;6620.404163625297;6745.426638735762;6754.459643228432;6759.763408280686;6773.085633439423;6777.559458635173;6560.639164845788;6605.801825945229;6608.107905432705;6608.768693095719;6612.70242839083 10:20:49 INFO - PROCESS | 10576 | |5;yui.html;717.7308509309009;755.6297414267011;764.4152223548986;789.6959670526848;813.2384886489604;13214.867851321496;13223.735525289489;13248.403821828017;13321.20072795633;13340.7331853363;12096.33470159141;12103.878961210385;12185.878141218585;12200.084993625469;12200.206986545869;664.0636702249828;679.222290477403;787.3937068457284;800.75977206838;805.5851236613149;803.7428023032631;807.8263173417714;814.3566582399897;814.8533264012475;817.3665409307804;847.4957400346815;851.812601227732;851.9190676885717;852.0074113657613;855.7518319687283;844.0757370679097;844.1558441558442;845.5814371885925;846.8221673448584;850.1286181663813;629.4240769695723;630.0612087988864;630.8139098965817;631.3749388105742;632.4813652804702;12116.81824772629;12262.509499620004;12280.07899407548;12291.446884890112;12877.806832897513;12700.555480558229;12942.223466592035;13232.735345293137;13399.732005359838;13497.595072147851;9493.43470278286;9545.61817527305;9862.50687465624;9871.753206169831;9985.350952188084;3505.2638945821154;3597.1546686528645;3599.2981368633127;3616.4936908832783;3618.9276214475826;46174.53825461736;46215.76892115552;46282.074358512975;46490;46501.76749116267;9264.166225039779;9647.758806029906;9669.274804389559;9989.350692204984;10083.49582520871;17733.11334433299;17734.91132544329;17740.11299435023;17745.911270443565;17786.288548458175;7066;7118.9644051779405;7132.144142702805;7133.7146514139895;7201.855962880818;4117.3618089195625;4134.958650413518;4153.439285696452;4178.665706743514;4228.936565951513;3067.3098552825436;3081.3683194944983;3084.0901933929094;3087.706667866549;3103.844807759603;537.3605409562608;552.257214047106;566.0575142387878;577.3850848845966;583.2505230778429;559.963602365845;570.3156212544963;588.9499392551681;591.4351794036685;600.7747094839435;7709.2290770922455;8384.99380074395;8574.185452382013;8627.827443451095;8987.505687187268;528.7752705100394;545.3782687735984;559.7285316621435;566.1592535085395;628.7327885648673;3822.3502004659276;4060.939085913714;4147.52303485097;4177.122804211089;4323.524412314643;57505;58525.414745852846;58835.411645882996;58844.705776470844;58881.11678324828;51206.487935120174;51510;51626.22560661593;52083.47916520862;52184.47815521796;46599.76700116478;46770.766146169735;47090.293645595346;47101.5289847104;47573.04853902903;8255.339572834278;8302.6678932842;8395.32837373021;8530.360222983178;8714.956425218086;33318.00183977938;33905.83047084749;33976.66023339735;33992.320153597284;34038.14904627404;41181.588184117776;45244;45784.54215457936;45854;46029.53970460386;9306.255499560155;9933.3543319684;9947.88114711258;10148.391096534231;10247.795044099226;10615.628453004108;10818.1886358525;10845.078168355778;11113.777724445628;11343.886561134283;10998.505067272152;11097.944510277719;11150.888491114985;11200.943995279971;11659.825102623297;10764.946175269073;10978.890211097787;11107.833382499108;11371.715707107389;11439.714007149887;10524.631637892637;10655.627053053106;10922.836157457803;10933.125349972142;10989.780204396027;8715.302775777796;8778;8901.198892099743;9072.228860546664;9167.633294668405;8796.592545192738;9188.862167067366;9281.890014529516;9397.953010234905;9655.062534852315 10:20:49 INFO - PROCESS | 10576 | __end_tp_report 10:20:49 INFO - PROCESS | 10576 | __start_cc_report 10:20:49 INFO - PROCESS | 10576 | _x_x_mozilla_cycle_collect,311 10:20:49 INFO - PROCESS | 10576 | __end_cc_report 10:20:49 INFO - PROCESS | 10576 | __startTimestamp1452882049736__endTimestamp 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | ------- Summary: start ------- 10:20:49 INFO - PROCESS | 10576 | Number of tests: 6 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#0] dojo.html Cycles:165 Average:5436.10 Median:5652.32 stddev:598.44 (10.6%) stddev-sans-first:576.17 10:20:49 INFO - PROCESS | 10576 | Values: 3292.5 3294.2 3315.1 3330.6 3344.1 5370.9 5373.8 5400.0 5418.4 5432.8 5410.2 5415.6 5504.8 5531.2 5583.7 4973.2 5000.5 5075.7 5077.8 5084.5 5071.6 5072.1 5142.8 5143.6 5148.9 4887.1 4907.5 4949.7 4970.7 4983.6 5037.1 5051.8 5051.8 5062.1 5064.0 5003.3 5028.5 5030.2 5040.9 5047.8 5224.0 5236.9 5298.4 5302.1 5343.1 5852.0 5853.4 5873.4 5876.3 5877.3 5931.5 5938.4 5941.2 5946.3 5947.1 5445.8 5504.3 5543.1 5605.5 5651.5 5859.4 5907.0 5926.4 5930.1 5956.3 5652.3 5691.0 5698.9 5705.0 5727.8 5791.7 5863.3 5951.0 5958.1 6001.8 5775.4 5821.8 5833.9 5834.3 5837.8 5746.9 5763.1 5801.7 5827.4 5829.7 4422.0 4439.7 4492.8 4495.8 4533.6 3948.9 3950.8 3958.8 3991.6 3996.0 5387.6 5388.1 5389.0 5400.3 5413.7 5793.5 5863.1 5886.6 5893.6 5957.9 5460.3 5465.2 5477.5 5484.7 5509.1 4878.2 4946.6 4958.6 4980.4 5031.8 6046.4 6107.9 6109.4 6109.6 6112.0 5805.5 5822.5 5827.6 5855.6 5881.7 5844.5 5962.5 6055.5 6055.6 6059.4 5797.2 5820.8 5823.5 5829.4 5880.4 5842.8 5888.7 5918.3 5929.2 5934.4 5612.0 5699.4 5758.6 5764.1 5765.7 5739.1 5744.5 5746.8 5751.9 5763.6 5579.1 5590.6 5608.6 5608.6 5624.1 5537.7 5670.7 5699.7 5709.3 5752.8 5655.0 5659.4 5659.8 5664.0 5666.6 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#1] ext.html Cycles:180 Average:47256.23 Median:38492.52 stddev:80670.25 (209.6%) stddev-sans-first:80820.28 10:20:49 INFO - PROCESS | 10576 | Values: 536.6 544.1 546.8 558.3 592.6 37330.8 37647.0 37794.8 37955.0 37996.0 40403.6 40858.8 40927.4 41015.8 41080.8 8383.5 8560.2 8604.1 8609.1 8659.9 8392.5 8444.0 8483.3 8484.9 8525.4 8623.1 8647.4 8668.4 8734.4 8759.0 8590.4 8649.4 8664.4 8684.3 8698.3 8437.5 8546.2 8576.1 8625.5 8647.7 38372.2 38612.8 38666.8 38749.6 38807.0 3250.6 3260.3 3401.8 3699.3 4007.8 29423.6 29860.3 29890.7 31668.7 31670.4 3449.8 3468.1 3493.8 3526.5 3607.4 205489.0 205898.0 205988.0 206006.0 207209.0 57430.0 57445.7 57567.0 57655.7 57701.0 60892.4 64939.7 65602.0 65624.7 65713.7 13978.6 14157.6 14177.2 14192.8 14217.7 10432.2 10458.2 10463.3 10476.8 10529.1 19487.3 19952.6 19971.3 19973.3 20047.8 7788.1 7798.5 7964.0 7996.2 8110.0 871.9 928.6 951.2 1035.6 1036.5 30697.8 31630.2 31984.5 32024.2 32593.0 1001.7 1026.7 1028.4 1088.0 1131.6 15195.6 15260.6 15408.2 15469.6 15887.8 392703.0 396353.0 397232.0 397800.0 397981.0 54893.5 55227.0 55291.4 55331.0 55352.0 1301.2 1304.0 1316.4 1321.0 1323.8 28971.9 29288.7 29319.9 29684.7 29941.3 46177.5 46365.8 46474.0 46630.8 46703.5 286687.0 286984.0 287218.2 287546.0 288355.0 32844.5 43632.3 43679.8 44639.0 44762.3 40509.6 40515.0 41046.0 41645.4 46134.0 35633.0 36079.8 36222.0 36974.3 37580.2 37011.4 39142.4 40207.4 40944.8 42758.6 36924.4 38296.2 39387.2 39533.0 39647.2 28899.6 31401.7 32211.0 32325.5 34190.8 25076.0 25227.5 25652.4 26045.6 27302.3 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#2] jquery.html Cycles:180 Average:26169.02 Median:4458.03 stddev:80992.57 (1816.8%) stddev-sans-first:81196.60 10:20:49 INFO - PROCESS | 10576 | Values: 365.1 366.2 368.4 368.6 371.2 15527.4 16860.8 17137.0 17719.6 18149.8 11041.2 11535.5 16500.2 16516.9 16614.5 4940.3 5482.9 5542.1 5542.5 5568.7 4468.3 5047.3 5433.3 5482.5 5503.2 5022.6 5026.7 5045.5 5264.6 5280.3 5163.3 5230.3 5275.6 5285.6 5580.1 5366.5 5384.1 5399.8 5400.2 5404.5 14498.6 19500.0 20263.7 20415.6 20455.6 1963.1 2029.6 2084.2 2090.6 2098.4 9458.5 10530.3 12799.2 12939.7 13024.3 1776.5 1831.3 1832.2 1864.2 1879.3 55251.4 55687.4 55895.2 57319.4 57853.7 9653.6 10022.2 10152.5 10168.2 10175.1 13124.6 13162.4 13269.8 13303.0 13316.5 6834.4 6855.1 6869.6 7059.3 7176.0 6466.9 6634.1 6790.6 6799.9 6854.3 4298.2 4406.2 4446.8 4447.8 4481.5 1721.3 1773.5 1778.3 1810.6 1816.0 822.6 893.6 896.5 962.5 1005.9 15522.7 15941.0 16150.5 16395.7 16661.9 831.7 845.7 861.7 875.7 925.1 7356.3 9622.8 9631.9 9646.3 9748.4 474596.0 481667.0 501817.0 506146.0 513326.0 66631.7 69417.3 69510.7 70861.6 73201.0 1128.2 1159.7 1162.4 1169.2 1170.7 15034.8 15239.8 15357.8 15428.2 15830.8 32256.7 32768.8 33098.3 33169.2 33393.0 41478.8 42848.6 42886.8 43205.0 43453.6 6936.7 7121.0 7269.9 7491.6 7497.6 9579.3 10727.2 11477.2 11660.4 11751.5 8772.5 9348.0 9452.7 9464.9 9511.5 9010.7 9516.7 9685.2 9973.8 10033.3 9920.8 10017.3 10133.5 10328.7 10334.0 7314.6 7532.6 7569.8 7584.8 7607.7 8670.3 10023.8 10026.2 10214.5 10256.4 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#3] mootools.html Cycles:180 Average:5601.63 Median:3491.93 stddev:2892.53 (82.8%) stddev-sans-first:2884.02 10:20:49 INFO - PROCESS | 10576 | Values: 1476.4 1499.6 1677.4 1732.1 1817.2 7848.4 7933.1 8036.6 8072.0 8079.6 8043.6 8093.6 8156.6 8164.6 8171.7 2389.2 2432.0 2440.3 2447.8 2449.7 2401.0 2417.3 2443.8 2445.7 2446.9 2335.5 2370.6 2387.9 2397.1 2406.4 2395.1 2416.6 2424.3 2426.1 2429.1 2430.0 2435.8 2443.2 2446.3 2451.8 8049.2 8075.8 8092.6 8094.0 8104.6 4935.7 5002.0 5015.9 5027.6 5034.8 3293.9 3412.6 3414.7 3422.1 3480.5 1059.6 1079.5 1099.9 1102.3 1153.8 10619.2 10696.7 10710.8 10711.1 10722.2 4239.6 4333.6 4338.1 4394.4 4506.5 8722.3 8789.8 8795.3 8812.9 8818.0 4891.3 4902.0 4915.8 4919.0 4956.5 4519.6 4525.2 4546.6 4551.3 4583.3 3609.4 3661.0 3673.5 3678.4 3693.9 1055.5 1106.5 1120.5 1126.1 1137.7 1053.5 1112.8 1165.4 1231.7 1327.1 7333.2 7336.9 7377.6 7388.4 7455.9 620.6 630.2 633.9 640.2 771.3 5492.6 5581.1 5597.0 5617.7 5714.1 9646.5 9956.4 9960.4 10057.9 10084.4 9763.6 9852.1 9973.1 9990.0 10050.0 7693.4 7698.4 7792.4 7819.2 7848.1 7284.9 7375.5 7505.3 7524.5 7546.9 8271.9 8444.5 8638.6 8872.1 9063.9 8557.9 8613.3 8655.3 8752.4 8794.5 6878.6 7207.2 7250.1 7295.9 7316.7 7427.5 7505.6 7527.9 7549.8 7550.5 6456.3 7059.6 7145.6 7150.7 7274.2 6941.7 7029.0 7053.5 7135.8 7281.0 7213.2 7283.9 7292.2 7299.0 7308.4 6386.3 6386.5 6406.3 6413.3 6413.8 6350.0 6414.8 6420.7 6426.0 6426.5 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#4] prototype.html Cycles:180 Average:5572.04 Median:6246.92 stddev:1676.78 (26.8%) stddev-sans-first:1634.79 10:20:49 INFO - PROCESS | 10576 | Values: 336.7 348.3 351.9 358.3 360.6 6104.8 6207.6 6231.7 6232.1 6261.7 6086.3 6182.0 6183.6 6197.2 6228.6 4823.6 4825.1 4836.4 4836.7 4837.5 4799.9 4806.1 4825.1 4825.5 4841.2 4713.7 4795.6 4805.3 4806.0 4809.6 4776.8 4781.2 4793.7 4797.3 4798.5 4202.1 4224.0 4224.4 4224.6 4227.4 5911.2 5914.7 5939.4 5949.0 5958.4 5407.8 5616.9 5619.0 5624.4 5631.8 6630.0 6635.4 6642.3 6649.4 6659.8 4689.1 4691.0 4694.2 4694.5 4696.5 6693.9 6872.5 6941.4 6945.7 6961.4 4659.3 4685.6 4693.7 4698.3 4704.0 4726.9 4733.7 4740.0 4743.1 4748.3 5480.8 5506.6 5513.8 5514.0 5525.2 6470.5 6594.6 6628.2 6647.9 6674.1 1655.2 1670.2 1729.7 1731.1 1739.2 1155.2 1170.1 1171.8 1173.0 1177.6 6230.5 6282.1 6301.6 6303.6 6326.3 6741.2 6761.7 6771.1 6776.3 6782.7 6131.7 6284.5 6286.4 6296.8 6299.1 3663.6 3681.5 3686.7 3693.4 3701.4 7086.4 7095.4 7096.6 7112.3 7130.8 6870.5 6968.2 6983.6 6986.8 7025.9 7180.6 7183.8 7232.5 7254.3 7274.6 6890.9 6897.6 6905.6 6918.7 6928.7 6764.8 6773.5 6823.4 6853.2 6876.3 7211.5 7221.4 7223.2 7227.4 7252.3 4679.2 4710.9 4713.4 4717.5 4744.5 6771.7 6912.5 6921.6 6932.9 6989.0 6721.4 6731.2 6741.4 6747.4 6747.8 6669.9 6707.6 6741.3 6753.4 6759.0 6444.9 6557.4 6612.6 6619.2 6620.4 6745.4 6754.5 6759.8 6773.1 6777.6 6560.6 6605.8 6608.1 6608.8 6612.7 10:20:49 INFO - PROCESS | 10576 | 10:20:49 INFO - PROCESS | 10576 | [#5] yui.html Cycles:180 Average:13555.37 Median:51854.85 stddev:15997.44 (30.9%) stddev-sans-first:16013.27 10:20:49 INFO - PROCESS | 10576 | Values: 717.7 755.6 764.4 789.7 813.2 13214.9 13223.7 13248.4 13321.2 13340.7 12096.3 12103.9 12185.9 12200.1 12200.2 664.1 679.2 787.4 800.8 805.6 803.7 807.8 814.4 814.9 817.4 847.5 851.8 851.9 852.0 855.8 844.1 844.2 845.6 846.8 850.1 629.4 630.1 630.8 631.4 632.5 12116.8 12262.5 12280.1 12291.4 12877.8 12700.6 12942.2 13232.7 13399.7 13497.6 9493.4 9545.6 9862.5 9871.8 9985.4 3505.3 3597.2 3599.3 3616.5 3618.9 46174.5 46215.8 46282.1 46490.0 46501.8 9264.2 9647.8 9669.3 9989.4 10083.5 17733.1 17734.9 17740.1 17745.9 17786.3 7066.0 7119.0 7132.1 7133.7 7201.9 4117.4 4135.0 4153.4 4178.7 4228.9 3067.3 3081.4 3084.1 3087.7 3103.8 537.4 552.3 566.1 577.4 583.3 560.0 570.3 588.9 591.4 600.8 7709.2 8385.0 8574.2 8627.8 8987.5 528.8 545.4 559.7 566.2 628.7 3822.4 4060.9 4147.5 4177.1 4323.5 57505.0 58525.4 58835.4 58844.7 58881.1 51206.5 51510.0 51626.2 52083.5 52184.5 46599.8 46770.8 47090.3 47101.5 47573.0 8255.3 8302.7 8395.3 8530.4 8715.0 33318.0 33905.8 33976.7 33992.3 34038.1 41181.6 45244.0 45784.5 45854.0 46029.5 9306.3 9933.4 9947.9 10148.4 10247.8 10615.6 10818.2 10845.1 11113.8 11343.9 10998.5 11097.9 11150.9 11200.9 11659.8 10764.9 10978.9 11107.8 11371.7 11439.7 10524.6 10655.6 10922.8 10933.1 10989.8 8715.3 8778.0 8901.2 9072.2 9167.6 8796.6 9188.9 9281.9 9398.0 9655.1 10:20:49 INFO - PROCESS | 10576 | -------- Summary: end -------- 10:20:49 INFO - PROCESS | 10576 | 10:20:50 INFO - TEST-INFO | 10576: exit 0 10:20:50 INFO - TEST-OK | dromaeo_css | took 1111127ms 10:20:50 INFO - TEST-START | kraken 10:20:50 INFO - operating with platform_type : linux_ 10:20:50 INFO - Initialising browser for kraken test... 10:20:50 INFO - TEST-INFO | started process 10820 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuxjlZf/profile http://localhost:38425/getInfo.html) 10:20:54 INFO - PROCESS | 10820 | 10:20:54 INFO - PROCESS | 10820 | (process:10895): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:54 INFO - PROCESS | 10820 | __metrics Screen width/height:1600/1200 10:20:54 INFO - PROCESS | 10820 | colorDepth:24 10:20:54 INFO - PROCESS | 10820 | Browser inner width/height: 1024/697 10:20:54 INFO - PROCESS | 10820 | __metrics 10:20:55 INFO - PROCESS | 10820 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:20:55 INFO - TEST-INFO | 10820: exit 0 10:20:55 INFO - Browser initialized. 10:20:55 INFO - Running cycle 1/1 for kraken test... 10:20:55 INFO - TEST-INFO | started process 10944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuxjlZf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:57 INFO - PROCESS | 10944 | 10:20:57 INFO - PROCESS | 10944 | (process:11003): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:21:07 INFO - PROCESS | 10944 | RSS: Main: 150634496 10:21:07 INFO - PROCESS | 10944 | 10:21:10 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38425/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:10 INFO - PROCESS | 10944 | RSS: Main: 151359488 10:21:10 INFO - PROCESS | 10944 | 10:21:13 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38425/tests/kraken/driver.html?testName=audio-dft) 10:21:14 INFO - PROCESS | 10944 | RSS: Main: 154836992 10:21:14 INFO - PROCESS | 10944 | 10:21:16 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38425/tests/kraken/driver.html?testName=audio-fft) 10:21:17 INFO - PROCESS | 10944 | RSS: Main: 148877312 10:21:17 INFO - PROCESS | 10944 | 10:21:19 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38425/tests/kraken/driver.html?testName=audio-oscillator) 10:21:20 INFO - PROCESS | 10944 | RSS: Main: 149475328 10:21:20 INFO - PROCESS | 10944 | 10:21:22 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:23 INFO - PROCESS | 10944 | RSS: Main: 149991424 10:21:23 INFO - PROCESS | 10944 | 10:21:26 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38425/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:26 INFO - PROCESS | 10944 | RSS: Main: 149331968 10:21:26 INFO - PROCESS | 10944 | 10:21:30 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38425/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:30 INFO - PROCESS | 10944 | RSS: Main: 149782528 10:21:30 INFO - PROCESS | 10944 | 10:21:33 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38425/tests/kraken/driver.html?testName=json-parse-financial) 10:21:34 INFO - PROCESS | 10944 | RSS: Main: 150028288 10:21:34 INFO - PROCESS | 10944 | 10:21:35 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:36 INFO - PROCESS | 10944 | RSS: Main: 149741568 10:21:36 INFO - PROCESS | 10944 | 10:21:38 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:38 INFO - PROCESS | 10944 | RSS: Main: 149401600 10:21:38 INFO - PROCESS | 10944 | 10:21:40 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:41 INFO - PROCESS | 10944 | RSS: Main: 150118400 10:21:41 INFO - PROCESS | 10944 | 10:21:43 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:44 INFO - PROCESS | 10944 | RSS: Main: 150302720 10:21:44 INFO - PROCESS | 10944 | 10:21:46 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:47 INFO - PROCESS | 10944 | RSS: Main: 150175744 10:21:47 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | Cycle 1(1): loaded http://localhost:38425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38425/tests/kraken/driver.html?testName=ai-astar) 10:21:49 INFO - PROCESS | 10944 | RSS: Main: 150413312 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | __start_tp_report 10:21:49 INFO - PROCESS | 10944 | _x_x_mozilla_page_load 10:21:49 INFO - PROCESS | 10944 | _x_x_mozilla_page_load_details 10:21:49 INFO - PROCESS | 10944 | |i|pagename|runs| 10:21:49 INFO - PROCESS | 10944 | |0;ai-astar;113;108;112;110;110;122;110;111;110;110 10:21:49 INFO - PROCESS | 10944 | |1;audio-beat-detection;152;124;153;172;129;153;153;129;161;126 10:21:49 INFO - PROCESS | 10944 | |2;audio-dft;161;163;162;167;161;162;161;166;170;163 10:21:49 INFO - PROCESS | 10944 | |3;audio-fft;73;71;73;71;74;127;73;74;72;72 10:21:49 INFO - PROCESS | 10944 | |4;audio-oscillator;96;98;144;97;96;97;148;95;96;139 10:21:49 INFO - PROCESS | 10944 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;110 10:21:49 INFO - PROCESS | 10944 | |6;imaging-darkroom;146;147;145;148;147;146;147;147;146;147 10:21:49 INFO - PROCESS | 10944 | |7;imaging-desaturate;97;96;96;98;97;97;96;97;96;97 10:21:49 INFO - PROCESS | 10944 | |8;json-parse-financial;60;60;59;58;60;62;59;61;62;56 10:21:49 INFO - PROCESS | 10944 | |9;json-stringify-tinderbox;66;71;67;67;67;69;67;67;68;67 10:21:49 INFO - PROCESS | 10944 | |10;stanford-crypto-aes;83;83;83;82;83;82;82;83;83;84 10:21:49 INFO - PROCESS | 10944 | |11;stanford-crypto-ccm;116;128;122;121;122;123;132;123;123;115 10:21:49 INFO - PROCESS | 10944 | |12;stanford-crypto-pbkdf2;134;158;137;149;139;134;140;140;156;136 10:21:49 INFO - PROCESS | 10944 | |13;stanford-crypto-sha256-iterative;77;69;68;69;68;67;67;68;77;67 10:21:49 INFO - PROCESS | 10944 | __end_tp_report 10:21:49 INFO - PROCESS | 10944 | __start_cc_report 10:21:49 INFO - PROCESS | 10944 | _x_x_mozilla_cycle_collect,746 10:21:49 INFO - PROCESS | 10944 | __end_cc_report 10:21:49 INFO - PROCESS | 10944 | __startTimestamp1452882109517__endTimestamp 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | ------- Summary: start ------- 10:21:49 INFO - PROCESS | 10944 | Number of tests: 14 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#0] ai-astar Cycles:10 Average:111.60 Median:110.50 stddev:3.89 (3.5%) stddev-sans-first:4.10 10:21:49 INFO - PROCESS | 10944 | Values: 113.0 108.0 112.0 110.0 110.0 122.0 110.0 111.0 110.0 110.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.00 stddev:16.80 (11.0%) stddev-sans-first:17.64 10:21:49 INFO - PROCESS | 10944 | Values: 152.0 124.0 153.0 172.0 129.0 153.0 153.0 129.0 161.0 126.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.06 (1.9%) stddev-sans-first:3.10 10:21:49 INFO - PROCESS | 10944 | Values: 161.0 163.0 162.0 167.0 161.0 162.0 161.0 166.0 170.0 163.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#3] audio-fft Cycles:10 Average:78.00 Median:73.00 stddev:17.25 (23.6%) stddev-sans-first:18.20 10:21:49 INFO - PROCESS | 10944 | Values: 73.0 71.0 73.0 71.0 74.0 127.0 73.0 74.0 72.0 72.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:22.93 (23.9%) stddev-sans-first:23.71 10:21:49 INFO - PROCESS | 10944 | Values: 96.0 98.0 144.0 97.0 96.0 97.0 148.0 95.0 96.0 139.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:21:49 INFO - PROCESS | 10944 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 10:21:49 INFO - PROCESS | 10944 | Values: 146.0 147.0 145.0 148.0 147.0 146.0 147.0 147.0 146.0 147.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 10:21:49 INFO - PROCESS | 10944 | Values: 97.0 96.0 96.0 98.0 97.0 97.0 96.0 97.0 96.0 97.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.83 (3.0%) stddev-sans-first:1.94 10:21:49 INFO - PROCESS | 10944 | Values: 60.0 60.0 59.0 58.0 60.0 62.0 59.0 61.0 62.0 56.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 10:21:49 INFO - PROCESS | 10944 | Values: 66.0 71.0 67.0 67.0 67.0 69.0 67.0 67.0 68.0 67.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 10:21:49 INFO - PROCESS | 10944 | Values: 83.0 83.0 83.0 82.0 83.0 82.0 82.0 83.0 83.0 84.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.00 stddev:4.97 (4.0%) stddev-sans-first:4.68 10:21:49 INFO - PROCESS | 10944 | Values: 116.0 128.0 122.0 121.0 122.0 123.0 132.0 123.0 123.0 115.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:140.00 stddev:8.86 (6.3%) stddev-sans-first:8.87 10:21:49 INFO - PROCESS | 10944 | Values: 134.0 158.0 137.0 149.0 139.0 134.0 140.0 140.0 156.0 136.0 10:21:49 INFO - PROCESS | 10944 | 10:21:49 INFO - PROCESS | 10944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:68.50 stddev:3.92 (5.7%) stddev-sans-first:3.14 10:21:49 INFO - PROCESS | 10944 | Values: 77.0 69.0 68.0 69.0 68.0 67.0 67.0 68.0 77.0 67.0 10:21:49 INFO - PROCESS | 10944 | -------- Summary: end -------- 10:21:49 INFO - PROCESS | 10944 | 10:21:50 INFO - TEST-INFO | 10944: exit 0 10:21:50 INFO - TEST-OK | kraken | took 60018ms 10:21:50 INFO - TEST-START | v8_7 10:21:50 INFO - operating with platform_type : linux_ 10:21:50 INFO - Initialising browser for v8_7 test... 10:21:50 INFO - TEST-INFO | started process 11231 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn4I5w6/profile http://localhost:38425/getInfo.html) 10:21:54 INFO - PROCESS | 11231 | 10:21:54 INFO - PROCESS | 11231 | (process:11301): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:21:55 INFO - PROCESS | 11231 | __metrics Screen width/height:1600/1200 10:21:55 INFO - PROCESS | 11231 | colorDepth:24 10:21:55 INFO - PROCESS | 11231 | Browser inner width/height: 1024/697 10:21:55 INFO - PROCESS | 11231 | __metrics 10:21:55 INFO - PROCESS | 11231 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:21:56 INFO - TEST-INFO | 11231: exit 0 10:21:56 INFO - Browser initialized. 10:21:56 INFO - Running cycle 1/1 for v8_7 test... 10:21:56 INFO - TEST-INFO | started process 11350 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn4I5w6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:57 INFO - PROCESS | 11350 | 10:21:57 INFO - PROCESS | 11350 | (process:11411): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:22:07 INFO - PROCESS | 11350 | RSS: Main: 151347200 10:22:07 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | Cycle 1(1): loaded http://localhost:38425/tests/v8_7/run.html (next: http://localhost:38425/tests/v8_7/run.html) 10:22:30 INFO - PROCESS | 11350 | RSS: Main: 147144704 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | __start_tp_report 10:22:30 INFO - PROCESS | 11350 | _x_x_mozilla_page_load 10:22:30 INFO - PROCESS | 11350 | _x_x_mozilla_page_load_details 10:22:30 INFO - PROCESS | 11350 | |i|pagename|runs| 10:22:30 INFO - PROCESS | 11350 | |0;Richards;167.5603217158177 10:22:30 INFO - PROCESS | 11350 | |1;DeltaBlue;188.14675446848543 10:22:30 INFO - PROCESS | 11350 | |2;Encrypt;280.19052956010086 10:22:30 INFO - PROCESS | 11350 | |3;Decrypt;5229.166666666667 10:22:30 INFO - PROCESS | 11350 | |4;RayTrace;1101.3215859030836 10:22:30 INFO - PROCESS | 11350 | |5;Earley;703.7297677691766 10:22:30 INFO - PROCESS | 11350 | |6;Boyer;12207.317073170732 10:22:30 INFO - PROCESS | 11350 | |7;RegExp;41469.38775510204 10:22:30 INFO - PROCESS | 11350 | |8;Splay;605.4054054054054 10:22:30 INFO - PROCESS | 11350 | |9;NavierStokes;4835.748792270531 10:22:30 INFO - PROCESS | 11350 | __end_tp_report 10:22:30 INFO - PROCESS | 11350 | __startTimestamp1452882150515__endTimestamp 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | ------- Summary: start ------- 10:22:30 INFO - PROCESS | 11350 | Number of tests: 10 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 167.6 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 188.1 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 280.2 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 5229.2 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#4] RayTrace Cycles:1 Average:1101.32 Median:1101.32 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 1101.3 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 703.7 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 12207.3 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#7] RegExp Cycles:1 Average:41469.39 Median:41469.39 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 41469.4 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#8] Splay Cycles:1 Average:605.41 Median:605.41 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 605.4 10:22:30 INFO - PROCESS | 11350 | 10:22:30 INFO - PROCESS | 11350 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:22:30 INFO - PROCESS | 11350 | Values: 4835.7 10:22:30 INFO - PROCESS | 11350 | -------- Summary: end -------- 10:22:30 INFO - PROCESS | 11350 | 10:22:31 INFO - TEST-INFO | 11350: exit 0 10:22:31 INFO - TEST-OK | v8_7 | took 40960ms 10:22:31 INFO - SUITE-END | took 1212s 10:22:31 INFO - Completed test suite (00:20:12) 10:22:31 INFO - Working with test: dromaeo_css 10:22:31 INFO - Generating results file: dromaeo_css 10:22:31 INFO - Working with test: kraken 10:22:31 INFO - Generating results file: kraken 10:22:31 INFO - javascript benchmark 10:22:31 INFO - Working with test: v8_7 10:22:31 INFO - Generating results file: v8_7 10:22:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 10:22:31 INFO - process_Request line: dromaeo_css 6962.66 graph.html#tests=[[72,1,43]] 10:22:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:31 INFO - process_Request line: kraken 1506.90 graph.html#tests=[[232,1,43]] 10:22:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:22:31 INFO - process_Request line: v8_7 20306.65 graph.html#tests=[[230,1,43]] 10:22:31 INFO - RETURN: dromaeo_css: 6962.66 10:22:31 INFO - RETURN: kraken: 1506.90 10:22:31 INFO - RETURN: v8_7: 20306.65 10:22:31 INFO - javascript benchmark 10:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3292.539044533767, 3294.2093897464606, 3315.0883507035564, 3330.6169790474073, 3344.1138098403926, 5370.91943620845, 5373.838784836461, 5400.0, 5418.40397556269, 5432.809851655193, 5410.161424979125, 5415.593830462712, 5504.80733174339, 5531.197976293435, 5583.748731307091, 4973.179425394815, 5000.549950504454, 5075.746212689369, 5077.796888124471, 5084.4661310562415, 5071.644984851062, 5072.112380333427, 5142.845714628548, 5143.639945203838, 5148.922766158511, 4887.14474966883, 4907.460179380283, 4949.653524253304, 4970.726610036447, 4983.551480366748, 5037.143685573461, 5051.772670229849, 5051.797928082872, 5062.063518249099, 5064.037832811754, 5003.324551185579, 5028.522290382408, 5030.220315851049, 5040.873978150539, 5047.798088076509, 5223.981323641891, 5236.8690782730355, 5298.443663415324, 5302.0721373759825, 5343.118385466393, 5852.034414321632, 5853.414658534155, 5873.383294754032, 5876.265466816648, 5877.265341832271, 5931.495822855062, 5938.435848594377, 5941.2276404067625, 5946.316173640001, 5947.10793380992, 5445.809396671137, 5504.311961004874, 5543.113101903717, 5605.467480589419, 5651.463111004448, 5859.384764599656, 5907.0, 5926.377730338339, 5930.11048342752, 5956.255468066492, 5652.3217213934595, 5691.0, 5698.914516282176, 5704.971475142598, 5727.799527016535, 5791.710414479259, 5863.2670916135485, 5951.0, 5958.136070269787, 6001.849953751192, 5775.422457754191, 5821.76712931478, 5833.854153646193, 5834.299884013861, 5837.824865254049, 5746.88506229873, 5763.135529670583, 5801.7389217485315, 5827.4172582741385, 5829.708514574254, 4421.955780442218, 4439.733615983051, 4492.820287188541, 4495.775211239425, 4533.637309015271, 3948.861789837342, 3950.762954222756, 3958.762474251554, 3991.5808840071954, 3996.0, 5387.595930305243, 5388.084025715638, 5389.0, 5400.270963419966, 5413.702246376487, 5793.507551858055, 5863.149843272701, 5886.587938844325, 5893.6463812171405, 5957.910631340534, 5460.290162278958, 5465.207544906046, 5477.507024367826, 5484.725763711798, 5509.090999984957, 4878.170710979142, 4946.579540739005, 4958.628102892298, 4980.427250866197, 5031.82388616404, 6046.425589568984, 6107.938920610826, 6109.435031337442, 6109.550212586144, 6112.042504713611, 5805.535557155502, 5822.475977162076, 5827.59206855533, 5855.59010869235, 5881.735321910439, 5844.532437405082, 5962.493188079062, 6055.485283750931, 6055.576109672281, 6059.3637668045985, 5797.2173756542325, 5820.82537523875, 5823.475887170006, 5829.446202610745, 5880.441358071148, 5842.7662893485485, 5888.705564721832, 5918.3489816121055, 5929.199558059607, 5934.376890426615, 5612.045952188219, 5699.401562836008, 5758.568107392046, 5764.07774756037, 5765.7117144141785, 5739.053056245672, 5744.511716504144, 5746.798862039808, 5751.9137212941005, 5763.625364351304, 5579.079451890392, 5590.580706447114, 5608.551315894637, 5608.635438696471, 5624.072028115315, 5537.667739935617, 5670.74481648335, 5699.686517241592, 5709.286339207599, 5752.827415177551, 5655.0, 5659.434056594308, 5659.830205093854, 5663.971680141738, 5666.603337766317], "unit": "score", "name": "dojo.html", "value": 5397.581345866448}, {"lowerIsBetter": false, "replicates": [536.5546596325049, 544.1103795294697, 546.8386825886363, 558.260305095748, 592.5526227698084, 37330.81334593327, 37647.0, 37794.8110259449, 37955.0, 37996.0, 40403.59596404035, 40858.795706021425, 40927.38608920861, 41015.79492102543, 41080.79459602698, 8383.455075420108, 8560.229579337858, 8604.053554109043, 8609.096044915288, 8659.870101948476, 8392.496450212977, 8444.0289366723, 8483.321334293241, 8484.872726909101, 8525.403221774479, 8623.09457506959, 8647.394682372236, 8668.39321247513, 8734.388592798507, 8759.0, 8590.355723320776, 8649.394542382035, 8664.350173736995, 8684.305255579538, 8698.304135669132, 8437.451565648213, 8546.2308392245, 8576.05663377028, 8625.525596092213, 8647.740567782914, 38372.232555349015, 38612.80693596542, 38666.806665966775, 38749.61250387516, 38807.0, 3250.593675790526, 3260.2990357073104, 3401.795892246473, 3699.278640665071, 4007.7996100195164, 29423.558646620317, 29860.253493662614, 29890.70109298901, 31668.683313167036, 31670.366592668248, 3449.844756985942, 3468.0982944434627, 3493.807840568768, 3526.4886591444097, 3607.404778211618, 205489.0, 205898.0, 205988.0, 206006.0, 207208.96395518078, 57430.0, 57445.71277143671, 57567.0, 57655.71172144113, 57701.0, 60892.39107608956, 64939.67530162319, 65602.0, 65624.67187664127, 65713.6714316435, 13978.580642580739, 14157.646058848612, 14177.22025288619, 14192.787108193384, 14217.715645687029, 10432.217583681255, 10458.163346932228, 10463.319884207502, 10476.842847357295, 10529.10502607287, 19487.317943871898, 19952.600947980958, 19971.301004464774, 19973.300934467516, 20047.799522004883, 7788.14330423653, 7798.454108212484, 7964.0, 7996.200379962073, 8110.0, 871.904090550039, 928.6331898899897, 951.1962391778935, 1035.6427032673716, 1036.4972988100765, 30697.846510767304, 31630.209244769067, 31984.520232196537, 32024.199395015312, 32593.0, 1001.6994901529512, 1026.6714651311659, 1028.4240825137947, 1088.0262165361958, 1131.5982826096617, 15195.620109497351, 15260.618484537754, 15408.152551609544, 15469.613259668598, 15887.761683574756, 392703.0, 396353.0, 397232.0, 397800.0, 397981.0, 54893.451065488836, 55227.0, 55291.44708552863, 55331.0, 55352.0, 1301.2322729589587, 1303.9739205215842, 1316.4207748590588, 1321.0, 1323.8146659467682, 28971.855140725005, 29288.70711292945, 29319.853400733715, 29684.703152968195, 29941.251468712584, 46177.538224617325, 46365.768171158925, 46474.0, 46630.76684616555, 46703.53296466992, 286687.0, 286984.0, 287218.150366468, 287546.0, 288355.0, 32844.507332389556, 43632.34551481667, 43679.78160109179, 44639.0, 44762.3285650722, 40509.59490405176, 40515.0, 41046.0, 41645.37531937084, 46134.0, 35633.0, 36079.842575105904, 36222.01557828584, 36974.26051479009, 37580.2483950314, 37011.44482832814, 39142.412863806494, 40207.396889046104, 40944.795276023426, 42758.57241427671, 36924.44613330749, 38296.2340753189, 39387.2122557553, 39533.0, 39647.2070558593, 28899.566506502, 31401.68598314079, 32211.0, 32325.51511727279, 34190.82904585461, 25076.0, 25227.49545009126, 25652.35869103213, 26045.609315860656, 27302.31744206331], "unit": "score", "name": "ext.html", "value": 18580.199396187905}, {"lowerIsBetter": false, "replicates": [365.14555939102513, 366.24370674557036, 368.3939918833518, 368.5742966873261, 371.1852483798064, 15527.378904843807, 16860.83139168608, 17137.0, 17719.55701107473, 18149.818501814978, 11041.227114102016, 11535.538578456852, 16500.17499125045, 16516.917415412936, 16614.501564953072, 4940.258961155829, 5482.862928426782, 5542.057850165482, 5542.528885044776, 5568.66588004719, 4468.3074123510905, 5047.343845300106, 5433.293671822657, 5482.533984611313, 5503.20203570482, 5022.5730812880765, 5026.698398096108, 5045.520675535837, 5264.6051546134, 5280.313559237294, 5163.302954101205, 5230.267762513251, 5275.577953763709, 5285.6300058995885, 5580.107182850725, 5366.517013468807, 5384.138537833927, 5399.784008639689, 5400.216968539579, 5404.486573775485, 14498.637534061732, 19500.0, 20263.696044559343, 20415.591688166154, 20455.5908881823, 1963.1264087481077, 2029.6143732690741, 2084.176750183669, 2090.6131767450433, 2098.380977611608, 9458.52707364629, 10530.31552949056, 12799.168054076456, 12939.741205175938, 13024.283664398454, 1776.4759395978217, 1831.3123576281455, 1832.175521015535, 1864.1983946902826, 1879.2764785557658, 55251.44748552544, 55687.443125569036, 55895.161572576035, 57319.42680573224, 57853.71073144607, 9653.613855445845, 10022.198224142052, 10152.492375381202, 10168.186545076376, 10175.084242418217, 13124.606261812161, 13162.407691653898, 13269.800952985714, 13303.002274829427, 13316.533921312901, 6834.419074378634, 6855.108835851307, 6869.622170780655, 7059.329363710439, 7176.0, 6466.870662586722, 6634.137562116894, 6790.5925644461495, 6799.864002719918, 6854.34883686049, 4298.183345164409, 4406.228909940747, 4446.799894004777, 4447.755373454426, 4481.529439408815, 1721.340528882879, 1773.5034190426702, 1778.2531336838558, 1810.5654642885877, 1815.972760408595, 822.5681517203516, 893.6023469555985, 896.4755617963565, 962.5331714118647, 1005.8893521712606, 15522.689546209012, 15940.963837350535, 16150.515484535483, 16395.672086558203, 16661.91669041647, 831.7296878514506, 845.6955496021427, 861.6897916749965, 875.6935072724496, 925.1303774451993, 7356.337929586363, 9622.759431014281, 9631.855522167172, 9646.324757266924, 9748.415095094317, 474596.0, 481667.0, 501817.0, 506146.0, 513326.0, 66631.66684166549, 69417.30582694108, 69510.65244673744, 70861.6456917712, 73201.0, 1128.2158899564724, 1159.7390587118, 1162.3607016141257, 1169.2107827216764, 1170.7131752720638, 15034.774478383051, 15239.847601523843, 15357.769633455731, 15428.151451670266, 15830.762538561701, 32256.677433225366, 32768.836155819066, 33098.338033239685, 33169.170770730925, 33393.0, 41478.79260603798, 42848.57151428446, 42886.78556607322, 43205.0, 43453.56546434622, 6936.7225310987, 7121.0, 7269.890951635624, 7491.625418728932, 7497.62511874415, 9579.281553883626, 10727.249092563447, 11477.196596238184, 11660.358680272328, 11751.47118379692, 8772.517511536927, 9347.953260233655, 9452.723882275804, 9464.858027129461, 9511.524423778921, 9010.729678109667, 9516.666916657883, 9685.225181985565, 9973.750656233653, 10033.297669163088, 9920.75198120024, 10017.298789084694, 10133.493325333851, 10328.690139295833, 10334.0, 7314.561126332437, 7532.623368831427, 7569.848603028019, 7584.772456826304, 7607.695692172472, 8670.30637548982, 10023.799524009624, 10026.248031397528, 10214.540345684314, 10256.38461692301], "unit": "score", "name": "jquery.html", "value": 8089.190183171173}, {"lowerIsBetter": false, "replicates": [1476.37254166979, 1499.5726218027864, 1677.412905483081, 1732.0733407626922, 1817.2004318100035, 7848.4113691473085, 7933.087694915086, 8036.638351274192, 8072.031356237259, 8079.596020198988, 8043.6380362883665, 8093.595320233994, 8156.592170391472, 8164.591770411471, 8171.713990010351, 2389.247387073075, 2432.0, 2440.3045132137345, 2447.7674620911075, 2449.6937882764655, 2401.0, 2417.2748175547354, 2443.7922776564014, 2445.6576079348906, 2446.902123915041, 2335.4628435459854, 2370.5851475991717, 2387.85672859629, 2397.077125306752, 2406.362313986795, 2395.1257790906366, 2416.5891798394314, 2424.3454267347806, 2426.065964603623, 2429.1012325439524, 2429.975700242993, 2435.8173137014796, 2443.1571107967725, 2446.2905757330354, 2451.8161137914726, 8049.235322644339, 8075.838483230303, 8092.554909479976, 8094.0, 8104.594770261463, 4935.70385776851, 5002.0, 5015.899682006339, 5027.622928280357, 5034.823781167678, 3293.8965446575426, 3412.5904891412943, 3414.6756058174433, 3422.110251334671, 3480.4953281774256, 1059.5602824827688, 1079.5465904320204, 1099.8625171853519, 1102.3000394749392, 1153.7692461507647, 10619.203559732974, 10696.732581685443, 10710.785784284348, 10711.089557387553, 10722.249442538947, 4239.554846741109, 4333.609975102256, 4338.110687309094, 4394.428724265825, 4506.481754598198, 8722.25860801839, 8789.780255493535, 8795.340349473816, 8812.854328937325, 8818.0, 4891.26631005352, 4902.044101400193, 4915.778789954461, 4918.9508104919205, 4956.529129732669, 4519.570640789119, 4525.185466616041, 4546.613537849254, 4551.2717965126085, 4583.312503124558, 3609.3864043112735, 3660.9816950915074, 3673.4673472346362, 3678.3746763050344, 3693.926121477555, 1055.5091882274778, 1106.5352551928208, 1120.4957769003818, 1126.0822429719751, 1137.7440075983004, 1053.5311786255043, 1112.8275117356823, 1165.4289398194824, 1231.7105480212142, 1327.1108357400565, 7333.230010848891, 7336.926630733731, 7377.594232317167, 7388.371988381048, 7455.85088298231, 620.5904103291806, 630.1618846933567, 633.8542135308904, 640.1549954060596, 771.2981187119694, 5492.5605951523785, 5581.134924086773, 5597.048501754712, 5617.691026993554, 5714.142878568248, 9646.469444180637, 9956.352837065568, 9960.352577082467, 10057.949710251401, 10084.394936303845, 9763.560639771227, 9852.113309802153, 9973.052560006789, 9989.95105513925, 10050.0, 7693.384529237647, 7698.42261830365, 7792.376609871197, 7819.218078192135, 7848.058233012075, 7284.854302913806, 7375.483716139819, 7505.286997735207, 7524.510906791041, 7546.886796698163, 8271.875921861056, 8444.535550544533, 8638.611262493328, 8872.112788721077, 9063.90936090657, 8557.914420855712, 8613.26787223093, 8655.264302534355, 8752.387332886638, 8794.472331660121, 6878.55289406187, 7207.243239459991, 7250.093738282715, 7295.927040729524, 7316.707331706672, 7427.4800763946005, 7505.587192704235, 7527.924720752722, 7549.811254718676, 7550.5469671819865, 6456.289808121197, 7059.647017649199, 7145.606991615511, 7150.713971441084, 7274.199838017919, 6941.652917354011, 7029.015937768614, 7053.506254562131, 7135.785926422215, 7281.017062696468, 7213.1704853942465, 7283.890741638986, 7292.197858235696, 7299.0, 7308.415326773739, 6386.297507274289, 6386.489080873426, 6406.263279722705, 6413.326600706859, 6413.775517856852, 6350.0, 6414.807555773335, 6420.743170273324, 6426.003969384753, 6426.518011149089], "unit": "score", "name": "mootools.html", "value": 4565.602460224344}, {"lowerIsBetter": false, "replicates": [336.67510852027794, 348.25647243135904, 351.9331327047861, 358.2905846424082, 360.6411620437663, 6104.755809767615, 6207.627542347456, 6231.6884155792195, 6232.096346029823, 6261.749530018805, 6086.330503644595, 6181.969090154555, 6183.628982261068, 6197.163382943301, 6228.626282423058, 4823.614110871122, 4825.083234185494, 4836.395450568679, 4836.6856154350035, 4837.467878533358, 4799.928001079987, 4806.110869489138, 4825.131476334259, 4825.541573550507, 4841.2012018016985, 4713.717176969393, 4795.568398844103, 4805.255185446262, 4806.0, 4809.615230781529, 4776.761161941907, 4781.187198176319, 4793.7363445010515, 4797.30439086334, 4798.5201479852085, 4202.075543380452, 4223.957760422418, 4224.429701990222, 4224.619784219435, 4227.408162857202, 5911.231539899829, 5914.674692891889, 5939.4357536034, 5948.97025514874, 5958.40415958405, 5407.810726624549, 5616.943830561683, 5619.0, 5624.397046841671, 5631.831045068655, 6630.038644396535, 6635.369639884203, 6642.302558231413, 6649.368310010541, 6659.833504162386, 4689.062187562501, 4690.9530904690855, 4694.178518759203, 4694.530546945312, 4696.459907110692, 6693.933060669428, 6872.450203983669, 6941.444684425284, 6945.652717364112, 6961.373476387099, 4659.347691323217, 4685.648576356787, 4693.741844198602, 4698.271767875985, 4703.95296047042, 4726.858194254178, 4733.668643194943, 4739.95260047402, 4743.0988112258565, 4748.287756836433, 5480.808171713971, 5506.64206826555, 5513.807016754395, 5514.035043867307, 5525.171224316385, 6470.514711396664, 6594.637294948824, 6628.204615446178, 6647.933520664828, 6674.098996635489, 1655.213773457598, 1670.189957870456, 1729.7405389191722, 1731.1171302635494, 1739.1738924011247, 1155.2433156282648, 1170.0931777872047, 1171.812509998396, 1173.0146676791367, 1177.587844254521, 6230.532710046765, 6282.089097080898, 6301.558890877686, 6303.590266632654, 6326.2724786649205, 6741.224759152662, 6761.661916904135, 6771.052052712625, 6776.322367763184, 6782.694778734969, 6131.662758548323, 6284.497240220771, 6286.371362863677, 6296.779612713533, 6299.055141728777, 3663.578688450862, 3681.4537894084547, 3686.668199862025, 3693.3905905525826, 3701.3892707702926, 7086.397656199178, 7095.361417472453, 7096.574205547684, 7112.25321341262, 7130.750423735144, 6870.484713646497, 6968.1638203414905, 6983.580985140908, 6986.790396288119, 7025.89461158083, 7180.640967951582, 7183.784486465414, 7232.45756568249, 7254.310840470147, 7274.599897005715, 6890.896636550356, 6897.586144831326, 6905.551139175937, 6918.688659010256, 6928.722851086101, 6764.76568815615, 6773.491988100814, 6823.351781580742, 6853.211880633591, 6876.277990811093, 7211.531250468703, 7221.4222862171955, 7223.205447400886, 7227.421806255382, 7252.347288744038, 4679.227927391942, 4710.905781884411, 4713.363695901009, 4717.528247175255, 4744.478107408251, 6771.695273712793, 6912.4815638828295, 6921.550099243533, 6932.93067069343, 6989.0, 6721.361470660279, 6731.1922569292, 6741.393274605309, 6747.392734653905, 6747.831304217434, 6669.933300667125, 6707.564008339442, 6741.325867413416, 6753.3921947025, 6758.966205168943, 6444.871102577828, 6557.442617377576, 6612.636305003271, 6619.172603424572, 6620.404163625297, 6745.426638735762, 6754.459643228432, 6759.763408280686, 6773.085633439423, 6777.559458635173, 6560.639164845788, 6605.801825945229, 6608.107905432705, 6608.768693095719, 6612.70242839083], "unit": "score", "name": "prototype.html", "value": 5029.614070539085}, {"lowerIsBetter": false, "replicates": [717.7308509309009, 755.6297414267011, 764.4152223548986, 789.6959670526848, 813.2384886489604, 13214.867851321496, 13223.735525289489, 13248.403821828017, 13321.20072795633, 13340.7331853363, 12096.33470159141, 12103.878961210385, 12185.878141218585, 12200.084993625469, 12200.206986545869, 664.0636702249828, 679.222290477403, 787.3937068457284, 800.75977206838, 805.5851236613149, 803.7428023032631, 807.8263173417714, 814.3566582399897, 814.8533264012475, 817.3665409307804, 847.4957400346815, 851.812601227732, 851.9190676885717, 852.0074113657613, 855.7518319687283, 844.0757370679097, 844.1558441558442, 845.5814371885925, 846.8221673448584, 850.1286181663813, 629.4240769695723, 630.0612087988864, 630.8139098965817, 631.3749388105742, 632.4813652804702, 12116.81824772629, 12262.509499620004, 12280.07899407548, 12291.446884890112, 12877.806832897513, 12700.555480558229, 12942.223466592035, 13232.735345293137, 13399.732005359838, 13497.595072147851, 9493.43470278286, 9545.61817527305, 9862.50687465624, 9871.753206169831, 9985.350952188084, 3505.2638945821154, 3597.1546686528645, 3599.2981368633127, 3616.4936908832783, 3618.9276214475826, 46174.53825461736, 46215.76892115552, 46282.074358512975, 46490.0, 46501.76749116267, 9264.166225039779, 9647.758806029906, 9669.274804389559, 9989.350692204984, 10083.49582520871, 17733.11334433299, 17734.91132544329, 17740.11299435023, 17745.911270443565, 17786.288548458175, 7066.0, 7118.9644051779405, 7132.144142702805, 7133.7146514139895, 7201.855962880818, 4117.3618089195625, 4134.958650413518, 4153.439285696452, 4178.665706743514, 4228.936565951513, 3067.3098552825436, 3081.3683194944983, 3084.0901933929094, 3087.706667866549, 3103.844807759603, 537.3605409562608, 552.257214047106, 566.0575142387878, 577.3850848845966, 583.2505230778429, 559.963602365845, 570.3156212544963, 588.9499392551681, 591.4351794036685, 600.7747094839435, 7709.2290770922455, 8384.99380074395, 8574.185452382013, 8627.827443451095, 8987.505687187268, 528.7752705100394, 545.3782687735984, 559.7285316621435, 566.1592535085395, 628.7327885648673, 3822.3502004659276, 4060.939085913714, 4147.52303485097, 4177.122804211089, 4323.524412314643, 57505.0, 58525.414745852846, 58835.411645882996, 58844.705776470844, 58881.11678324828, 51206.487935120174, 51510.0, 51626.22560661593, 52083.47916520862, 52184.47815521796, 46599.76700116478, 46770.766146169735, 47090.293645595346, 47101.5289847104, 47573.04853902903, 8255.339572834278, 8302.6678932842, 8395.32837373021, 8530.360222983178, 8714.956425218086, 33318.00183977938, 33905.83047084749, 33976.66023339735, 33992.320153597284, 34038.14904627404, 41181.588184117776, 45244.0, 45784.54215457936, 45854.0, 46029.53970460386, 9306.255499560155, 9933.3543319684, 9947.88114711258, 10148.391096534231, 10247.795044099226, 10615.628453004108, 10818.1886358525, 10845.078168355778, 11113.777724445628, 11343.886561134283, 10998.505067272152, 11097.944510277719, 11150.888491114985, 11200.943995279971, 11659.825102623297, 10764.946175269073, 10978.890211097787, 11107.833382499108, 11371.715707107389, 11439.714007149887, 10524.631637892637, 10655.627053053106, 10922.836157457803, 10933.125349972142, 10989.780204396027, 8715.302775777796, 8778.0, 8901.198892099743, 9072.228860546664, 9167.633294668405, 8796.592545192738, 9188.862167067366, 9281.890014529516, 9397.953010234905, 9655.062534852315], "unit": "score", "name": "yui.html", "value": 6115.440286745708}], "name": "dromaeo_css", "value": 6962.659253825902}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 112.0, 110.0, 110.0, 122.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 153.0, 172.0, 129.0, 153.0, 153.0, 129.0, 161.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 167.0, 161.0, 162.0, 161.0, 166.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 71.0, 74.0, 127.0, 73.0, 74.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 78.0}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 144.0, 97.0, 96.0, 97.0, 148.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 98.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 59.0, 58.0, 60.0, 62.0, 59.0, 61.0, 62.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 82.0, 83.0, 82.0, 82.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [116.0, 128.0, 122.0, 121.0, 122.0, 123.0, 132.0, 123.0, 123.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [134.0, 158.0, 137.0, 149.0, 139.0, 134.0, 140.0, 140.0, 156.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [77.0, 69.0, 68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 77.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1506.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1101.3215859030836], "unit": "score", "name": "RayTrace", "value": 671.910012}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [41469.38775510204], "unit": "score", "name": "RegExp", "value": 21.96765009842518}, {"lowerIsBetter": false, "replicates": [605.4054054054054], "unit": "score", "name": "Splay", "value": 134.60566964285715}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20306.650966533107}]} 10:22:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20306.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1506.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6962.66"}}} 10:22:31 INFO - Return code: 0 10:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:22:31 INFO - # TBPL SUCCESS # 10:22:31 INFO - Running post-action listener: _resource_record_post_action 10:22:31 INFO - Running post-run listener: _resource_record_post_run 10:22:32 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 551440384; Read time: 0; Write time: 457220 10:22:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237051904; Read time: 0; Write time: 249648 10:22:33 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 314388480; Read time: 0; Write time: 207572 10:22:33 INFO - Running post-run listener: _upload_blobber_files 10:22:33 INFO - Blob upload gear active. 10:22:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:22:33 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 10:22:33 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 10:22:33 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 10:22:33 INFO - (blobuploader) - INFO - Open directory for files ... 10:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:34 INFO - (blobuploader) - INFO - Done attempting. 10:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:22:35 INFO - (blobuploader) - INFO - Done attempting. 10:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:22:35 INFO - Return code: 0 10:22:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6426392617e2ce2de4c7cd0e9577daf48a4b50145a5bcf40d7a61652e59bf086ba62cb07af3d12c82a865ecf5ad41949c9d6c9a3b797be8f75eabae0550dca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94a6b46f7b15107f54c2acd26d5c9df03189f310156c2d571601fb7ed2d7135ce2a46b36f63ca54854e6d0d0512e178b935f2b37deb01ba966904760567918c5"} 10:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:22:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:22:35 INFO - Contents: 10:22:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de6426392617e2ce2de4c7cd0e9577daf48a4b50145a5bcf40d7a61652e59bf086ba62cb07af3d12c82a865ecf5ad41949c9d6c9a3b797be8f75eabae0550dca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94a6b46f7b15107f54c2acd26d5c9df03189f310156c2d571601fb7ed2d7135ce2a46b36f63ca54854e6d0d0512e178b935f2b37deb01ba966904760567918c5"} 10:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:22:35 INFO - Copying logs to upload dir... 10:22:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.112523 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-15 10:22:35.473027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:35.477014) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 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/Firefox/sha512/de6426392617e2ce2de4c7cd0e9577daf48a4b50145a5bcf40d7a61652e59bf086ba62cb07af3d12c82a865ecf5ad41949c9d6c9a3b797be8f75eabae0550dca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94a6b46f7b15107f54c2acd26d5c9df03189f310156c2d571601fb7ed2d7135ce2a46b36f63ca54854e6d0d0512e178b935f2b37deb01ba966904760567918c5"} build_url:https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/fVQUjlT6Sz-V4BSOEOJ2PQ/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/Firefox/sha512/de6426392617e2ce2de4c7cd0e9577daf48a4b50145a5bcf40d7a61652e59bf086ba62cb07af3d12c82a865ecf5ad41949c9d6c9a3b797be8f75eabae0550dca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94a6b46f7b15107f54c2acd26d5c9df03189f310156c2d571601fb7ed2d7135ce2a46b36f63ca54854e6d0d0512e178b935f2b37deb01ba966904760567918c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:35.501518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:35.501865) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=574dc5aafe09851ec43d388c000001b6-1452880695.771204-1141127622 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 10:22:35.583312) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:22:35.583648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 10:22:35.583968) ========= ========= Total master_lag: 0.27 =========