builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1453715352.42 results: success (0) buildid: 20160124233013 builduid: cab3f576caa240559d79f9804a4afedc revision: e93a14409efe417a7fd132184780ae7192d68d7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.419808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.429105) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.429475) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.457146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.457521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.474595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.474869) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.523830) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.524111) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.524507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.524807) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 01:49:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.0M=0s 2016-01-25 01:49:12 (84.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161907 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.699270) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.699559) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.749002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:12.749362) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e93a14409efe417a7fd132184780ae7192d68d7d --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e93a14409efe417a7fd132184780ae7192d68d7d --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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 01:49:12,973 truncating revision to first 12 chars 2016-01-25 01:49:12,973 Setting DEBUG logging. 2016-01-25 01:49:12,973 attempt 1/10 2016-01-25 01:49:12,973 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e93a14409efe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 01:49:13,401 unpacking tar archive at: b2g-inbound-e93a14409efe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:13.470861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:13.471241) ========= echo e93a14409efe417a7fd132184780ae7192d68d7d in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e93a14409efe417a7fd132184780ae7192d68d7d'] 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e93a14409efe417a7fd132184780ae7192d68d7d program finished with exit code 0 elapsedTime=0.004642 script_repo_revision: 'e93a14409efe417a7fd132184780ae7192d68d7d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:13.522317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:13.522636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 01:49:13.532860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 01:49:13.533156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:49:13 INFO - MultiFileLogger online at 20160125 01:49:13 in /builds/slave/test-pgo 01:49:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 01:49:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:49:13 INFO - {'append_to_log': False, 01:49:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:49:13 INFO - 'blob_upload_branch': 'B2G-Inbound', 01:49:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:49:13 INFO - 'branch': 'B2G-Inbound', 01:49:13 INFO - 'buildbot_json_path': 'buildprops.json', 01:49:13 INFO - 'config_files': ('talos/linux_config.py',), 01:49:13 INFO - 'default_actions': ('clobber', 01:49:13 INFO - 'read-buildbot-config', 01:49:13 INFO - 'download-and-extract', 01:49:13 INFO - 'populate-webroot', 01:49:13 INFO - 'create-virtualenv', 01:49:13 INFO - 'install', 01:49:13 INFO - 'run-tests'), 01:49:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:49:13 INFO - 'download_minidump_stackwalk': True, 01:49:13 INFO - 'download_symbols': 'ondemand', 01:49:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:49:13 INFO - 'tooltool.py': '/tools/tooltool.py', 01:49:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:49:13 INFO - '/tools/misc-python/virtualenv.py')}, 01:49:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:49:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:49:13 INFO - 'installer_path': 'installer.exe', 01:49:13 INFO - 'log_level': 'info', 01:49:13 INFO - 'log_name': 'talos', 01:49:13 INFO - 'log_to_console': True, 01:49:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:49:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:49:13 INFO - 'opt_config_files': (), 01:49:13 INFO - 'pip_index': False, 01:49:13 INFO - 'sps_profile': False, 01:49:13 INFO - 'sps_profile_interval': 0, 01:49:13 INFO - 'suite': 'dromaeojs', 01:49:13 INFO - 'system_bits': '32', 01:49:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:49:13 INFO - 'title': 'talos-linux64-ix-038', 01:49:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:49:13 INFO - 'use_talos_json': True, 01:49:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:49:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:49:13 INFO - 'work_dir': 'build'} 01:49:13 INFO - ##### 01:49:13 INFO - ##### Running clobber step. 01:49:13 INFO - ##### 01:49:13 INFO - Running pre-action listener: _resource_record_pre_action 01:49:13 INFO - Running main action method: clobber 01:49:13 INFO - rmtree: /builds/slave/test-pgo/build 01:49:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:49:14 INFO - Running post-action listener: _resource_record_post_action 01:49:14 INFO - ##### 01:49:14 INFO - ##### Running read-buildbot-config step. 01:49:14 INFO - ##### 01:49:14 INFO - Running pre-action listener: _resource_record_pre_action 01:49:14 INFO - Running main action method: read_buildbot_config 01:49:14 INFO - Using buildbot properties: 01:49:14 INFO - { 01:49:14 INFO - "project": "", 01:49:14 INFO - "product": "firefox", 01:49:14 INFO - "script_repo_revision": "production", 01:49:14 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 01:49:14 INFO - "repository": "", 01:49:14 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 01:49:14 INFO - "buildid": "20160124233013", 01:49:14 INFO - "pgo_build": "True", 01:49:14 INFO - "basedir": "/builds/slave/test-pgo", 01:49:14 INFO - "buildnumber": 229, 01:49:14 INFO - "slavename": "talos-linux64-ix-038", 01:49:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:49:14 INFO - "platform": "ubuntu64_hw", 01:49:14 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 01:49:14 INFO - "branch": "b2g-inbound", 01:49:14 INFO - "repo_path": "integration/b2g-inbound", 01:49:14 INFO - "revision": "e93a14409efe417a7fd132184780ae7192d68d7d", 01:49:14 INFO - "stage_platform": "linux64-pgo", 01:49:14 INFO - "builduid": "cab3f576caa240559d79f9804a4afedc", 01:49:14 INFO - "slavebuilddir": "test" 01:49:14 INFO - } 01:49:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:49:14 INFO - Running post-action listener: _resource_record_post_action 01:49:14 INFO - ##### 01:49:14 INFO - ##### Running download-and-extract step. 01:49:14 INFO - ##### 01:49:14 INFO - Running pre-action listener: _resource_record_pre_action 01:49:14 INFO - Running main action method: download_and_extract 01:49:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:14 INFO - https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:49:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/test_packages.json 01:49:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/test_packages.json 01:49:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:49:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:49:17 INFO - Downloaded 1448 bytes. 01:49:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:49:17 INFO - Using the following test package requirements: 01:49:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:49:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:49:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:49:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'jsshell-linux-x86_64.zip'], 01:49:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:49:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:49:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:49:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:49:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:49:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:49:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:49:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:49:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:17 INFO - https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:18 INFO - Downloaded 22491678 bytes. 01:49:18 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'] 01:49:18 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 01:49:19 INFO - Return code: 0 01:49:19 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:19 INFO - https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:20 INFO - Downloaded 22491678 bytes. 01:49:20 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'] 01:49:20 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 01:49:22 INFO - Return code: 0 01:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:22 INFO - https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:23 INFO - Downloaded 10706572 bytes. 01:49:23 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'] 01:49:23 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 01:49:23 INFO - Return code: 0 01:49:23 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')]} 01:49:23 INFO - https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:49:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:49:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:49:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ai_p_IoARlWFif8k5tEMbQ/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 01:49:25 INFO - Downloaded 55970521 bytes. 01:49:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:49:25 INFO - mkdir: /builds/slave/test-pgo/properties 01:49:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:49:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:49:25 INFO - Contents: 01:49:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:49:25 INFO - Running post-action listener: _resource_record_post_action 01:49:25 INFO - Running post-action listener: set_extra_try_arguments 01:49:25 INFO - ##### 01:49:25 INFO - ##### Running populate-webroot step. 01:49:25 INFO - ##### 01:49:25 INFO - Running pre-action listener: _resource_record_pre_action 01:49:25 INFO - Running main action method: populate_webroot 01:49:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:49:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:49:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:49:25 INFO - '--tppagecycles', 01:49:25 INFO - '7'], 01:49:25 INFO - 'tests': ['tsvgm']}}, 01:49:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:49:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:49:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:49:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:49:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:49:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:49:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'tests': ['damp', 'tps']}, 01:49:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['damp', 'tps']}, 01:49:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:49:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:49:25 INFO - 'other': {'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'other_l64': {'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'other_nol64': {'tests': ['a11yr', 01:49:25 INFO - 'ts_paint', 01:49:25 INFO - 'tpaint', 01:49:25 INFO - 'sessionrestore', 01:49:25 INFO - 'sessionrestore_no_auto_restore']}, 01:49:25 INFO - 'svgr': {'tests': ['tsvgx', 01:49:25 INFO - 'tsvgr_opacity', 01:49:25 INFO - 'tart', 01:49:25 INFO - 'tscrollx', 01:49:25 INFO - 'cart']}, 01:49:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['tsvgx', 01:49:25 INFO - 'tsvgr_opacity', 01:49:25 INFO - 'tart', 01:49:25 INFO - 'tscrollx', 01:49:25 INFO - 'cart']}, 01:49:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'tests': ['tp5o']}, 01:49:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'talos_options': ['--e10s'], 01:49:25 INFO - 'tests': ['tp5o']}, 01:49:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'talos_options': ['--xperf_path', 01:49:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:49:25 INFO - 'tests': ['tp5n']}, 01:49:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:49:25 INFO - 'talos_options': ['--e10s', 01:49:25 INFO - '--xperf_path', 01:49:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:49:25 INFO - 'tests': ['tp5n']}}, 01:49:25 INFO - 'talos.zip': {'path': '', 01:49:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:49:25 INFO - Running post-action listener: _resource_record_post_action 01:49:25 INFO - ##### 01:49:25 INFO - ##### Running create-virtualenv step. 01:49:25 INFO - ##### 01:49:25 INFO - Running pre-action listener: _resource_record_pre_action 01:49:25 INFO - Running main action method: create_virtualenv 01:49:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:49:25 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 01:49:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:49:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:49:25 INFO - Using real prefix '/usr' 01:49:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:49:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:49:27 INFO - Installing pip.................done. 01:49:27 INFO - Return code: 0 01:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 01:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:49:27 INFO - Using env: {'DISPLAY': ':0', 01:49:27 INFO - 'HOME': '/home/cltbld', 01:49:27 INFO - 'LANG': 'en_US.UTF-8', 01:49:27 INFO - 'LANGUAGE': 'en_US:en', 01:49:27 INFO - 'LOGNAME': 'cltbld', 01:49:27 INFO - 'MAIL': '/var/mail/cltbld', 01:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:27 INFO - 'MOZ_NO_REMOTE': '1', 01:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:27 INFO - 'NO_EM_RESTART': '1', 01:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:27 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:27 INFO - 'SHELL': '/bin/bash', 01:49:27 INFO - 'SHLVL': '1', 01:49:27 INFO - 'TERM': 'linux', 01:49:27 INFO - 'TMOUT': '86400', 01:49:27 INFO - 'USER': 'cltbld', 01:49:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:27 INFO - '_': '/tools/buildbot/bin/python'} 01:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:28 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 01:49:28 INFO - Cleaning up... 01:49:28 INFO - Return code: 0 01:49:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 01:49:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:49:28 INFO - Using env: {'DISPLAY': ':0', 01:49:28 INFO - 'HOME': '/home/cltbld', 01:49:28 INFO - 'LANG': 'en_US.UTF-8', 01:49:28 INFO - 'LANGUAGE': 'en_US:en', 01:49:28 INFO - 'LOGNAME': 'cltbld', 01:49:28 INFO - 'MAIL': '/var/mail/cltbld', 01:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:28 INFO - 'MOZ_NO_REMOTE': '1', 01:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:28 INFO - 'NO_EM_RESTART': '1', 01:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:28 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:28 INFO - 'SHELL': '/bin/bash', 01:49:28 INFO - 'SHLVL': '1', 01:49:28 INFO - 'TERM': 'linux', 01:49:28 INFO - 'TMOUT': '86400', 01:49:28 INFO - 'USER': 'cltbld', 01:49:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:28 INFO - '_': '/tools/buildbot/bin/python'} 01:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:28 INFO - Downloading/unpacking psutil>=0.7.1 01:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:30 INFO - Installing collected packages: psutil 01:49:30 INFO - Running setup.py install for psutil 01:49:30 INFO - building 'psutil._psutil_linux' extension 01:49:30 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 01:49:30 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 01:49:30 INFO - building 'psutil._psutil_posix' extension 01:49:30 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 01:49:30 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 01:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:49:30 INFO - Successfully installed psutil 01:49:30 INFO - Cleaning up... 01:49:30 INFO - Return code: 0 01:49:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 01:49:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:49:30 INFO - Using env: {'DISPLAY': ':0', 01:49:30 INFO - 'HOME': '/home/cltbld', 01:49:30 INFO - 'LANG': 'en_US.UTF-8', 01:49:30 INFO - 'LANGUAGE': 'en_US:en', 01:49:30 INFO - 'LOGNAME': 'cltbld', 01:49:30 INFO - 'MAIL': '/var/mail/cltbld', 01:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:30 INFO - 'MOZ_NO_REMOTE': '1', 01:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:30 INFO - 'NO_EM_RESTART': '1', 01:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:30 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:30 INFO - 'SHELL': '/bin/bash', 01:49:30 INFO - 'SHLVL': '1', 01:49:30 INFO - 'TERM': 'linux', 01:49:30 INFO - 'TMOUT': '86400', 01:49:30 INFO - 'USER': 'cltbld', 01:49:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:30 INFO - '_': '/tools/buildbot/bin/python'} 01:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:49:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:49:32 INFO - Installing collected packages: mozsystemmonitor 01:49:32 INFO - Running setup.py install for mozsystemmonitor 01:49:32 INFO - Successfully installed mozsystemmonitor 01:49:32 INFO - Cleaning up... 01:49:33 INFO - Return code: 0 01:49:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:49: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')]} 01:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49: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')]} 01:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 01:49:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:49:33 INFO - Using env: {'DISPLAY': ':0', 01:49:33 INFO - 'HOME': '/home/cltbld', 01:49:33 INFO - 'LANG': 'en_US.UTF-8', 01:49:33 INFO - 'LANGUAGE': 'en_US:en', 01:49:33 INFO - 'LOGNAME': 'cltbld', 01:49:33 INFO - 'MAIL': '/var/mail/cltbld', 01:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:33 INFO - 'MOZ_NO_REMOTE': '1', 01:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:33 INFO - 'NO_EM_RESTART': '1', 01:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:33 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:33 INFO - 'SHELL': '/bin/bash', 01:49:33 INFO - 'SHLVL': '1', 01:49:33 INFO - 'TERM': 'linux', 01:49:33 INFO - 'TMOUT': '86400', 01:49:33 INFO - 'USER': 'cltbld', 01:49:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:33 INFO - '_': '/tools/buildbot/bin/python'} 01:49:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:33 INFO - Downloading/unpacking blobuploader==1.2.4 01:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:34 INFO - Downloading blobuploader-1.2.4.tar.gz 01:49:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:49:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:49:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:35 INFO - Downloading docopt-0.6.1.tar.gz 01:49:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:49:35 INFO - Installing collected packages: blobuploader, requests, docopt 01:49:35 INFO - Running setup.py install for blobuploader 01:49:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:49:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:49:35 INFO - Running setup.py install for requests 01:49:36 INFO - Running setup.py install for docopt 01:49:36 INFO - Successfully installed blobuploader requests docopt 01:49:36 INFO - Cleaning up... 01:49:36 INFO - Return code: 0 01:49:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:49:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:49:36 INFO - Using env: {'DISPLAY': ':0', 01:49:36 INFO - 'HOME': '/home/cltbld', 01:49:36 INFO - 'LANG': 'en_US.UTF-8', 01:49:36 INFO - 'LANGUAGE': 'en_US:en', 01:49:36 INFO - 'LOGNAME': 'cltbld', 01:49:36 INFO - 'MAIL': '/var/mail/cltbld', 01:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:36 INFO - 'MOZ_NO_REMOTE': '1', 01:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:36 INFO - 'NO_EM_RESTART': '1', 01:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:36 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:36 INFO - 'SHELL': '/bin/bash', 01:49:36 INFO - 'SHLVL': '1', 01:49:36 INFO - 'TERM': 'linux', 01:49:36 INFO - 'TMOUT': '86400', 01:49:36 INFO - 'USER': 'cltbld', 01:49:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:36 INFO - '_': '/tools/buildbot/bin/python'} 01:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:36 INFO - Running setup.py (path:/tmp/pip-5j1174-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:36 INFO - Running setup.py (path:/tmp/pip-Kcoy3A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:36 INFO - Running setup.py (path:/tmp/pip-0OKPvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:36 INFO - Running setup.py (path:/tmp/pip-CY533p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:36 INFO - Running setup.py (path:/tmp/pip-oi39qG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:36 INFO - Running setup.py (path:/tmp/pip-5jxOrN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:36 INFO - Running setup.py (path:/tmp/pip-f8WDF_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:37 INFO - Running setup.py (path:/tmp/pip-A135cy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:37 INFO - Running setup.py (path:/tmp/pip-jYNAb9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:37 INFO - Running setup.py (path:/tmp/pip-D3kOvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:37 INFO - Running setup.py (path:/tmp/pip-7w87OQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:37 INFO - Running setup.py (path:/tmp/pip-JSXh42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:37 INFO - Running setup.py (path:/tmp/pip-i4eLkW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:37 INFO - Running setup.py (path:/tmp/pip-nxIGSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:37 INFO - Running setup.py (path:/tmp/pip-5bc2yC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:37 INFO - Running setup.py (path:/tmp/pip-UDTiQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:37 INFO - Running setup.py (path:/tmp/pip-4cvSI_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:49:37 INFO - Running setup.py install for manifestparser 01:49:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:49:37 INFO - Running setup.py install for mozcrash 01:49:37 INFO - Running setup.py install for mozdebug 01:49:38 INFO - Running setup.py install for mozdevice 01:49:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for mozfile 01:49:38 INFO - Running setup.py install for mozhttpd 01:49:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for mozinfo 01:49:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for mozInstall 01:49:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for mozleak 01:49:38 INFO - Running setup.py install for mozlog 01:49:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for moznetwork 01:49:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:49:38 INFO - Running setup.py install for mozprocess 01:49:39 INFO - Running setup.py install for mozprofile 01:49:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:49:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:49:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:49:39 INFO - Running setup.py install for mozrunner 01:49:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:49:39 INFO - Running setup.py install for mozscreenshot 01:49:39 INFO - Running setup.py install for moztest 01:49:39 INFO - Running setup.py install for mozversion 01:49:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:49:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:49:39 INFO - Cleaning up... 01:49:39 INFO - Return code: 0 01:49:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:49:39 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')]} 01:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:39 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')]} 01:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 01:49:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:49:39 INFO - Using env: {'DISPLAY': ':0', 01:49:39 INFO - 'HOME': '/home/cltbld', 01:49:39 INFO - 'LANG': 'en_US.UTF-8', 01:49:39 INFO - 'LANGUAGE': 'en_US:en', 01:49:39 INFO - 'LOGNAME': 'cltbld', 01:49:39 INFO - 'MAIL': '/var/mail/cltbld', 01:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:39 INFO - 'MOZ_NO_REMOTE': '1', 01:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:39 INFO - 'NO_EM_RESTART': '1', 01:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:39 INFO - 'SHELL': '/bin/bash', 01:49:39 INFO - 'SHLVL': '1', 01:49:39 INFO - 'TERM': 'linux', 01:49:39 INFO - 'TMOUT': '86400', 01:49:39 INFO - 'USER': 'cltbld', 01:49:39 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:39 INFO - '_': '/tools/buildbot/bin/python'} 01:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:39 INFO - Running setup.py (path:/tmp/pip-ofts7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:49:39 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)) 01:49:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:39 INFO - Running setup.py (path:/tmp/pip-GP6AJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:49:39 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)) 01:49:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:39 INFO - Running setup.py (path:/tmp/pip-wZ8XIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:49:39 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)) 01:49:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:39 INFO - Running setup.py (path:/tmp/pip-25uJVM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:40 INFO - Running setup.py (path:/tmp/pip-HwoAUu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:40 INFO - Running setup.py (path:/tmp/pip-I7LyWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:40 INFO - Running setup.py (path:/tmp/pip-gIK2rg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:40 INFO - Running setup.py (path:/tmp/pip-xLSWLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:40 INFO - Running setup.py (path:/tmp/pip-Jbra0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:40 INFO - Running setup.py (path:/tmp/pip-ygbBUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:40 INFO - Running setup.py (path:/tmp/pip-6FX1H2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:40 INFO - Running setup.py (path:/tmp/pip-G1RnWG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:40 INFO - Running setup.py (path:/tmp/pip-5OFz9r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:40 INFO - Running setup.py (path:/tmp/pip-80YDSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:40 INFO - Running setup.py (path:/tmp/pip-18eI1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:40 INFO - Running setup.py (path:/tmp/pip-cjndFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:49:40 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)) 01:49:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:40 INFO - Running setup.py (path:/tmp/pip-tRYVAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:49:41 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)) 01:49:41 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)) 01:49:41 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)) 01:49:41 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)) 01:49:41 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)) 01:49:41 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)) 01:49:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:42 INFO - Downloading blessings-1.6.tar.gz 01:49:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:49:42 INFO - Installing collected packages: blessings 01:49:42 INFO - Running setup.py install for blessings 01:49:42 INFO - Successfully installed blessings 01:49:42 INFO - Cleaning up... 01:49:43 INFO - Return code: 0 01:49:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:49:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:49:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:49:43 INFO - Reading from file tmpfile_stdout 01:49:43 INFO - Current package versions: 01:49:43 INFO - argparse == 1.2.1 01:49:43 INFO - blessings == 1.6 01:49:43 INFO - blobuploader == 1.2.4 01:49:43 INFO - docopt == 0.6.1 01:49:43 INFO - manifestparser == 1.1 01:49:43 INFO - mozInstall == 1.12 01:49:43 INFO - mozcrash == 0.16 01:49:43 INFO - mozdebug == 0.1 01:49:43 INFO - mozdevice == 0.48 01:49:43 INFO - mozfile == 1.2 01:49:43 INFO - mozhttpd == 0.7 01:49:43 INFO - mozinfo == 0.9 01:49:43 INFO - mozleak == 0.1 01:49:43 INFO - mozlog == 3.1 01:49:43 INFO - moznetwork == 0.27 01:49:43 INFO - mozprocess == 0.22 01:49:43 INFO - mozprofile == 0.28 01:49:43 INFO - mozrunner == 6.11 01:49:43 INFO - mozscreenshot == 0.1 01:49:43 INFO - mozsystemmonitor == 0.0 01:49:43 INFO - moztest == 0.7 01:49:43 INFO - mozversion == 1.4 01:49:43 INFO - psutil == 3.1.1 01:49:43 INFO - requests == 1.2.3 01:49:43 INFO - wsgiref == 0.1.2 01:49:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 01:49:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:49:43 INFO - Using env: {'DISPLAY': ':0', 01:49:43 INFO - 'HOME': '/home/cltbld', 01:49:43 INFO - 'LANG': 'en_US.UTF-8', 01:49:43 INFO - 'LANGUAGE': 'en_US:en', 01:49:43 INFO - 'LOGNAME': 'cltbld', 01:49:43 INFO - 'MAIL': '/var/mail/cltbld', 01:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:43 INFO - 'MOZ_NO_REMOTE': '1', 01:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:43 INFO - 'NO_EM_RESTART': '1', 01:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:43 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:43 INFO - 'SHELL': '/bin/bash', 01:49:43 INFO - 'SHLVL': '1', 01:49:43 INFO - 'TERM': 'linux', 01:49:43 INFO - 'TMOUT': '86400', 01:49:43 INFO - 'USER': 'cltbld', 01:49:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:43 INFO - '_': '/tools/buildbot/bin/python'} 01:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 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)) 01:49:43 INFO - Cleaning up... 01:49:43 INFO - Return code: 0 01:49:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:49:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:49:43 INFO - Using env: {'DISPLAY': ':0', 01:49:43 INFO - 'HOME': '/home/cltbld', 01:49:43 INFO - 'LANG': 'en_US.UTF-8', 01:49:43 INFO - 'LANGUAGE': 'en_US:en', 01:49:43 INFO - 'LOGNAME': 'cltbld', 01:49:43 INFO - 'MAIL': '/var/mail/cltbld', 01:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:43 INFO - 'MOZ_NO_REMOTE': '1', 01:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:43 INFO - 'NO_EM_RESTART': '1', 01:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:43 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:43 INFO - 'SHELL': '/bin/bash', 01:49:43 INFO - 'SHLVL': '1', 01:49:43 INFO - 'TERM': 'linux', 01:49:43 INFO - 'TMOUT': '86400', 01:49:43 INFO - 'USER': 'cltbld', 01:49:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:43 INFO - '_': '/tools/buildbot/bin/python'} 01:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:43 INFO - Downloading/unpacking jsonschema 01:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:49:45 INFO - Downloading/unpacking functools32 (from jsonschema) 01:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:45 INFO - Downloading functools32-3.2.3-2.tar.gz 01:49:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:49:45 INFO - warning: no files found matching '*.txt' 01:49:45 INFO - no previously-included directories found matching 'build' 01:49:45 INFO - no previously-included directories found matching 'dist' 01:49:45 INFO - no previously-included directories found matching '.git*' 01:49:45 INFO - Installing collected packages: jsonschema, functools32 01:49:45 INFO - Running setup.py install for functools32 01:49:45 INFO - warning: no files found matching '*.txt' 01:49:45 INFO - no previously-included directories found matching 'build' 01:49:45 INFO - no previously-included directories found matching 'dist' 01:49:45 INFO - no previously-included directories found matching '.git*' 01:49:45 INFO - Successfully installed jsonschema functools32 01:49:45 INFO - Cleaning up... 01:49:45 INFO - Return code: 0 01:49:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb486ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8f630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, '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': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', '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 01:49:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:49:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:49:45 INFO - Using env: {'DISPLAY': ':0', 01:49:45 INFO - 'HOME': '/home/cltbld', 01:49:45 INFO - 'LANG': 'en_US.UTF-8', 01:49:45 INFO - 'LANGUAGE': 'en_US:en', 01:49:45 INFO - 'LOGNAME': 'cltbld', 01:49:45 INFO - 'MAIL': '/var/mail/cltbld', 01:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:45 INFO - 'MOZ_NO_REMOTE': '1', 01:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:49:45 INFO - 'NO_EM_RESTART': '1', 01:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:49:45 INFO - 'PWD': '/builds/slave/test-pgo', 01:49:45 INFO - 'SHELL': '/bin/bash', 01:49:45 INFO - 'SHLVL': '1', 01:49:45 INFO - 'TERM': 'linux', 01:49:45 INFO - 'TMOUT': '86400', 01:49:45 INFO - 'USER': 'cltbld', 01:49:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:45 INFO - '_': '/tools/buildbot/bin/python'} 01:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:49:46 INFO - Downloading/unpacking flake8 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:49:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49: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 01:49:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:48 INFO - no previously-included directories found matching 'docs/_build' 01:49:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:48 INFO - Running setup.py install for pep8 01:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:48 INFO - no previously-included directories found matching 'docs/_build' 01:49:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:49:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:48 INFO - Cleaning up... 01:49:48 INFO - Return code: 0 01:49:48 INFO - Running post-action listener: _resource_record_post_action 01:49:48 INFO - Running post-action listener: _start_resource_monitoring 01:49:48 INFO - Starting resource monitoring. 01:49:48 INFO - ##### 01:49:48 INFO - ##### Running install step. 01:49:48 INFO - ##### 01:49:48 INFO - Running pre-action listener: _resource_record_pre_action 01:49:48 INFO - Running main action method: install 01:49:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:49:48 INFO - Reading from file tmpfile_stdout 01:49:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:49:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:49:49 INFO - Reading from file tmpfile_stdout 01:49:49 INFO - Output received: 01:49:49 INFO - Usage: mozinstall [options] installer 01:49:49 INFO - Options: 01:49:49 INFO - -h, --help show this help message and exit 01:49:49 INFO - -d DEST, --destination=DEST 01:49:49 INFO - Directory to install application into. [default: 01:49:49 INFO - "/builds/slave/test-pgo"] 01:49:49 INFO - --app=APP Application being installed. [default: firefox] 01:49:49 INFO - mkdir: /builds/slave/test-pgo/build/application 01:49:49 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'] 01:49:49 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 01:50:05 INFO - Reading from file tmpfile_stdout 01:50:05 INFO - Output received: 01:50:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:50:05 INFO - Running post-action listener: _resource_record_post_action 01:50:05 INFO - ##### 01:50:05 INFO - ##### Running run-tests step. 01:50:05 INFO - ##### 01:50:05 INFO - Running pre-action listener: _resource_record_pre_action 01:50:05 INFO - Running main action method: run_tests 01:50:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:50:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:50:05 INFO - Python 2.7.3 01:50:05 INFO - Return code: 0 01:50:05 INFO - grabbing minidump binary from tooltool 01:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:50:05 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 0x1b20840>, '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 0x1a8d6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8db60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:50:05 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 01:50:05 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 01:50:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:50:05 INFO - Return code: 0 01:50:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:50:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:50:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:50:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:50:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:50:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:50:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:50:06 INFO - Return code: 0 01:50:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 01:50:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 01:50:06 INFO - Using env: {'DISPLAY': ':0', 01:50:06 INFO - 'HOME': '/home/cltbld', 01:50:06 INFO - 'LANG': 'en_US.UTF-8', 01:50:06 INFO - 'LANGUAGE': 'en_US:en', 01:50:06 INFO - 'LOGNAME': 'cltbld', 01:50:06 INFO - 'MAIL': '/var/mail/cltbld', 01:50:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:50:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:06 INFO - 'MOZ_NO_REMOTE': '1', 01:50:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:06 INFO - 'NO_EM_RESTART': '1', 01:50:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 01:50:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:50:06 INFO - 'SHELL': '/bin/bash', 01:50:06 INFO - 'SHLVL': '1', 01:50:06 INFO - 'TERM': 'linux', 01:50:06 INFO - 'TMOUT': '86400', 01:50:06 INFO - 'USER': 'cltbld', 01:50:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903', 01:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:06 INFO - '_': '/tools/buildbot/bin/python'} 01:50:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:50:06 INFO - mozversion application_buildid: 20160124233013 01:50:06 INFO - mozversion application_changeset: e93a14409efe417a7fd132184780ae7192d68d7d 01:50:06 INFO - mozversion application_display_name: Nightly 01:50:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:50:06 INFO - mozversion application_name: Firefox 01:50:06 INFO - mozversion application_remotingname: firefox 01:50:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 01:50:06 INFO - mozversion application_vendor: Mozilla 01:50:06 INFO - mozversion application_version: 46.0a1 01:50:06 INFO - mozversion platform_buildid: 20160124233013 01:50:06 INFO - mozversion platform_changeset: e93a14409efe417a7fd132184780ae7192d68d7d 01:50:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 01:50:06 INFO - mozversion platform_version: 46.0a1 01:50:06 INFO - using testdate: 1453715406 01:50:06 INFO - actual date: 1453715406 01:50:06 INFO - starting webserver on 'localhost:41249' 01:50:06 INFO - SUITE-START | Running 3 tests 01:50:06 INFO - TEST-START | dromaeo_css 01:50:06 INFO - operating with platform_type : linux_ 01:50:06 INFO - Initialising browser for dromaeo_css test... 01:50:06 INFO - TEST-INFO | started process 15993 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYIdv0P/profile http://localhost:41249/getInfo.html) 01:50:11 INFO - PROCESS | 15993 | __metrics Screen width/height:1600/1200 01:50:11 INFO - PROCESS | 15993 | colorDepth:24 01:50:11 INFO - PROCESS | 15993 | Browser inner width/height: 1024/697 01:50:11 INFO - PROCESS | 15993 | __metrics 01:50:11 INFO - PROCESS | 15993 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:50:11 INFO - PROCESS | 15993 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:50:12 INFO - TEST-INFO | 15993: exit 0 01:50:12 INFO - Browser initialized. 01:50:12 INFO - Running cycle 1/1 for dromaeo_css test... 01:50:12 INFO - TEST-INFO | started process 16087 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYIdv0P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:24 INFO - PROCESS | 16087 | RSS: Main: 148549632 01:50:24 INFO - PROCESS | 16087 | 01:51:15 INFO - PROCESS | 16087 | 1453715475553 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] 01:53:23 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41249/tests/dromaeo/cssquery-ext.html) 01:53:24 INFO - PROCESS | 16087 | RSS: Main: 236601344 01:53:24 INFO - PROCESS | 16087 | 01:56:27 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-ext.html (next: http://localhost:41249/tests/dromaeo/cssquery-jquery.html) 01:56:27 INFO - PROCESS | 16087 | RSS: Main: 233185280 01:56:27 INFO - PROCESS | 16087 | 01:59:29 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41249/tests/dromaeo/cssquery-mootools.html) 01:59:30 INFO - PROCESS | 16087 | RSS: Main: 235917312 01:59:30 INFO - PROCESS | 16087 | 02:02:32 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41249/tests/dromaeo/cssquery-prototype.html) 02:02:32 INFO - PROCESS | 16087 | RSS: Main: 209391616 02:02:32 INFO - PROCESS | 16087 | 02:05:35 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41249/tests/dromaeo/cssquery-yui.html) 02:05:35 INFO - PROCESS | 16087 | RSS: Main: 212889600 02:05:35 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | Cycle 1(1): loaded http://localhost:41249/tests/dromaeo/cssquery-yui.html (next: http://localhost:41249/tests/dromaeo/cssquery-dojo.html) 02:08:38 INFO - PROCESS | 16087 | RSS: Main: 267104256 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | __start_tp_report 02:08:38 INFO - PROCESS | 16087 | _x_x_mozilla_page_load 02:08:38 INFO - PROCESS | 16087 | _x_x_mozilla_page_load_details 02:08:38 INFO - PROCESS | 16087 | |i|pagename|runs| 02:08:38 INFO - PROCESS | 16087 | |0;dojo.html;3081.2604974806054;3118.2827949571597;3169.28691044515;3172.9841350793245;3196.1530194498455;4973.328600638913;5035.9748201259035;5096.210087436449;5131.153359695651;5160.716160611165;5061.367329083864;5080.695158290505;5105;5123.205903085019;5180.533751962323;4578.061497393026;4658.231391820345;4660.998019448117;4706.176419126639;4788.473267940523;4794.976025119887;4809.855704328876;4834.637402194832;4854.077725232212;4866.756662166895;4595.701279416827;4657.580817726421;4666.160091183586;4705.341252224691;4715.245560710304;4670.416197975253;4675.485696573374;4678.836240731592;4683.180443422388;4714.986277950257;4578.2903649934315;4653.395058642389;4667.6265898728025;4673.696209746389;4697.506761790031;4898.804047838083;4915.016996600694;4931;4950.133726597831;4973.776180071869;5506.256655351516;5530.889382212334;5538.169274608841;5540.86147846303;5543.113101903717;5347.171188465794;5436.401995780461;5546.69493177875;5580.246666700024;5599.580031497613;5201.141811601081;5206.479352064801;5228.424873263938;5230.947690523084;5277.023750606112;5536.280283563111;5547;5551.3893471718075;5551.833444996657;5600.075987462104;5233.659812112201;5298.072837253465;5304.363476382859;5399.568034557305;5442.863928401822;5340.25236466895;5378.515933565998;5388.13789793639;5393.865153371119;5407.188921661704;5455.0453670607485;5495.862603434866;5498.780048798003;5500.697461639568;5547.445255474501;5335.3864305604575;5361.410244873061;5407.134858422713;5482.835514934558;5487.122060470386;4293.162833247549;4319;4319.956800432018;4344.066025804404;4347.217500849877;3759.981200094037;3834.5206849143856;3850.537935447764;3874.9806250969127;3875;4975.502449755068;5049.040682270357;5073.492650734897;5075.847724568269;5077.365329333833;5458.4814442627885;5472.20653005312;5491.36849262332;5492.176173573996;5513.531349835229;5071.46749591295;5077.136886729265;5079.923801142986;5082.949170508247;5125.308083408767;4543.818247270138;4644.465886423104;4654.813807447664;4724.220503616864;4765.618750499952;5683.346415162227;5698.601097923106;5705.885882282331;5717;5722.055860782924;5502.614816962774;5514.779408823762;5516.503514683698;5522.895420915913;5525.778968841362;5614.6631202128;5689.800856969986;5712.571557133315;5730.484256416942;5783.392743762012;5395.730213489388;5400.135978243462;5408.405075441619;5412.7293635318865;5415.025295446857;5365.517103460707;5424.945750542602;5467.043267428105;5477.67133971963;5520.558355331484;5256.132738098171;5273.103572392779;5306.734663266899;5311.415744268204;5341.092014357646;5356.57147428197;5366.2487251784005;5385.3268341457315;5393.352797664305;5433.8369848904595;5143.4085080216255;5221.712805795566;5309.46905309466;5311.548518375981;5313;5291.470852914677;5320.920186197132;5330.78676852937;5342.866428339323;5399.136138217867;5211.114110601131;5211.583073354198;5216.739163041909;5217.947820521898;5219.034478621467 02:08:38 INFO - PROCESS | 16087 | |1;ext.html;494.787241486161;511.96416250862444;527.1276038156851;533.3306700091384;561.3964987638288;27994.720052799465;28401.715982840164;28403.857980710094;28407.431851363013;34599.135021624475;38099.4285085724;38740.41889371662;38752;38763.22473550534;38793.61206387935;8283.130271321515;8495;8496.745097647081;8497.74506764795;8501.872471912926;8212.425130240885;8316.209960053786;8351;8351.20663536963;8353.665853365857;8346.081930987586;8376.748697539084;8415.621297041647;8417.032041315266;8615.741527754146;8504.574771261443;8547.487150770974;8580.699675511358;8583.270422014137;8594.742157735278;8462.111478294813;8552.315814734806;8582.442141260799;8588.098249683755;8589.871151932726;39547.60452395468;39832.40251396231;39855.20289594221;39895;39974.20051598952;3265.4035269142246;3315.287213249139;3324.8670053197843;3365.612954510238;3465.42820434628;29887.551686724717;30146.698533014827;30360;30549.389012219854;31425.685743142505;3831.6934645228316;3887.961120388788;3891.8443262269475;3967.4247234151176;4083.060895993938;249170;249839;250915;251323;251558;51196;52337.999999999236;52504;57995;58749.412505874396;60345.396546034855;60828.391716083155;60876;60885;60919.69540152271;15446;15566.299516521784;15652.765208521882;15657.37370505167;15661.373545058297;11826.408679566159;11914.52341906314;11914.821277680841;11921.105917056255;11933.76132477363;17753.11234438273;18139.183736731615;20372.490687732927;20429.79570204279;20921;7798.8050298741855;7828.491148075471;7904.762857114296;7913.446058775946;7920.366370690331;913.7441516375426;953.880764904387;1014.5688082564881;1068.647346375694;1102.729831191347;26964.32589185247;27360.45279094407;27733.168004959884;27766.028189013286;27868.860655696593;1047.0838016735356;1049.3441599000626;1069.6946435514299;1112.4580333936915;1124.9718757030976;14547.3453694584;14632.685155138499;14639.121652700873;14681.632959175893;14829.480968166277;357778;359444;360689;360751;361098;51745.48254517407;52366.8106551475;52414.47585524096;52461.47538524642;52500;1302.2707283921034;1312.25201635069;1322.8743269389586;1323.5830713325272;1328.4686125549858;24186.75813241845;30347;30427;30709;30908.69091309058;43376.132477350904;43800;44010.55989440065;44043.55956440523;44111.77944110259;280818;287223;287389;287973;288137;32079.35841283208;32679.673203267663;32681;32688.182795430304;42363.5763642372;37781;38285.42571861369;38484.61515384923;38682;38714.6128538711;32582.185445364055;32935.67064329326;34688.653113469554;34934.30131397409;36601.71893983698;35861.28277434385;36005;36474.635253647124;38531.80734096312;38951.22097557976;33030.834845826575;33414;33707.494387584695;33781.66218337785;33864;29856;30422;32572;32766.344673105927;32767.672323276463;25063.122790702237;31634.841825790725;32863.507047394785;33958.32083358368;33999.15002124967 02:08:38 INFO - PROCESS | 16087 | |2;jquery.html;364.2351062768187;364.2405584356618;364.3841907176871;365.1546669460199;368.9723270754694;13675.521356752515;13961.511347102853;15542.53372398827;15745.84254157458;16469.917650411746;15046;15952.920235398808;16313.83686163138;16329.510114696579;16808.32766689334;5322.920156197651;5456.836294911159;5484.945150548503;5490.835274941758;5505.587080968923;4006.118653896153;4169.708120431571;5390.380106287768;5475.260839786618;5754.625949313302;5699.145128230778;5860.355360910296;5932.080527518242;5932.139839723238;5943.762249510014;5764.7982320618785;5768.509676677488;5809.04150815115;5809.099589563603;5809.9709501452435;4916.115099282128;5104.285400043997;5106.08090543702;5137.717425541594;5140.665856719302;12599.3070381129;12855.485780568766;15507.92246038774;19000.714989275173;19007.144678489363;2074.7925207479284;2163.621366260898;2192.1012384922105;2214.413180507167;2227.0646328542052;9028.683996060172;9525.904740952572;10198.023259874908;10581.047705706447;13200.273984930825;1770.5485101299087;1773.3704534890187;1811.936582219616;1835.9541011474687;1863.0777765006274;55633.44366556323;56328.436715633135;57209.71395143039;57573.13640295399;57584;9853.408795472295;10027.147692446224;10212.744681383025;10258.487075646188;10263.640772572924;13360.6659833503;13433.932830335785;13442.260675662737;13452.596422107352;13474.258915759532;7306.853862922818;7371.226021267797;7407.703691852374;7469.178390377054;7537.4723769336715;7052.726341286278;7142.21435642079;7198.892016619755;7251.419886409075;7276.490645654753;4457.888552786207;4518.909621807546;4532.388127602798;4532.954670453253;4559.270516717309;1690.8055573608947;1742.224710004036;1743.625120599052;1772.0785191700243;1802.270080617352;872.882160908282;909.5725009245645;918.5958178401482;948.7153853843819;975.6048800235916;15985.760213596805;16178.352865885232;16186;16585.419510317082;16721.749173762404;884.8009197930543;930.4138392812484;934.4206591913057;985.0494273026563;988.3279370028449;8718.041015488292;9052.683156089506;9302.813943721088;9784.657536986313;9886.15967642744;512164;522090;522725;523549;526847;67694.66152669206;70609.64695176491;71304.64347678228;71676.283237168;71755;1152.302856771641;1155.2086820527966;1166.6441735270655;1177.8586569611703;1179.7522520270838;14735.484258050918;15165.772513412086;15234.771478428054;15287.61780955485;15371.15458649785;33174.17064573405;33328;34344.65655343515;34554.82722586371;34802;42392.36411453893;43821.12357752764;44626.55373446224;45117.32324015077;45571.772141140405;7033.683484243119;7059.117610298713;7194.856102878018;7321.15806682217;7519.248075192437;8834.29325653959;10364.429956352473;10396.792064158522;10810;10949.178811589003;9127.589258483516;9335.346525743404;9421.104995025462;9584.66453674118;9935.751606209613;9294.302927280345;10013.599456021677;10333.534990925576;10355.275130740776;10483.68548943533;7519.436042296959;7916.802079948047;9593.520323983912;10370.170386368922;10529.4735263235;7232.855342893218;7315.524490908074;7315.743948961761;7349.228331025165;7398.741044063432;7890.566018868788;10144.847827282449;10317.845232321672;10353.17174626013;10508 02:08:38 INFO - PROCESS | 16087 | |3;mootools.html;1292.4636275945484;1417.4826188441218;1421.5095791951774;1553.7824704541367;1739.791225052994;6982.511224214307;7573.166951635322;7740.303372696456;7748.108967468743;7752.186020467854;7462.21646727094;7720.112187098485;7723.304902558769;7725.459217854753;7740.458167928233;2025.2709024751077;2078.199893041175;2261.7172853393367;2271.659251112338;2300.8734519601417;2318.5015221727326;2318.5826551220775;2323.546908352872;2327.94180145496;2328.2898715891647;2221.6334304839684;2313.4447732544236;2317.5249073939885;2318.455163036685;2318.547883162784;2266.7279926408855;2297.6783250344965;2346.565885311206;2348.765123487663;2349.4596242864236;2266.0369343029147;2286.5769832581027;2292.495650956787;2299.8620082795087;2317.3627252505526;7881.09367422748;7941.205879412013;7944.642491087915;7947.483413578099;7954.522728636242;4818.518148185189;4934.235193545006;4937.259411088329;4938.827141050046;4941.061198372297;3023.9848800755854;3092.38152369527;3112.2219445138717;3114.6106736657916;3126.3434678717495;1022.6216299969059;1032.9567137191416;1051.5215576912487;1060.1095080132725;1096.6709987003867;11054.281471704313;11077.889221107765;11104.722381940435;11108.61119860809;11116.333020018745;4337.067530480898;4353.281708518122;4389.275769498061;4458.6878918475395;4494.213512635341;8732.91267087321;8786.472811631322;8805.295576353876;8806.25146862511;8806.691765788166;4795.760211989386;4819.036192761461;4832.226843704991;4834.589059929875;4834.95165048352;4408.955910440919;4417.491988421309;4467;4472.955270447319;4476.216662084123;3364.8317584120696;3425.469052296898;3430.879919202816;3602.945955810665;3698.3712768829364;1106.6126855600476;1142.3146112332533;1145;1145.5417832866754;1148.2593727046008;1252.6868282929267;1278.5397256987478;1284.7687416265162;1294.1652634051172;1298.4092238031674;7193.964030179815;7196.136463624399;7225.747098851515;7370.189279179286;7381.557106573623;1104.3484344236938;1109.9056580190775;1118.5358076398365;1121.472907733364;1144.0390072339276;5533.3083364579425;5599.272094627672;5609.411011843697;5611.186377975252;5613.242212301368;9190.632374704937;9257.166854982948;9422.764430889145;9564.856527152098;9569.186619137452;9519.381240219363;9527.761805954768;9576;9663.082007209305;9687.128158465772;7409.962950185214;7506.13679426862;7582.810429739301;7635.503692259986;7657.846843063107;7027.859442811217;7057.7176912922905;7071.222165561681;7076.398506127037;7086.50394472382;8535.743927682179;8625.137486251324;8627.654893804429;8685.478871267744;8856.114388561093;8826.073262307622;8870.201681848665;8984.550772461482;9053.275737940818;9082.682106126254;6888.552244104118;7006.054182685272;7007.859842803014;7014.088168538057;7020.052292940388;6809.69356378974;7009.9649501752165;7286;7510;7511.06111736033;6968.686409111703;7154.177269614061;7185.712571497291;7196.856062878608;7252.383547398319;7018.894716579153;7052.717891284291;7066.116735408074;7089.539179953286;7122.109736282965;7046.189688185719;7085.185203701641;7117.572945623279;7130.679119439534;7132.179799322937;6305.180326557518;6333.778317758856;6348.873022539431;6353.809385718436;6361.045843123568;6494.772682956074;6552.213734351718;6553.901691474727;6556.2788093310655;6562.409383155348 02:08:38 INFO - PROCESS | 16087 | |4;prototype.html;333.283440602704;333.56802940192455;334.19125715767854;341.8786330852547;342.14293195545156;5833.212516310296;5851.67815770133;5882.529397648189;5895.174675545427;6023.638581685102;5732.5987180897355;5895.292564892208;5897.557683173758;5907.85230369241;5922.703864806753;4601.470830854444;4601.861944141681;4608.423947006624;4614.930776038362;4615.953840461602;4404.4054052702795;4523.117991991563;4529.116822219668;4529.4791099023705;4598.195315819735;4452.6215271701785;4582.793774280149;4595.954040459586;4597.195490789115;4609.446866376023;4571.9542804571865;4582.633389328846;4585.72485650862;4602.516735742733;4603.585677289043;4055.533613634411;4062.106336605942;4064.1058967027207;4071.0840060986043;4072.246634372621;5592.804251851166;5645.040343141676;5672.290963629546;5685.914711279334;5696.487316141567;5344.251804747339;5352.2239275305255;5354.9196762048605;5359.330083739533;5360.91958620621;6037.818865434044;6295.464885484739;6297.716602752887;6306.180196574416;6307.085472606493;4381.07997320563;4425.468943726773;4429.069895321986;4454.198244316021;4470.776461176928;6452.451541618968;6513.283538810727;6588.275289718175;6610.0745895574655;6612.9008064879545;4613;4614.307853821953;4616.099860527165;4616.3998680172035;4617.353570500132;4442.644588432918;4591.563801438858;4609.492955774862;4664.976675116671;4680.321353403738;5286.312779338661;5288.867778305573;5291.497307755757;5295.708736019479;5297.867553311198;6391.392817682313;6401.775937842153;6402.327755585597;6404.391582799627;6404.5837020594445;1584.302906721062;1608.3968511808073;1613.3385312022249;1614.1203044340862;1614.386533117408;1072.0565902006185;1073.2648136026846;1075.5267682219956;1083.0469187115445;1108.7948729485072;6010.2186715726675;6020.277566692025;6022.45797878193;6023.307319658208;6025.18659980897;6541.5093867960095;6551.050097735897;6579.046038324416;6612.173478315211;6626.370494802986;5868.23712917318;5998.3701711320555;6004.939950600438;6008.24896887889;6010.158577799024;3481.4603736420895;3529.6117427083;3530.452779819132;3533.452314891196;3534.8939531814085;6735.191776986793;6770.086038384854;6794.218664853605;6795.694193761293;6803.455723542104;6708.262091169968;6710;6714.731410743613;6715.496337774686;6719.832004199934;6625.801225963229;6825.5222134451105;6866.141732283465;6876.449884009367;6879.89680154788;6314.463270622048;6417.1657684500715;6481.157449531531;6597.472202223907;6612;6486.286508483969;6520.478361731145;6527.67361631926;6528.804135875931;6544.8363790905605;6837.863242735217;6848.554843935129;6850.0752398425575;6856.417204537471;6856.760013399507;4342.565743425758;4526.185286648435;4534.795934182904;4538.659600529907;4560.110778398181;6550.050242714875;6557.475401967927;6560;6561.048647945926;6566.606003639797;6344.429001389897;6347.587406818542;6352.047192921099;6353.904691429725;6358.713857876499;6208.689565521616;6355.078513615592;6378.394052564999;6389.041643753474;6449.677516124081;6281.96859015702;6291.622502649856;6309.3690630936535;6309.842253943688;6313.936860631518;6462.579932304385;6462.676866156579;6463.7737679181;6464.967675161594;6473.190851143607;6187.319394866651;6281.246250449793;6307.05394190875;6320.115183874169;6362.936370636235 02:08:38 INFO - PROCESS | 16087 | |5;yui.html;683.5420268420161;706.5937086175451;758.2455456820463;771.9382449404046;820.9179082091791;13445.865541344583;13630.93184534076;13652.658683532916;13662.248576328311;13746.725065498684;12600.432980515876;12615.116941814076;12630.621081367552;12679;12898.613041608744;652.2075678051167;669.1635455680399;775.4106878772145;803.2208757505225;812.10262659761;802.8474589827944;808.2402541610896;810.2828996338225;810.542043745285;810.5947026486757;839.6473481137906;841.7096101844854;841.8021764885247;841.9410641255115;843.3211264931728;699.3251512290639;712.7968528969245;809.1301850510724;838.9664413423455;842.3345557009955;620.8354785981718;621.0466933257428;621.0652967284209;621.5959626242933;622.0078974036404;11999.100067494974;12021.15851890368;12030.51877924882;12047.03623710101;12082.516699332016;12225.083118766039;12424.316662583555;12446.25322480654;12534.74930501385;12823.230606163566;9269.781825968741;9293.814123717488;9428.811423771485;9431.339806213567;9518.809623807485;3541.1718131433045;3562.4656301554714;3599.2441587266703;3626.546681664792;3639.0356555512544;46614.53385466136;46710.532894670956;46784.76607616974;46897.06205875897;46899.765501172275;10022.749431264278;10168.745781355525;10229.539670714836;10418.895811041944;10691.625793097204;18398.448046558624;18407.079646017646;18410.907945460454;18475.53811154705;18485.7227141593;7159.105111861018;7331.120265568166;7585.506942048749;7604.657790399446;7611.1627720950655;4011.7392369495888;4170.603792639695;4205.2640787862;4231.619154276068;4288.356746488052;3148.9685103148677;3203.8077715337154;3204.8718051277688;3208.326251487214;3225.048610659861;552.033940603943;563.2171281918137;573.1803520964977;604.5103466192398;627.9811605651838;512.6872607709295;566.8469513231404;623.8565130020121;643.2184895352169;667.6961982298043;8632.223099920911;8765.298776097898;8767.561621918878;8779.692710755093;8818.647254109892;602.3374288282854;675.9493038022168;680.5814424129223;681.924988251292;681.9727210911607;4046.7571945683353;4183.895402614898;4185.581441855851;4244.872653820328;4254.553271906405;54863.45136548663;55207.44792552103;55297;55824;55952.440475594725;48284.5171548287;48375;48449.51550484521;48794.268085978736;48839.26741098886;42757.358639620434;43186.56813431825;43958.12083758371;45514.54485455103;45669.54330456653;8405.201505856934;8422.873656895028;8476.36427267945;8633.43882647651;8655.437396569454;32600.51099233466;32623.34753304873;32946.67053329436;33427.83286083554;33639.15902102467;39363.80318098391;41779;42170.1565968685;43255;43286.56713432825;10099.94950025245;10174.389536627827;10204.948975255076;10232.744181395226;10529.999650033235;11024.393658348868;11292.661220163409;11299.830502542633;11480.081593472669;11692.649220523397;10381.63664271777;10652.520636571218;10672.733181670521;11012.614558490415;11025.117990560575;10464.372137671764;10845.403502807421;10966.506507207036;11017.944910275397;11035.668929932115;9772.951135244279;10152.187824973837;10358.689239322832;10526.578936842441;10579.31234469757;8704.651813927372;8807.603657835542;8949.284057275532;9164.129407706258;9195.356325057182;8168.632411541614;8284.627191776264;8621.612027458654;9306;9331.393459425115 02:08:38 INFO - PROCESS | 16087 | __end_tp_report 02:08:38 INFO - PROCESS | 16087 | __start_cc_report 02:08:38 INFO - PROCESS | 16087 | _x_x_mozilla_cycle_collect,722 02:08:38 INFO - PROCESS | 16087 | __end_cc_report 02:08:38 INFO - PROCESS | 16087 | __startTimestamp1453716518785__endTimestamp 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | ------- Summary: start ------- 02:08:38 INFO - PROCESS | 16087 | Number of tests: 6 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#0] dojo.html Cycles:165 Average:5090.17 Median:5256.13 stddev:539.49 (10.3%) stddev-sans-first:517.61 02:08:38 INFO - PROCESS | 16087 | Values: 3081.3 3118.3 3169.3 3173.0 3196.2 4973.3 5036.0 5096.2 5131.2 5160.7 5061.4 5080.7 5105.0 5123.2 5180.5 4578.1 4658.2 4661.0 4706.2 4788.5 4795.0 4809.9 4834.6 4854.1 4866.8 4595.7 4657.6 4666.2 4705.3 4715.2 4670.4 4675.5 4678.8 4683.2 4715.0 4578.3 4653.4 4667.6 4673.7 4697.5 4898.8 4915.0 4931.0 4950.1 4973.8 5506.3 5530.9 5538.2 5540.9 5543.1 5347.2 5436.4 5546.7 5580.2 5599.6 5201.1 5206.5 5228.4 5230.9 5277.0 5536.3 5547.0 5551.4 5551.8 5600.1 5233.7 5298.1 5304.4 5399.6 5442.9 5340.3 5378.5 5388.1 5393.9 5407.2 5455.0 5495.9 5498.8 5500.7 5547.4 5335.4 5361.4 5407.1 5482.8 5487.1 4293.2 4319.0 4320.0 4344.1 4347.2 3760.0 3834.5 3850.5 3875.0 3875.0 4975.5 5049.0 5073.5 5075.8 5077.4 5458.5 5472.2 5491.4 5492.2 5513.5 5071.5 5077.1 5079.9 5082.9 5125.3 4543.8 4644.5 4654.8 4724.2 4765.6 5683.3 5698.6 5705.9 5717.0 5722.1 5502.6 5514.8 5516.5 5522.9 5525.8 5614.7 5689.8 5712.6 5730.5 5783.4 5395.7 5400.1 5408.4 5412.7 5415.0 5365.5 5424.9 5467.0 5477.7 5520.6 5256.1 5273.1 5306.7 5311.4 5341.1 5356.6 5366.2 5385.3 5393.4 5433.8 5143.4 5221.7 5309.5 5311.5 5313.0 5291.5 5320.9 5330.8 5342.9 5399.1 5211.1 5211.6 5216.7 5217.9 5219.0 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#1] ext.html Cycles:180 Average:46330.42 Median:196356.15 stddev:79227.87 (40.3%) stddev-sans-first:79375.38 02:08:38 INFO - PROCESS | 16087 | Values: 494.8 512.0 527.1 533.3 561.4 27994.7 28401.7 28403.9 28407.4 34599.1 38099.4 38740.4 38752.0 38763.2 38793.6 8283.1 8495.0 8496.7 8497.7 8501.9 8212.4 8316.2 8351.0 8351.2 8353.7 8346.1 8376.7 8415.6 8417.0 8615.7 8504.6 8547.5 8580.7 8583.3 8594.7 8462.1 8552.3 8582.4 8588.1 8589.9 39547.6 39832.4 39855.2 39895.0 39974.2 3265.4 3315.3 3324.9 3365.6 3465.4 29887.6 30146.7 30360.0 30549.4 31425.7 3831.7 3888.0 3891.8 3967.4 4083.1 249170.0 249839.0 250915.0 251323.0 251558.0 51196.0 52338.0 52504.0 57995.0 58749.4 60345.4 60828.4 60876.0 60885.0 60919.7 15446.0 15566.3 15652.8 15657.4 15661.4 11826.4 11914.5 11914.8 11921.1 11933.8 17753.1 18139.2 20372.5 20429.8 20921.0 7798.8 7828.5 7904.8 7913.4 7920.4 913.7 953.9 1014.6 1068.6 1102.7 26964.3 27360.5 27733.2 27766.0 27868.9 1047.1 1049.3 1069.7 1112.5 1125.0 14547.3 14632.7 14639.1 14681.6 14829.5 357778.0 359444.0 360689.0 360751.0 361098.0 51745.5 52366.8 52414.5 52461.5 52500.0 1302.3 1312.3 1322.9 1323.6 1328.5 24186.8 30347.0 30427.0 30709.0 30908.7 43376.1 43800.0 44010.6 44043.6 44111.8 280818.0 287223.0 287389.0 287973.0 288137.0 32079.4 32679.7 32681.0 32688.2 42363.6 37781.0 38285.4 38484.6 38682.0 38714.6 32582.2 32935.7 34688.7 34934.3 36601.7 35861.3 36005.0 36474.6 38531.8 38951.2 33030.8 33414.0 33707.5 33781.7 33864.0 29856.0 30422.0 32572.0 32766.3 32767.7 25063.1 31634.8 32863.5 33958.3 33999.2 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#2] jquery.html Cycles:180 Average:26888.99 Median:25052.36 stddev:85201.07 (340.1%) stddev-sans-first:85416.80 02:08:38 INFO - PROCESS | 16087 | Values: 364.2 364.2 364.4 365.2 369.0 13675.5 13961.5 15542.5 15745.8 16469.9 15046.0 15952.9 16313.8 16329.5 16808.3 5322.9 5456.8 5484.9 5490.8 5505.6 4006.1 4169.7 5390.4 5475.3 5754.6 5699.1 5860.4 5932.1 5932.1 5943.8 5764.8 5768.5 5809.0 5809.1 5810.0 4916.1 5104.3 5106.1 5137.7 5140.7 12599.3 12855.5 15507.9 19000.7 19007.1 2074.8 2163.6 2192.1 2214.4 2227.1 9028.7 9525.9 10198.0 10581.0 13200.3 1770.5 1773.4 1811.9 1836.0 1863.1 55633.4 56328.4 57209.7 57573.1 57584.0 9853.4 10027.1 10212.7 10258.5 10263.6 13360.7 13433.9 13442.3 13452.6 13474.3 7306.9 7371.2 7407.7 7469.2 7537.5 7052.7 7142.2 7198.9 7251.4 7276.5 4457.9 4518.9 4532.4 4533.0 4559.3 1690.8 1742.2 1743.6 1772.1 1802.3 872.9 909.6 918.6 948.7 975.6 15985.8 16178.4 16186.0 16585.4 16721.7 884.8 930.4 934.4 985.0 988.3 8718.0 9052.7 9302.8 9784.7 9886.2 512164.0 522090.0 522725.0 523549.0 526847.0 67694.7 70609.6 71304.6 71676.3 71755.0 1152.3 1155.2 1166.6 1177.9 1179.8 14735.5 15165.8 15234.8 15287.6 15371.2 33174.2 33328.0 34344.7 34554.8 34802.0 42392.4 43821.1 44626.6 45117.3 45571.8 7033.7 7059.1 7194.9 7321.2 7519.2 8834.3 10364.4 10396.8 10810.0 10949.2 9127.6 9335.3 9421.1 9584.7 9935.8 9294.3 10013.6 10333.5 10355.3 10483.7 7519.4 7916.8 9593.5 10370.2 10529.5 7232.9 7315.5 7315.7 7349.2 7398.7 7890.6 10144.8 10317.8 10353.2 10508.0 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#3] mootools.html Cycles:180 Average:5507.58 Median:6319.48 stddev:2857.76 (45.2%) stddev-sans-first:2848.21 02:08:38 INFO - PROCESS | 16087 | Values: 1292.5 1417.5 1421.5 1553.8 1739.8 6982.5 7573.2 7740.3 7748.1 7752.2 7462.2 7720.1 7723.3 7725.5 7740.5 2025.3 2078.2 2261.7 2271.7 2300.9 2318.5 2318.6 2323.5 2327.9 2328.3 2221.6 2313.4 2317.5 2318.5 2318.5 2266.7 2297.7 2346.6 2348.8 2349.5 2266.0 2286.6 2292.5 2299.9 2317.4 7881.1 7941.2 7944.6 7947.5 7954.5 4818.5 4934.2 4937.3 4938.8 4941.1 3024.0 3092.4 3112.2 3114.6 3126.3 1022.6 1033.0 1051.5 1060.1 1096.7 11054.3 11077.9 11104.7 11108.6 11116.3 4337.1 4353.3 4389.3 4458.7 4494.2 8732.9 8786.5 8805.3 8806.3 8806.7 4795.8 4819.0 4832.2 4834.6 4835.0 4409.0 4417.5 4467.0 4473.0 4476.2 3364.8 3425.5 3430.9 3602.9 3698.4 1106.6 1142.3 1145.0 1145.5 1148.3 1252.7 1278.5 1284.8 1294.2 1298.4 7194.0 7196.1 7225.7 7370.2 7381.6 1104.3 1109.9 1118.5 1121.5 1144.0 5533.3 5599.3 5609.4 5611.2 5613.2 9190.6 9257.2 9422.8 9564.9 9569.2 9519.4 9527.8 9576.0 9663.1 9687.1 7410.0 7506.1 7582.8 7635.5 7657.8 7027.9 7057.7 7071.2 7076.4 7086.5 8535.7 8625.1 8627.7 8685.5 8856.1 8826.1 8870.2 8984.6 9053.3 9082.7 6888.6 7006.1 7007.9 7014.1 7020.1 6809.7 7010.0 7286.0 7510.0 7511.1 6968.7 7154.2 7185.7 7196.9 7252.4 7018.9 7052.7 7066.1 7089.5 7122.1 7046.2 7085.2 7117.6 7130.7 7132.2 6305.2 6333.8 6348.9 6353.8 6361.0 6494.8 6552.2 6553.9 6556.3 6562.4 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#4] prototype.html Cycles:180 Average:5316.38 Median:6001.66 stddev:1597.50 (26.6%) stddev-sans-first:1557.59 02:08:38 INFO - PROCESS | 16087 | Values: 333.3 333.6 334.2 341.9 342.1 5833.2 5851.7 5882.5 5895.2 6023.6 5732.6 5895.3 5897.6 5907.9 5922.7 4601.5 4601.9 4608.4 4614.9 4616.0 4404.4 4523.1 4529.1 4529.5 4598.2 4452.6 4582.8 4596.0 4597.2 4609.4 4572.0 4582.6 4585.7 4602.5 4603.6 4055.5 4062.1 4064.1 4071.1 4072.2 5592.8 5645.0 5672.3 5685.9 5696.5 5344.3 5352.2 5354.9 5359.3 5360.9 6037.8 6295.5 6297.7 6306.2 6307.1 4381.1 4425.5 4429.1 4454.2 4470.8 6452.5 6513.3 6588.3 6610.1 6612.9 4613.0 4614.3 4616.1 4616.4 4617.4 4442.6 4591.6 4609.5 4665.0 4680.3 5286.3 5288.9 5291.5 5295.7 5297.9 6391.4 6401.8 6402.3 6404.4 6404.6 1584.3 1608.4 1613.3 1614.1 1614.4 1072.1 1073.3 1075.5 1083.0 1108.8 6010.2 6020.3 6022.5 6023.3 6025.2 6541.5 6551.1 6579.0 6612.2 6626.4 5868.2 5998.4 6004.9 6008.2 6010.2 3481.5 3529.6 3530.5 3533.5 3534.9 6735.2 6770.1 6794.2 6795.7 6803.5 6708.3 6710.0 6714.7 6715.5 6719.8 6625.8 6825.5 6866.1 6876.4 6879.9 6314.5 6417.2 6481.2 6597.5 6612.0 6486.3 6520.5 6527.7 6528.8 6544.8 6837.9 6848.6 6850.1 6856.4 6856.8 4342.6 4526.2 4534.8 4538.7 4560.1 6550.1 6557.5 6560.0 6561.0 6566.6 6344.4 6347.6 6352.0 6353.9 6358.7 6208.7 6355.1 6378.4 6389.0 6449.7 6282.0 6291.6 6309.4 6309.8 6313.9 6462.6 6462.7 6463.8 6465.0 6473.2 6187.3 6281.2 6307.1 6320.1 6362.9 02:08:38 INFO - PROCESS | 16087 | 02:08:38 INFO - PROCESS | 16087 | [#5] yui.html Cycles:180 Average:13234.73 Median:46747.65 stddev:15230.93 (32.6%) stddev-sans-first:15244.50 02:08:38 INFO - PROCESS | 16087 | Values: 683.5 706.6 758.2 771.9 820.9 13445.9 13630.9 13652.7 13662.2 13746.7 12600.4 12615.1 12630.6 12679.0 12898.6 652.2 669.2 775.4 803.2 812.1 802.8 808.2 810.3 810.5 810.6 839.6 841.7 841.8 841.9 843.3 699.3 712.8 809.1 839.0 842.3 620.8 621.0 621.1 621.6 622.0 11999.1 12021.2 12030.5 12047.0 12082.5 12225.1 12424.3 12446.3 12534.7 12823.2 9269.8 9293.8 9428.8 9431.3 9518.8 3541.2 3562.5 3599.2 3626.5 3639.0 46614.5 46710.5 46784.8 46897.1 46899.8 10022.7 10168.7 10229.5 10418.9 10691.6 18398.4 18407.1 18410.9 18475.5 18485.7 7159.1 7331.1 7585.5 7604.7 7611.2 4011.7 4170.6 4205.3 4231.6 4288.4 3149.0 3203.8 3204.9 3208.3 3225.0 552.0 563.2 573.2 604.5 628.0 512.7 566.8 623.9 643.2 667.7 8632.2 8765.3 8767.6 8779.7 8818.6 602.3 675.9 680.6 681.9 682.0 4046.8 4183.9 4185.6 4244.9 4254.6 54863.5 55207.4 55297.0 55824.0 55952.4 48284.5 48375.0 48449.5 48794.3 48839.3 42757.4 43186.6 43958.1 45514.5 45669.5 8405.2 8422.9 8476.4 8633.4 8655.4 32600.5 32623.3 32946.7 33427.8 33639.2 39363.8 41779.0 42170.2 43255.0 43286.6 10099.9 10174.4 10204.9 10232.7 10530.0 11024.4 11292.7 11299.8 11480.1 11692.6 10381.6 10652.5 10672.7 11012.6 11025.1 10464.4 10845.4 10966.5 11017.9 11035.7 9773.0 10152.2 10358.7 10526.6 10579.3 8704.7 8807.6 8949.3 9164.1 9195.4 8168.6 8284.6 8621.6 9306.0 9331.4 02:08:38 INFO - PROCESS | 16087 | -------- Summary: end -------- 02:08:38 INFO - PROCESS | 16087 | 02:08:39 INFO - TEST-INFO | 16087: exit 0 02:08:39 INFO - TEST-OK | dromaeo_css | took 1113054ms 02:08:39 INFO - TEST-START | kraken 02:08:39 INFO - operating with platform_type : linux_ 02:08:39 INFO - Initialising browser for kraken test... 02:08:39 INFO - TEST-INFO | started process 16288 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_WvmnX/profile http://localhost:41249/getInfo.html) 02:08:43 INFO - PROCESS | 16288 | __metrics Screen width/height:1600/1200 02:08:43 INFO - PROCESS | 16288 | colorDepth:24 02:08:43 INFO - PROCESS | 16288 | Browser inner width/height: 1024/697 02:08:43 INFO - PROCESS | 16288 | __metrics 02:08:43 INFO - PROCESS | 16288 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:08:43 INFO - PROCESS | 16288 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:45 INFO - TEST-INFO | 16288: exit 0 02:08:45 INFO - Browser initialized. 02:08:45 INFO - Running cycle 1/1 for kraken test... 02:08:45 INFO - TEST-INFO | started process 16372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_WvmnX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:56 INFO - PROCESS | 16372 | RSS: Main: 147873792 02:08:56 INFO - PROCESS | 16372 | 02:08:59 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41249/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:59 INFO - PROCESS | 16372 | RSS: Main: 189456384 02:08:59 INFO - PROCESS | 16372 | 02:09:02 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41249/tests/kraken/driver.html?testName=audio-dft) 02:09:03 INFO - PROCESS | 16372 | RSS: Main: 179863552 02:09:03 INFO - PROCESS | 16372 | 02:09:05 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41249/tests/kraken/driver.html?testName=audio-fft) 02:09:06 INFO - PROCESS | 16372 | RSS: Main: 166096896 02:09:06 INFO - PROCESS | 16372 | 02:09:08 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41249/tests/kraken/driver.html?testName=audio-oscillator) 02:09:09 INFO - PROCESS | 16372 | RSS: Main: 167956480 02:09:09 INFO - PROCESS | 16372 | 02:09:11 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:09:11 INFO - PROCESS | 16372 | RSS: Main: 168562688 02:09:11 INFO - PROCESS | 16372 | 02:09:14 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41249/tests/kraken/driver.html?testName=imaging-darkroom) 02:09:15 INFO - PROCESS | 16372 | RSS: Main: 167084032 02:09:15 INFO - PROCESS | 16372 | 02:09:18 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41249/tests/kraken/driver.html?testName=imaging-desaturate) 02:09:19 INFO - PROCESS | 16372 | RSS: Main: 167600128 02:09:19 INFO - PROCESS | 16372 | 02:09:22 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41249/tests/kraken/driver.html?testName=json-parse-financial) 02:09:22 INFO - PROCESS | 16372 | RSS: Main: 169390080 02:09:22 INFO - PROCESS | 16372 | 02:09:24 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:09:24 INFO - PROCESS | 16372 | RSS: Main: 182407168 02:09:24 INFO - PROCESS | 16372 | 02:09:26 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:09:27 INFO - PROCESS | 16372 | RSS: Main: 180932608 02:09:27 INFO - PROCESS | 16372 | 02:09:29 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:09:29 INFO - PROCESS | 16372 | RSS: Main: 189804544 02:09:29 INFO - PROCESS | 16372 | 02:09:32 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:09:32 INFO - PROCESS | 16372 | RSS: Main: 196771840 02:09:32 INFO - PROCESS | 16372 | 02:09:35 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:09:35 INFO - PROCESS | 16372 | RSS: Main: 195710976 02:09:35 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | Cycle 1(1): loaded http://localhost:41249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41249/tests/kraken/driver.html?testName=ai-astar) 02:09:37 INFO - PROCESS | 16372 | RSS: Main: 257093632 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | __start_tp_report 02:09:37 INFO - PROCESS | 16372 | _x_x_mozilla_page_load 02:09:37 INFO - PROCESS | 16372 | _x_x_mozilla_page_load_details 02:09:37 INFO - PROCESS | 16372 | |i|pagename|runs| 02:09:37 INFO - PROCESS | 16372 | |0;ai-astar;111;113;106;110;109;112;109;110;104;109 02:09:37 INFO - PROCESS | 16372 | |1;audio-beat-detection;152;125;149;163;127;147;146;131;161;123 02:09:37 INFO - PROCESS | 16372 | |2;audio-dft;161;160;161;159;160;161;160;161;162;163 02:09:37 INFO - PROCESS | 16372 | |3;audio-fft;72;73;73;154;74;75;76;73;148;73 02:09:37 INFO - PROCESS | 16372 | |4;audio-oscillator;96;95;151;94;95;102;146;94;96;147 02:09:37 INFO - PROCESS | 16372 | |5;imaging-gaussian-blur;109;109;110;109;109;109;110;109;109;109 02:09:37 INFO - PROCESS | 16372 | |6;imaging-darkroom;149;147;146;146;146;146;146;146;145;146 02:09:37 INFO - PROCESS | 16372 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;95;96 02:09:37 INFO - PROCESS | 16372 | |8;json-parse-financial;55;55;55;54;55;54;53;55;57;53 02:09:37 INFO - PROCESS | 16372 | |9;json-stringify-tinderbox;68;69;68;70;68;69;68;68;68;69 02:09:37 INFO - PROCESS | 16372 | |10;stanford-crypto-aes;88;79;81;80;81;82;81;89;82;82 02:09:37 INFO - PROCESS | 16372 | |11;stanford-crypto-ccm;116;125;123;119;120;114;113;116;114;114 02:09:37 INFO - PROCESS | 16372 | |12;stanford-crypto-pbkdf2;146;137;146;167;148;134;136;149;146;139 02:09:37 INFO - PROCESS | 16372 | |13;stanford-crypto-sha256-iterative;67;70;68;68;66;69;66;67;67;67 02:09:37 INFO - PROCESS | 16372 | __end_tp_report 02:09:37 INFO - PROCESS | 16372 | __start_cc_report 02:09:37 INFO - PROCESS | 16372 | _x_x_mozilla_cycle_collect,941 02:09:37 INFO - PROCESS | 16372 | __end_cc_report 02:09:37 INFO - PROCESS | 16372 | __startTimestamp1453716577901__endTimestamp 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | ------- Summary: start ------- 02:09:37 INFO - PROCESS | 16372 | Number of tests: 14 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.67 (2.4%) stddev-sans-first:2.76 02:09:37 INFO - PROCESS | 16372 | Values: 111.0 113.0 106.0 110.0 109.0 112.0 109.0 110.0 104.0 109.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.00 stddev:14.86 (10.0%) stddev-sans-first:15.35 02:09:37 INFO - PROCESS | 16372 | Values: 152.0 125.0 149.0 163.0 127.0 147.0 146.0 131.0 161.0 123.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 02:09:37 INFO - PROCESS | 16372 | Values: 161.0 160.0 161.0 159.0 160.0 161.0 160.0 161.0 162.0 163.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:32.67 (44.8%) stddev-sans-first:34.07 02:09:37 INFO - PROCESS | 16372 | Values: 72.0 73.0 73.0 154.0 74.0 75.0 76.0 73.0 148.0 73.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:94.50 stddev:25.25 (26.7%) stddev-sans-first:26.14 02:09:37 INFO - PROCESS | 16372 | Values: 96.0 95.0 151.0 94.0 95.0 102.0 146.0 94.0 96.0 147.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:09:37 INFO - PROCESS | 16372 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.06 (0.7%) stddev-sans-first:0.50 02:09:37 INFO - PROCESS | 16372 | Values: 149.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:09:37 INFO - PROCESS | 16372 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.24 02:09:37 INFO - PROCESS | 16372 | Values: 55.0 55.0 55.0 54.0 55.0 54.0 53.0 55.0 57.0 53.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 02:09:37 INFO - PROCESS | 16372 | Values: 68.0 69.0 68.0 70.0 68.0 69.0 68.0 68.0 68.0 69.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:3.31 (4.0%) stddev-sans-first:2.85 02:09:37 INFO - PROCESS | 16372 | Values: 88.0 79.0 81.0 80.0 81.0 82.0 81.0 89.0 82.0 82.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#11] stanford-crypto-ccm Cycles:10 Average:117.40 Median:117.50 stddev:4.17 (3.5%) stddev-sans-first:4.39 02:09:37 INFO - PROCESS | 16372 | Values: 116.0 125.0 123.0 119.0 120.0 114.0 113.0 116.0 114.0 114.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:146.00 stddev:9.51 (6.5%) stddev-sans-first:10.07 02:09:37 INFO - PROCESS | 16372 | Values: 146.0 137.0 146.0 167.0 148.0 134.0 136.0 149.0 146.0 139.0 02:09:37 INFO - PROCESS | 16372 | 02:09:37 INFO - PROCESS | 16372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 02:09:37 INFO - PROCESS | 16372 | Values: 67.0 70.0 68.0 68.0 66.0 69.0 66.0 67.0 67.0 67.0 02:09:37 INFO - PROCESS | 16372 | -------- Summary: end -------- 02:09:37 INFO - PROCESS | 16372 | 02:09:38 INFO - TEST-INFO | 16372: exit 0 02:09:38 INFO - TEST-OK | kraken | took 59308ms 02:09:38 INFO - TEST-START | v8_7 02:09:38 INFO - operating with platform_type : linux_ 02:09:38 INFO - Initialising browser for v8_7 test... 02:09:38 INFO - TEST-INFO | started process 16618 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3ssOEF/profile http://localhost:41249/getInfo.html) 02:09:42 INFO - PROCESS | 16618 | __metrics Screen width/height:1600/1200 02:09:42 INFO - PROCESS | 16618 | colorDepth:24 02:09:42 INFO - PROCESS | 16618 | Browser inner width/height: 1024/697 02:09:42 INFO - PROCESS | 16618 | __metrics 02:09:43 INFO - PROCESS | 16618 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:09:43 INFO - PROCESS | 16618 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:44 INFO - TEST-INFO | 16618: exit 0 02:09:44 INFO - Browser initialized. 02:09:44 INFO - Running cycle 1/1 for v8_7 test... 02:09:44 INFO - TEST-INFO | started process 16699 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3ssOEF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:56 INFO - PROCESS | 16699 | RSS: Main: 148594688 02:09:56 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:41249/tests/v8_7/run.html (next: http://localhost:41249/tests/v8_7/run.html) 02:10:18 INFO - PROCESS | 16699 | RSS: Main: 581419008 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | __start_tp_report 02:10:18 INFO - PROCESS | 16699 | _x_x_mozilla_page_load 02:10:18 INFO - PROCESS | 16699 | _x_x_mozilla_page_load_details 02:10:18 INFO - PROCESS | 16699 | |i|pagename|runs| 02:10:18 INFO - PROCESS | 16699 | |0;Richards;167.7008217340265 02:10:18 INFO - PROCESS | 16699 | |1;DeltaBlue;203.334688897926 02:10:18 INFO - PROCESS | 16699 | |2;Encrypt;284.9814762040467 02:10:18 INFO - PROCESS | 16699 | |3;Decrypt;5218.75 02:10:18 INFO - PROCESS | 16699 | |4;RayTrace;1126.126126126126 02:10:18 INFO - PROCESS | 16699 | |5;Earley;786.1635220125786 02:10:18 INFO - PROCESS | 16699 | |6;Boyer;12280.487804878048 02:10:18 INFO - PROCESS | 16699 | |7;RegExp;42416.666666666664 02:10:18 INFO - PROCESS | 16699 | |8;Splay;588.5815185403178 02:10:18 INFO - PROCESS | 16699 | |9;NavierStokes;4830.917874396136 02:10:18 INFO - PROCESS | 16699 | __end_tp_report 02:10:18 INFO - PROCESS | 16699 | __startTimestamp1453716618932__endTimestamp 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | ------- Summary: start ------- 02:10:18 INFO - PROCESS | 16699 | Number of tests: 10 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 167.7 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#1] DeltaBlue Cycles:1 Average:203.33 Median:203.33 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 203.3 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#2] Encrypt Cycles:1 Average:284.98 Median:284.98 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 285.0 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 5218.8 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#4] RayTrace Cycles:1 Average:1126.13 Median:1126.13 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 1126.1 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 786.2 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 12280.5 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#7] RegExp Cycles:1 Average:42416.67 Median:42416.67 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 42416.7 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#8] Splay Cycles:1 Average:588.58 Median:588.58 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 588.6 02:10:18 INFO - PROCESS | 16699 | 02:10:18 INFO - PROCESS | 16699 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:10:18 INFO - PROCESS | 16699 | Values: 4830.9 02:10:18 INFO - PROCESS | 16699 | -------- Summary: end -------- 02:10:18 INFO - PROCESS | 16699 | 02:10:19 INFO - TEST-INFO | 16699: exit 0 02:10:19 INFO - TEST-OK | v8_7 | took 41020ms 02:10:19 INFO - SUITE-END | took 1213s 02:10:19 INFO - Completed test suite (00:20:13) 02:10:19 INFO - Working with test: dromaeo_css 02:10:19 INFO - Generating results file: dromaeo_css 02:10:19 INFO - Working with test: kraken 02:10:19 INFO - Generating results file: kraken 02:10:19 INFO - javascript benchmark 02:10:19 INFO - Working with test: v8_7 02:10:19 INFO - Generating results file: v8_7 02:10:19 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:10:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 02:10:19 INFO - process_Request line: dromaeo_css 6801.46 graph.html#tests=[[72,201,35]] 02:10:19 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:10:20 INFO - process_Request line: kraken 1499.80 graph.html#tests=[[232,201,35]] 02:10:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:10:20 INFO - process_Request line: v8_7 19853.45 graph.html#tests=[[230,201,35]] 02:10:20 INFO - RETURN: dromaeo_css: 6801.46 02:10:20 INFO - RETURN: kraken: 1499.80 02:10:20 INFO - RETURN: v8_7: 19853.45 02:10:20 INFO - javascript benchmark 02:10:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3081.2604974806054, 3118.2827949571597, 3169.28691044515, 3172.9841350793245, 3196.1530194498455, 4973.328600638913, 5035.9748201259035, 5096.210087436449, 5131.153359695651, 5160.716160611165, 5061.367329083864, 5080.695158290505, 5105.0, 5123.205903085019, 5180.533751962323, 4578.061497393026, 4658.231391820345, 4660.998019448117, 4706.176419126639, 4788.473267940523, 4794.976025119887, 4809.855704328876, 4834.637402194832, 4854.077725232212, 4866.756662166895, 4595.701279416827, 4657.580817726421, 4666.160091183586, 4705.341252224691, 4715.245560710304, 4670.416197975253, 4675.485696573374, 4678.836240731592, 4683.180443422388, 4714.986277950257, 4578.2903649934315, 4653.395058642389, 4667.6265898728025, 4673.696209746389, 4697.506761790031, 4898.804047838083, 4915.016996600694, 4931.0, 4950.133726597831, 4973.776180071869, 5506.256655351516, 5530.889382212334, 5538.169274608841, 5540.86147846303, 5543.113101903717, 5347.171188465794, 5436.401995780461, 5546.69493177875, 5580.246666700024, 5599.580031497613, 5201.141811601081, 5206.479352064801, 5228.424873263938, 5230.947690523084, 5277.023750606112, 5536.280283563111, 5547.0, 5551.3893471718075, 5551.833444996657, 5600.075987462104, 5233.659812112201, 5298.072837253465, 5304.363476382859, 5399.568034557305, 5442.863928401822, 5340.25236466895, 5378.515933565998, 5388.13789793639, 5393.865153371119, 5407.188921661704, 5455.0453670607485, 5495.862603434866, 5498.780048798003, 5500.697461639568, 5547.445255474501, 5335.3864305604575, 5361.410244873061, 5407.134858422713, 5482.835514934558, 5487.122060470386, 4293.162833247549, 4319.0, 4319.956800432018, 4344.066025804404, 4347.217500849877, 3759.981200094037, 3834.5206849143856, 3850.537935447764, 3874.9806250969127, 3875.0, 4975.502449755068, 5049.040682270357, 5073.492650734897, 5075.847724568269, 5077.365329333833, 5458.4814442627885, 5472.20653005312, 5491.36849262332, 5492.176173573996, 5513.531349835229, 5071.46749591295, 5077.136886729265, 5079.923801142986, 5082.949170508247, 5125.308083408767, 4543.818247270138, 4644.465886423104, 4654.813807447664, 4724.220503616864, 4765.618750499952, 5683.346415162227, 5698.601097923106, 5705.885882282331, 5717.0, 5722.055860782924, 5502.614816962774, 5514.779408823762, 5516.503514683698, 5522.895420915913, 5525.778968841362, 5614.6631202128, 5689.800856969986, 5712.571557133315, 5730.484256416942, 5783.392743762012, 5395.730213489388, 5400.135978243462, 5408.405075441619, 5412.7293635318865, 5415.025295446857, 5365.517103460707, 5424.945750542602, 5467.043267428105, 5477.67133971963, 5520.558355331484, 5256.132738098171, 5273.103572392779, 5306.734663266899, 5311.415744268204, 5341.092014357646, 5356.57147428197, 5366.2487251784005, 5385.3268341457315, 5393.352797664305, 5433.8369848904595, 5143.4085080216255, 5221.712805795566, 5309.46905309466, 5311.548518375981, 5313.0, 5291.470852914677, 5320.920186197132, 5330.78676852937, 5342.866428339323, 5399.136138217867, 5211.114110601131, 5211.583073354198, 5216.739163041909, 5217.947820521898, 5219.034478621467], "unit": "score", "name": "dojo.html", "value": 5057.134226878093}, {"lowerIsBetter": false, "replicates": [494.787241486161, 511.96416250862444, 527.1276038156851, 533.3306700091384, 561.3964987638288, 27994.720052799465, 28401.715982840164, 28403.857980710094, 28407.431851363013, 34599.135021624475, 38099.4285085724, 38740.41889371662, 38752.0, 38763.22473550534, 38793.61206387935, 8283.130271321515, 8495.0, 8496.745097647081, 8497.74506764795, 8501.872471912926, 8212.425130240885, 8316.209960053786, 8351.0, 8351.20663536963, 8353.665853365857, 8346.081930987586, 8376.748697539084, 8415.621297041647, 8417.032041315266, 8615.741527754146, 8504.574771261443, 8547.487150770974, 8580.699675511358, 8583.270422014137, 8594.742157735278, 8462.111478294813, 8552.315814734806, 8582.442141260799, 8588.098249683755, 8589.871151932726, 39547.60452395468, 39832.40251396231, 39855.20289594221, 39895.0, 39974.20051598952, 3265.4035269142246, 3315.287213249139, 3324.8670053197843, 3365.612954510238, 3465.42820434628, 29887.551686724717, 30146.698533014827, 30360.0, 30549.389012219854, 31425.685743142505, 3831.6934645228316, 3887.961120388788, 3891.8443262269475, 3967.4247234151176, 4083.060895993938, 249170.0, 249839.0, 250915.0, 251323.0, 251558.0, 51196.0, 52337.999999999236, 52504.0, 57995.0, 58749.412505874396, 60345.396546034855, 60828.391716083155, 60876.0, 60885.0, 60919.69540152271, 15446.0, 15566.299516521784, 15652.765208521882, 15657.37370505167, 15661.373545058297, 11826.408679566159, 11914.52341906314, 11914.821277680841, 11921.105917056255, 11933.76132477363, 17753.11234438273, 18139.183736731615, 20372.490687732927, 20429.79570204279, 20921.0, 7798.8050298741855, 7828.491148075471, 7904.762857114296, 7913.446058775946, 7920.366370690331, 913.7441516375426, 953.880764904387, 1014.5688082564881, 1068.647346375694, 1102.729831191347, 26964.32589185247, 27360.45279094407, 27733.168004959884, 27766.028189013286, 27868.860655696593, 1047.0838016735356, 1049.3441599000626, 1069.6946435514299, 1112.4580333936915, 1124.9718757030976, 14547.3453694584, 14632.685155138499, 14639.121652700873, 14681.632959175893, 14829.480968166277, 357778.0, 359444.0, 360689.0, 360751.0, 361098.0, 51745.48254517407, 52366.8106551475, 52414.47585524096, 52461.47538524642, 52500.0, 1302.2707283921034, 1312.25201635069, 1322.8743269389586, 1323.5830713325272, 1328.4686125549858, 24186.75813241845, 30347.0, 30427.0, 30709.0, 30908.69091309058, 43376.132477350904, 43800.0, 44010.55989440065, 44043.55956440523, 44111.77944110259, 280818.0, 287223.0, 287389.0, 287973.0, 288137.0, 32079.35841283208, 32679.673203267663, 32681.0, 32688.182795430304, 42363.5763642372, 37781.0, 38285.42571861369, 38484.61515384923, 38682.0, 38714.6128538711, 32582.185445364055, 32935.67064329326, 34688.653113469554, 34934.30131397409, 36601.71893983698, 35861.28277434385, 36005.0, 36474.635253647124, 38531.80734096312, 38951.22097557976, 33030.834845826575, 33414.0, 33707.494387584695, 33781.66218337785, 33864.0, 29856.0, 30422.0, 32572.0, 32766.344673105927, 32767.672323276463, 25063.122790702237, 31634.841825790725, 32863.507047394785, 33958.32083358368, 33999.15002124967], "unit": "score", "name": "ext.html", "value": 18190.938406522826}, {"lowerIsBetter": false, "replicates": [364.2351062768187, 364.2405584356618, 364.3841907176871, 365.1546669460199, 368.9723270754694, 13675.521356752515, 13961.511347102853, 15542.53372398827, 15745.84254157458, 16469.917650411746, 15046.0, 15952.920235398808, 16313.83686163138, 16329.510114696579, 16808.32766689334, 5322.920156197651, 5456.836294911159, 5484.945150548503, 5490.835274941758, 5505.587080968923, 4006.118653896153, 4169.708120431571, 5390.380106287768, 5475.260839786618, 5754.625949313302, 5699.145128230778, 5860.355360910296, 5932.080527518242, 5932.139839723238, 5943.762249510014, 5764.7982320618785, 5768.509676677488, 5809.04150815115, 5809.099589563603, 5809.9709501452435, 4916.115099282128, 5104.285400043997, 5106.08090543702, 5137.717425541594, 5140.665856719302, 12599.3070381129, 12855.485780568766, 15507.92246038774, 19000.714989275173, 19007.144678489363, 2074.7925207479284, 2163.621366260898, 2192.1012384922105, 2214.413180507167, 2227.0646328542052, 9028.683996060172, 9525.904740952572, 10198.023259874908, 10581.047705706447, 13200.273984930825, 1770.5485101299087, 1773.3704534890187, 1811.936582219616, 1835.9541011474687, 1863.0777765006274, 55633.44366556323, 56328.436715633135, 57209.71395143039, 57573.13640295399, 57584.0, 9853.408795472295, 10027.147692446224, 10212.744681383025, 10258.487075646188, 10263.640772572924, 13360.6659833503, 13433.932830335785, 13442.260675662737, 13452.596422107352, 13474.258915759532, 7306.853862922818, 7371.226021267797, 7407.703691852374, 7469.178390377054, 7537.4723769336715, 7052.726341286278, 7142.21435642079, 7198.892016619755, 7251.419886409075, 7276.490645654753, 4457.888552786207, 4518.909621807546, 4532.388127602798, 4532.954670453253, 4559.270516717309, 1690.8055573608947, 1742.224710004036, 1743.625120599052, 1772.0785191700243, 1802.270080617352, 872.882160908282, 909.5725009245645, 918.5958178401482, 948.7153853843819, 975.6048800235916, 15985.760213596805, 16178.352865885232, 16186.0, 16585.419510317082, 16721.749173762404, 884.8009197930543, 930.4138392812484, 934.4206591913057, 985.0494273026563, 988.3279370028449, 8718.041015488292, 9052.683156089506, 9302.813943721088, 9784.657536986313, 9886.15967642744, 512164.0, 522090.0, 522725.0, 523549.0, 526847.0, 67694.66152669206, 70609.64695176491, 71304.64347678228, 71676.283237168, 71755.0, 1152.302856771641, 1155.2086820527966, 1166.6441735270655, 1177.8586569611703, 1179.7522520270838, 14735.484258050918, 15165.772513412086, 15234.771478428054, 15287.61780955485, 15371.15458649785, 33174.17064573405, 33328.0, 34344.65655343515, 34554.82722586371, 34802.0, 42392.36411453893, 43821.12357752764, 44626.55373446224, 45117.32324015077, 45571.772141140405, 7033.683484243119, 7059.117610298713, 7194.856102878018, 7321.15806682217, 7519.248075192437, 8834.29325653959, 10364.429956352473, 10396.792064158522, 10810.0, 10949.178811589003, 9127.589258483516, 9335.346525743404, 9421.104995025462, 9584.66453674118, 9935.751606209613, 9294.302927280345, 10013.599456021677, 10333.534990925576, 10355.275130740776, 10483.68548943533, 7519.436042296959, 7916.802079948047, 9593.520323983912, 10370.170386368922, 10529.4735263235, 7232.855342893218, 7315.524490908074, 7315.743948961761, 7349.228331025165, 7398.741044063432, 7890.566018868788, 10144.847827282449, 10317.845232321672, 10353.17174626013, 10508.0], "unit": "score", "name": "jquery.html", "value": 8116.911584630873}, {"lowerIsBetter": false, "replicates": [1292.4636275945484, 1417.4826188441218, 1421.5095791951774, 1553.7824704541367, 1739.791225052994, 6982.511224214307, 7573.166951635322, 7740.303372696456, 7748.108967468743, 7752.186020467854, 7462.21646727094, 7720.112187098485, 7723.304902558769, 7725.459217854753, 7740.458167928233, 2025.2709024751077, 2078.199893041175, 2261.7172853393367, 2271.659251112338, 2300.8734519601417, 2318.5015221727326, 2318.5826551220775, 2323.546908352872, 2327.94180145496, 2328.2898715891647, 2221.6334304839684, 2313.4447732544236, 2317.5249073939885, 2318.455163036685, 2318.547883162784, 2266.7279926408855, 2297.6783250344965, 2346.565885311206, 2348.765123487663, 2349.4596242864236, 2266.0369343029147, 2286.5769832581027, 2292.495650956787, 2299.8620082795087, 2317.3627252505526, 7881.09367422748, 7941.205879412013, 7944.642491087915, 7947.483413578099, 7954.522728636242, 4818.518148185189, 4934.235193545006, 4937.259411088329, 4938.827141050046, 4941.061198372297, 3023.9848800755854, 3092.38152369527, 3112.2219445138717, 3114.6106736657916, 3126.3434678717495, 1022.6216299969059, 1032.9567137191416, 1051.5215576912487, 1060.1095080132725, 1096.6709987003867, 11054.281471704313, 11077.889221107765, 11104.722381940435, 11108.61119860809, 11116.333020018745, 4337.067530480898, 4353.281708518122, 4389.275769498061, 4458.6878918475395, 4494.213512635341, 8732.91267087321, 8786.472811631322, 8805.295576353876, 8806.25146862511, 8806.691765788166, 4795.760211989386, 4819.036192761461, 4832.226843704991, 4834.589059929875, 4834.95165048352, 4408.955910440919, 4417.491988421309, 4467.0, 4472.955270447319, 4476.216662084123, 3364.8317584120696, 3425.469052296898, 3430.879919202816, 3602.945955810665, 3698.3712768829364, 1106.6126855600476, 1142.3146112332533, 1145.0, 1145.5417832866754, 1148.2593727046008, 1252.6868282929267, 1278.5397256987478, 1284.7687416265162, 1294.1652634051172, 1298.4092238031674, 7193.964030179815, 7196.136463624399, 7225.747098851515, 7370.189279179286, 7381.557106573623, 1104.3484344236938, 1109.9056580190775, 1118.5358076398365, 1121.472907733364, 1144.0390072339276, 5533.3083364579425, 5599.272094627672, 5609.411011843697, 5611.186377975252, 5613.242212301368, 9190.632374704937, 9257.166854982948, 9422.764430889145, 9564.856527152098, 9569.186619137452, 9519.381240219363, 9527.761805954768, 9576.0, 9663.082007209305, 9687.128158465772, 7409.962950185214, 7506.13679426862, 7582.810429739301, 7635.503692259986, 7657.846843063107, 7027.859442811217, 7057.7176912922905, 7071.222165561681, 7076.398506127037, 7086.50394472382, 8535.743927682179, 8625.137486251324, 8627.654893804429, 8685.478871267744, 8856.114388561093, 8826.073262307622, 8870.201681848665, 8984.550772461482, 9053.275737940818, 9082.682106126254, 6888.552244104118, 7006.054182685272, 7007.859842803014, 7014.088168538057, 7020.052292940388, 6809.69356378974, 7009.9649501752165, 7286.0, 7510.0, 7511.06111736033, 6968.686409111703, 7154.177269614061, 7185.712571497291, 7196.856062878608, 7252.383547398319, 7018.894716579153, 7052.717891284291, 7066.116735408074, 7089.539179953286, 7122.109736282965, 7046.189688185719, 7085.185203701641, 7117.572945623279, 7130.679119439534, 7132.179799322937, 6305.180326557518, 6333.778317758856, 6348.873022539431, 6353.809385718436, 6361.045843123568, 6494.772682956074, 6552.213734351718, 6553.901691474727, 6556.2788093310655, 6562.409383155348], "unit": "score", "name": "mootools.html", "value": 4528.510626383163}, {"lowerIsBetter": false, "replicates": [333.283440602704, 333.56802940192455, 334.19125715767854, 341.8786330852547, 342.14293195545156, 5833.212516310296, 5851.67815770133, 5882.529397648189, 5895.174675545427, 6023.638581685102, 5732.5987180897355, 5895.292564892208, 5897.557683173758, 5907.85230369241, 5922.703864806753, 4601.470830854444, 4601.861944141681, 4608.423947006624, 4614.930776038362, 4615.953840461602, 4404.4054052702795, 4523.117991991563, 4529.116822219668, 4529.4791099023705, 4598.195315819735, 4452.6215271701785, 4582.793774280149, 4595.954040459586, 4597.195490789115, 4609.446866376023, 4571.9542804571865, 4582.633389328846, 4585.72485650862, 4602.516735742733, 4603.585677289043, 4055.533613634411, 4062.106336605942, 4064.1058967027207, 4071.0840060986043, 4072.246634372621, 5592.804251851166, 5645.040343141676, 5672.290963629546, 5685.914711279334, 5696.487316141567, 5344.251804747339, 5352.2239275305255, 5354.9196762048605, 5359.330083739533, 5360.91958620621, 6037.818865434044, 6295.464885484739, 6297.716602752887, 6306.180196574416, 6307.085472606493, 4381.07997320563, 4425.468943726773, 4429.069895321986, 4454.198244316021, 4470.776461176928, 6452.451541618968, 6513.283538810727, 6588.275289718175, 6610.0745895574655, 6612.9008064879545, 4613.0, 4614.307853821953, 4616.099860527165, 4616.3998680172035, 4617.353570500132, 4442.644588432918, 4591.563801438858, 4609.492955774862, 4664.976675116671, 4680.321353403738, 5286.312779338661, 5288.867778305573, 5291.497307755757, 5295.708736019479, 5297.867553311198, 6391.392817682313, 6401.775937842153, 6402.327755585597, 6404.391582799627, 6404.5837020594445, 1584.302906721062, 1608.3968511808073, 1613.3385312022249, 1614.1203044340862, 1614.386533117408, 1072.0565902006185, 1073.2648136026846, 1075.5267682219956, 1083.0469187115445, 1108.7948729485072, 6010.2186715726675, 6020.277566692025, 6022.45797878193, 6023.307319658208, 6025.18659980897, 6541.5093867960095, 6551.050097735897, 6579.046038324416, 6612.173478315211, 6626.370494802986, 5868.23712917318, 5998.3701711320555, 6004.939950600438, 6008.24896887889, 6010.158577799024, 3481.4603736420895, 3529.6117427083, 3530.452779819132, 3533.452314891196, 3534.8939531814085, 6735.191776986793, 6770.086038384854, 6794.218664853605, 6795.694193761293, 6803.455723542104, 6708.262091169968, 6710.0, 6714.731410743613, 6715.496337774686, 6719.832004199934, 6625.801225963229, 6825.5222134451105, 6866.141732283465, 6876.449884009367, 6879.89680154788, 6314.463270622048, 6417.1657684500715, 6481.157449531531, 6597.472202223907, 6612.0, 6486.286508483969, 6520.478361731145, 6527.67361631926, 6528.804135875931, 6544.8363790905605, 6837.863242735217, 6848.554843935129, 6850.0752398425575, 6856.417204537471, 6856.760013399507, 4342.565743425758, 4526.185286648435, 4534.795934182904, 4538.659600529907, 4560.110778398181, 6550.050242714875, 6557.475401967927, 6560.0, 6561.048647945926, 6566.606003639797, 6344.429001389897, 6347.587406818542, 6352.047192921099, 6353.904691429725, 6358.713857876499, 6208.689565521616, 6355.078513615592, 6378.394052564999, 6389.041643753474, 6449.677516124081, 6281.96859015702, 6291.622502649856, 6309.3690630936535, 6309.842253943688, 6313.936860631518, 6462.579932304385, 6462.676866156579, 6463.7737679181, 6464.967675161594, 6473.190851143607, 6187.319394866651, 6281.246250449793, 6307.05394190875, 6320.115183874169, 6362.936370636235], "unit": "score", "name": "prototype.html", "value": 4796.87549776827}, {"lowerIsBetter": false, "replicates": [683.5420268420161, 706.5937086175451, 758.2455456820463, 771.9382449404046, 820.9179082091791, 13445.865541344583, 13630.93184534076, 13652.658683532916, 13662.248576328311, 13746.725065498684, 12600.432980515876, 12615.116941814076, 12630.621081367552, 12679.0, 12898.613041608744, 652.2075678051167, 669.1635455680399, 775.4106878772145, 803.2208757505225, 812.10262659761, 802.8474589827944, 808.2402541610896, 810.2828996338225, 810.542043745285, 810.5947026486757, 839.6473481137906, 841.7096101844854, 841.8021764885247, 841.9410641255115, 843.3211264931728, 699.3251512290639, 712.7968528969245, 809.1301850510724, 838.9664413423455, 842.3345557009955, 620.8354785981718, 621.0466933257428, 621.0652967284209, 621.5959626242933, 622.0078974036404, 11999.100067494974, 12021.15851890368, 12030.51877924882, 12047.03623710101, 12082.516699332016, 12225.083118766039, 12424.316662583555, 12446.25322480654, 12534.74930501385, 12823.230606163566, 9269.781825968741, 9293.814123717488, 9428.811423771485, 9431.339806213567, 9518.809623807485, 3541.1718131433045, 3562.4656301554714, 3599.2441587266703, 3626.546681664792, 3639.0356555512544, 46614.53385466136, 46710.532894670956, 46784.76607616974, 46897.06205875897, 46899.765501172275, 10022.749431264278, 10168.745781355525, 10229.539670714836, 10418.895811041944, 10691.625793097204, 18398.448046558624, 18407.079646017646, 18410.907945460454, 18475.53811154705, 18485.7227141593, 7159.105111861018, 7331.120265568166, 7585.506942048749, 7604.657790399446, 7611.1627720950655, 4011.7392369495888, 4170.603792639695, 4205.2640787862, 4231.619154276068, 4288.356746488052, 3148.9685103148677, 3203.8077715337154, 3204.8718051277688, 3208.326251487214, 3225.048610659861, 552.033940603943, 563.2171281918137, 573.1803520964977, 604.5103466192398, 627.9811605651838, 512.6872607709295, 566.8469513231404, 623.8565130020121, 643.2184895352169, 667.6961982298043, 8632.223099920911, 8765.298776097898, 8767.561621918878, 8779.692710755093, 8818.647254109892, 602.3374288282854, 675.9493038022168, 680.5814424129223, 681.924988251292, 681.9727210911607, 4046.7571945683353, 4183.895402614898, 4185.581441855851, 4244.872653820328, 4254.553271906405, 54863.45136548663, 55207.44792552103, 55297.0, 55824.0, 55952.440475594725, 48284.5171548287, 48375.0, 48449.51550484521, 48794.268085978736, 48839.26741098886, 42757.358639620434, 43186.56813431825, 43958.12083758371, 45514.54485455103, 45669.54330456653, 8405.201505856934, 8422.873656895028, 8476.36427267945, 8633.43882647651, 8655.437396569454, 32600.51099233466, 32623.34753304873, 32946.67053329436, 33427.83286083554, 33639.15902102467, 39363.80318098391, 41779.0, 42170.1565968685, 43255.0, 43286.56713432825, 10099.94950025245, 10174.389536627827, 10204.948975255076, 10232.744181395226, 10529.999650033235, 11024.393658348868, 11292.661220163409, 11299.830502542633, 11480.081593472669, 11692.649220523397, 10381.63664271777, 10652.520636571218, 10672.733181670521, 11012.614558490415, 11025.117990560575, 10464.372137671764, 10845.403502807421, 10966.506507207036, 11017.944910275397, 11035.668929932115, 9772.951135244279, 10152.187824973837, 10358.689239322832, 10526.578936842441, 10579.31234469757, 8704.651813927372, 8807.603657835542, 8949.284057275532, 9164.129407706258, 9195.356325057182, 8168.632411541614, 8284.627191776264, 8621.612027458654, 9306.0, 9331.393459425115], "unit": "score", "name": "yui.html", "value": 6102.5622403312655}], "name": "dromaeo_css", "value": 6801.463388758888}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 110.0, 109.0, 112.0, 109.0, 110.0, 104.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 149.0, 163.0, 127.0, 147.0, 146.0, 131.0, 161.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 159.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 154.0, 74.0, 75.0, 76.0, 73.0, 148.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 151.0, 94.0, 95.0, 102.0, 146.0, 94.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 53.0, 55.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 70.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [88.0, 79.0, 81.0, 80.0, 81.0, 82.0, 81.0, 89.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [116.0, 125.0, 123.0, 119.0, 120.0, 114.0, 113.0, 116.0, 114.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 137.0, 146.0, 167.0, 148.0, 134.0, 136.0, 149.0, 146.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 68.0, 66.0, 69.0, 66.0, 67.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1499.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [203.334688897926], "unit": "score", "name": "DeltaBlue", "value": 325.168324}, {"lowerIsBetter": false, "replicates": [284.9814762040467], "unit": "score", "name": "Encrypt", "value": 934.0291290000002}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1126.126126126126], "unit": "score", "name": "RayTrace", "value": 657.110232}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [42416.666666666664], "unit": "score", "name": "RegExp", "value": 21.47705304518664}, {"lowerIsBetter": false, "replicates": [588.5815185403178], "unit": "score", "name": "Splay", "value": 138.453209}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19853.448595624133}]} 02:10:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19853.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1499.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6801.46"}}} 02:10:20 INFO - Return code: 0 02:10:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:10:20 INFO - # TBPL SUCCESS # 02:10:20 INFO - Running post-action listener: _resource_record_post_action 02:10:20 INFO - Running post-run listener: _resource_record_post_run 02:10:21 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 564109312; Read time: 12; Write time: 1163748 02:10:21 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 254959616; Read time: 0; Write time: 622128 02:10:21 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309149696; Read time: 12; Write time: 541620 02:10:21 INFO - Running post-run listener: _upload_blobber_files 02:10:21 INFO - Blob upload gear active. 02:10:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:10:21 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:10:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:10:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:10:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:10:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:10:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:10:22 INFO - (blobuploader) - INFO - Done attempting. 02:10:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:10:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:10:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:10:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:10:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:10:23 INFO - (blobuploader) - INFO - Done attempting. 02:10:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:10:23 INFO - Return code: 0 02:10:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:10:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:10:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/085b4ad933c5d6004cceb64ef1b21a6c4faae355d12074bdf0f245326cb06094927e180282eb63657d7c362636e5a17e1840e1bc38c96f3b42a1e6b32d0b5bb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dd1a50588f9bf863dab56d5f539df7ca938d6d45ab72093fa738dc3185a8f86f9ed29ed4346cad35a1f131e33d2324c3076e534fa1b7f442834820857f87fbe6"} 02:10:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:10:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:10:23 INFO - Contents: 02:10:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/085b4ad933c5d6004cceb64ef1b21a6c4faae355d12074bdf0f245326cb06094927e180282eb63657d7c362636e5a17e1840e1bc38c96f3b42a1e6b32d0b5bb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dd1a50588f9bf863dab56d5f539df7ca938d6d45ab72093fa738dc3185a8f86f9ed29ed4346cad35a1f131e33d2324c3076e534fa1b7f442834820857f87fbe6"} 02:10:23 INFO - Running post-run listener: copy_logs_to_upload_dir 02:10:23 INFO - Copying logs to upload dir... 02:10:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:10:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.115035 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 02:10:23.668938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 02:10:23.672619) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/085b4ad933c5d6004cceb64ef1b21a6c4faae355d12074bdf0f245326cb06094927e180282eb63657d7c362636e5a17e1840e1bc38c96f3b42a1e6b32d0b5bb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dd1a50588f9bf863dab56d5f539df7ca938d6d45ab72093fa738dc3185a8f86f9ed29ed4346cad35a1f131e33d2324c3076e534fa1b7f442834820857f87fbe6"} build_url:https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011555 build_url: 'https://queue.taskcluster.net/v1/task/Ai_p_IoARlWFif8k5tEMbQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/085b4ad933c5d6004cceb64ef1b21a6c4faae355d12074bdf0f245326cb06094927e180282eb63657d7c362636e5a17e1840e1bc38c96f3b42a1e6b32d0b5bb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/dd1a50588f9bf863dab56d5f539df7ca938d6d45ab72093fa738dc3185a8f86f9ed29ed4346cad35a1f131e33d2324c3076e534fa1b7f442834820857f87fbe6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 02:10:23.696778) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:10:23.697090) ========= 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=8783db0840cc980e80bb0bd400000236-1453712574.240473-2004096903 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:10:23.782176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:10:23.782499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:10:23.782839) ========= ========= Total master_lag: 0.28 =========