builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1453753883.25 results: success (0) buildid: 20160125100829 builduid: dc7f62d8282d461c9d2986d8b7f0be12 revision: af58efa23494fda1b3173ee88835b5cff4ad52e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.245521) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.245926) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.246218) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006254 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.275659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.275956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.289987) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.290253) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.339051) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.339341) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.342758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.343061) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 12:31:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 193M=0s 2016-01-25 12:31:24 (193 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.566344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.566688) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013889 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.613289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:23.613645) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af58efa23494fda1b3173ee88835b5cff4ad52e6 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af58efa23494fda1b3173ee88835b5cff4ad52e6 --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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 12:31:24,177 truncating revision to first 12 chars 2016-01-25 12:31:24,177 Setting DEBUG logging. 2016-01-25 12:31:24,177 attempt 1/10 2016-01-25 12:31:24,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af58efa23494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 12:31:24,607 unpacking tar archive at: mozilla-aurora-af58efa23494/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:24.363517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:24.363862) ========= echo af58efa23494fda1b3173ee88835b5cff4ad52e6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af58efa23494fda1b3173ee88835b5cff4ad52e6'] 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False af58efa23494fda1b3173ee88835b5cff4ad52e6 program finished with exit code 0 elapsedTime=0.004683 script_repo_revision: 'af58efa23494fda1b3173ee88835b5cff4ad52e6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:24.413710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:24.413981) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 12:31:24.423739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 12:31:24.424005) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:31:25 INFO - MultiFileLogger online at 20160125 12:31:25 in /builds/slave/test-pgo 12:31:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:31:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:31:25 INFO - {'append_to_log': False, 12:31:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:31:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:31:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:31:25 INFO - 'branch': 'Mozilla-Aurora', 12:31:25 INFO - 'buildbot_json_path': 'buildprops.json', 12:31:25 INFO - 'config_files': ('talos/linux_config.py',), 12:31:25 INFO - 'default_actions': ('clobber', 12:31:25 INFO - 'read-buildbot-config', 12:31:25 INFO - 'download-and-extract', 12:31:25 INFO - 'populate-webroot', 12:31:25 INFO - 'create-virtualenv', 12:31:25 INFO - 'install', 12:31:25 INFO - 'run-tests'), 12:31:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:31:25 INFO - 'download_minidump_stackwalk': True, 12:31:25 INFO - 'download_symbols': 'ondemand', 12:31:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:31:25 INFO - 'tooltool.py': '/tools/tooltool.py', 12:31:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:31:25 INFO - '/tools/misc-python/virtualenv.py')}, 12:31:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:31:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:31:25 INFO - 'installer_path': 'installer.exe', 12:31:25 INFO - 'log_level': 'info', 12:31:25 INFO - 'log_name': 'talos', 12:31:25 INFO - 'log_to_console': True, 12:31:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:31:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:31:25 INFO - 'opt_config_files': (), 12:31:25 INFO - 'pip_index': False, 12:31:25 INFO - 'sps_profile': False, 12:31:25 INFO - 'sps_profile_interval': 0, 12:31:25 INFO - 'suite': 'dromaeojs-e10s', 12:31:25 INFO - 'system_bits': '32', 12:31:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:31:25 INFO - 'title': 'talos-linux64-ix-032', 12:31:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:31:25 INFO - 'use_talos_json': True, 12:31:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:31:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:31:25 INFO - 'work_dir': 'build'} 12:31:25 INFO - ##### 12:31:25 INFO - ##### Running clobber step. 12:31:25 INFO - ##### 12:31:25 INFO - Running pre-action listener: _resource_record_pre_action 12:31:25 INFO - Running main action method: clobber 12:31:25 INFO - rmtree: /builds/slave/test-pgo/build 12:31:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:31:25 INFO - Running post-action listener: _resource_record_post_action 12:31:25 INFO - ##### 12:31:25 INFO - ##### Running read-buildbot-config step. 12:31:25 INFO - ##### 12:31:25 INFO - Running pre-action listener: _resource_record_pre_action 12:31:25 INFO - Running main action method: read_buildbot_config 12:31:25 INFO - Using buildbot properties: 12:31:25 INFO - { 12:31:25 INFO - "project": "", 12:31:25 INFO - "product": "firefox", 12:31:25 INFO - "script_repo_revision": "production", 12:31:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:31:25 INFO - "repository": "", 12:31:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:31:25 INFO - "buildid": "20160125100829", 12:31:25 INFO - "pgo_build": "True", 12:31:25 INFO - "basedir": "/builds/slave/test-pgo", 12:31:25 INFO - "buildnumber": 115, 12:31:25 INFO - "slavename": "talos-linux64-ix-032", 12:31:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:31:25 INFO - "platform": "ubuntu64_hw", 12:31:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:31:25 INFO - "branch": "mozilla-aurora", 12:31:25 INFO - "repo_path": "releases/mozilla-aurora", 12:31:25 INFO - "revision": "af58efa23494fda1b3173ee88835b5cff4ad52e6", 12:31:25 INFO - "stage_platform": "linux64-pgo", 12:31:25 INFO - "builduid": "dc7f62d8282d461c9d2986d8b7f0be12", 12:31:25 INFO - "slavebuilddir": "test" 12:31:25 INFO - } 12:31:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 12:31:25 INFO - Running post-action listener: _resource_record_post_action 12:31:25 INFO - ##### 12:31:25 INFO - ##### Running download-and-extract step. 12:31:25 INFO - ##### 12:31:25 INFO - Running pre-action listener: _resource_record_pre_action 12:31:25 INFO - Running main action method: download_and_extract 12:31:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:31:25 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')]} 12:31:25 INFO - https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:31:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/test_packages.json 12:31:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/test_packages.json 12:31:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:31:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:31:26 INFO - Downloaded 1448 bytes. 12:31:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:31:26 INFO - Using the following test package requirements: 12:31:26 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 12:31:26 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:31:26 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:31:26 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'jsshell-linux-x86_64.zip'], 12:31:26 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:31:26 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 12:31:26 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:31:26 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:31:26 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:31:26 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 12:31:26 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 12:31:26 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:31:26 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:31:26 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')]} 12:31:26 INFO - https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:31:28 INFO - Downloaded 22398081 bytes. 12:31:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:31:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:31:30 INFO - Return code: 0 12:31:30 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:31: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')]} 12:31:30 INFO - https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 12:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:31:31 INFO - Downloaded 22398081 bytes. 12:31:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:31:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:31:32 INFO - Return code: 0 12:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:32 INFO - https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 12:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 12:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 12:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:31:33 INFO - Downloaded 10706572 bytes. 12:31:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:31:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:31:33 INFO - Return code: 0 12:31: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')]} 12:31:33 INFO - https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:31:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 12:31:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 12:31:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 12:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:31:35 INFO - Downloaded 59574087 bytes. 12:31:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 12:31:35 INFO - mkdir: /builds/slave/test-pgo/properties 12:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:31:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:31:35 INFO - Contents: 12:31:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 12:31:35 INFO - Running post-action listener: _resource_record_post_action 12:31:35 INFO - Running post-action listener: set_extra_try_arguments 12:31:35 INFO - ##### 12:31:35 INFO - ##### Running populate-webroot step. 12:31:35 INFO - ##### 12:31:35 INFO - Running pre-action listener: _resource_record_pre_action 12:31:35 INFO - Running main action method: populate_webroot 12:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:31:35 INFO - '--tppagecycles', 12:31:35 INFO - '7'], 12:31:35 INFO - 'tests': ['tsvgm']}}, 12:31:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:31:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:31:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:31:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'tests': ['damp', 'tps']}, 12:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['damp', 'tps']}, 12:31:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:31:35 INFO - 'other': {'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'other_l64': {'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'other_nol64': {'tests': ['a11yr', 12:31:35 INFO - 'ts_paint', 12:31:35 INFO - 'tpaint', 12:31:35 INFO - 'sessionrestore', 12:31:35 INFO - 'sessionrestore_no_auto_restore']}, 12:31:35 INFO - 'svgr': {'tests': ['tsvgx', 12:31:35 INFO - 'tsvgr_opacity', 12:31:35 INFO - 'tart', 12:31:35 INFO - 'tscrollx', 12:31:35 INFO - 'cart']}, 12:31:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['tsvgx', 12:31:35 INFO - 'tsvgr_opacity', 12:31:35 INFO - 'tart', 12:31:35 INFO - 'tscrollx', 12:31:35 INFO - 'cart']}, 12:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'tests': ['tp5o']}, 12:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'talos_options': ['--e10s'], 12:31:35 INFO - 'tests': ['tp5o']}, 12:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'talos_options': ['--xperf_path', 12:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:35 INFO - 'tests': ['tp5n']}, 12:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:31:35 INFO - 'talos_options': ['--e10s', 12:31:35 INFO - '--xperf_path', 12:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:31:35 INFO - 'tests': ['tp5n']}}, 12:31:35 INFO - 'talos.zip': {'path': '', 12:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:31:35 INFO - Running post-action listener: _resource_record_post_action 12:31:35 INFO - ##### 12:31:35 INFO - ##### Running create-virtualenv step. 12:31:35 INFO - ##### 12:31:35 INFO - Running pre-action listener: _resource_record_pre_action 12:31:35 INFO - Running main action method: create_virtualenv 12:31:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:31:35 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 12:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:31:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:31:35 INFO - Using real prefix '/usr' 12:31:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:31:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:31:37 INFO - Installing pip.................done. 12:31:37 INFO - Return code: 0 12:31:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:37 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:37 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 12:31:37 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 12:31:37 INFO - Using env: {'DISPLAY': ':0', 12:31:37 INFO - 'HOME': '/home/cltbld', 12:31:37 INFO - 'LANG': 'en_US.UTF-8', 12:31:37 INFO - 'LANGUAGE': 'en_US:en', 12:31:37 INFO - 'LOGNAME': 'cltbld', 12:31:37 INFO - 'MAIL': '/var/mail/cltbld', 12:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:37 INFO - 'MOZ_NO_REMOTE': '1', 12:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:37 INFO - 'NO_EM_RESTART': '1', 12:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:37 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:37 INFO - 'SHELL': '/bin/bash', 12:31:37 INFO - 'SHLVL': '1', 12:31:37 INFO - 'TERM': 'linux', 12:31:37 INFO - 'TMOUT': '86400', 12:31:37 INFO - 'USER': 'cltbld', 12:31:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:37 INFO - '_': '/tools/buildbot/bin/python'} 12:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:31:37 INFO - Cleaning up... 12:31:37 INFO - Return code: 0 12:31:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:37 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:37 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 12:31:37 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 12:31:37 INFO - Using env: {'DISPLAY': ':0', 12:31:37 INFO - 'HOME': '/home/cltbld', 12:31:37 INFO - 'LANG': 'en_US.UTF-8', 12:31:37 INFO - 'LANGUAGE': 'en_US:en', 12:31:37 INFO - 'LOGNAME': 'cltbld', 12:31:37 INFO - 'MAIL': '/var/mail/cltbld', 12:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:37 INFO - 'MOZ_NO_REMOTE': '1', 12:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:37 INFO - 'NO_EM_RESTART': '1', 12:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:37 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:37 INFO - 'SHELL': '/bin/bash', 12:31:37 INFO - 'SHLVL': '1', 12:31:37 INFO - 'TERM': 'linux', 12:31:37 INFO - 'TMOUT': '86400', 12:31:37 INFO - 'USER': 'cltbld', 12:31:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:37 INFO - '_': '/tools/buildbot/bin/python'} 12:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:38 INFO - Downloading/unpacking psutil>=0.7.1 12:31:38 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 12:31:38 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 12:31:38 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 12:31:38 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 12:31:38 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 12:31:38 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 12:31:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:31:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:40 INFO - Installing collected packages: psutil 12:31:40 INFO - Running setup.py install for psutil 12:31:40 INFO - building 'psutil._psutil_linux' extension 12:31:40 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 12:31:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:31:40 INFO - building 'psutil._psutil_posix' extension 12:31:40 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 12:31:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:31:40 INFO - Successfully installed psutil 12:31:40 INFO - Cleaning up... 12:31:40 INFO - Return code: 0 12:31:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:40 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:40 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 12:31:40 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 12:31:40 INFO - Using env: {'DISPLAY': ':0', 12:31:40 INFO - 'HOME': '/home/cltbld', 12:31:40 INFO - 'LANG': 'en_US.UTF-8', 12:31:40 INFO - 'LANGUAGE': 'en_US:en', 12:31:40 INFO - 'LOGNAME': 'cltbld', 12:31:40 INFO - 'MAIL': '/var/mail/cltbld', 12:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:40 INFO - 'MOZ_NO_REMOTE': '1', 12:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:40 INFO - 'NO_EM_RESTART': '1', 12:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:40 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:40 INFO - 'SHELL': '/bin/bash', 12:31:40 INFO - 'SHLVL': '1', 12:31:40 INFO - 'TERM': 'linux', 12:31:40 INFO - 'TMOUT': '86400', 12:31:40 INFO - 'USER': 'cltbld', 12:31:40 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:40 INFO - '_': '/tools/buildbot/bin/python'} 12:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:31:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:31:42 INFO - Installing collected packages: mozsystemmonitor 12:31:42 INFO - Running setup.py install for mozsystemmonitor 12:31:42 INFO - Successfully installed mozsystemmonitor 12:31:42 INFO - Cleaning up... 12:31:42 INFO - Return code: 0 12:31:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:42 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:42 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 12:31:42 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 12:31:42 INFO - Using env: {'DISPLAY': ':0', 12:31:42 INFO - 'HOME': '/home/cltbld', 12:31:42 INFO - 'LANG': 'en_US.UTF-8', 12:31:42 INFO - 'LANGUAGE': 'en_US:en', 12:31:42 INFO - 'LOGNAME': 'cltbld', 12:31:42 INFO - 'MAIL': '/var/mail/cltbld', 12:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:42 INFO - 'MOZ_NO_REMOTE': '1', 12:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:42 INFO - 'NO_EM_RESTART': '1', 12:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:42 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:42 INFO - 'SHELL': '/bin/bash', 12:31:42 INFO - 'SHLVL': '1', 12:31:42 INFO - 'TERM': 'linux', 12:31:42 INFO - 'TMOUT': '86400', 12:31:42 INFO - 'USER': 'cltbld', 12:31:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:42 INFO - '_': '/tools/buildbot/bin/python'} 12:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:31:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:31:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:31:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31: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 12:31:45 INFO - Downloading docopt-0.6.1.tar.gz 12:31:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:31:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:31:45 INFO - Running setup.py install for blobuploader 12:31:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:31:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:31:45 INFO - Running setup.py install for requests 12:31:45 INFO - Running setup.py install for docopt 12:31:46 INFO - Successfully installed blobuploader requests docopt 12:31:46 INFO - Cleaning up... 12:31:46 INFO - Return code: 0 12:31:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:46 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:46 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 12:31:46 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 12:31:46 INFO - Using env: {'DISPLAY': ':0', 12:31:46 INFO - 'HOME': '/home/cltbld', 12:31:46 INFO - 'LANG': 'en_US.UTF-8', 12:31:46 INFO - 'LANGUAGE': 'en_US:en', 12:31:46 INFO - 'LOGNAME': 'cltbld', 12:31:46 INFO - 'MAIL': '/var/mail/cltbld', 12:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:46 INFO - 'MOZ_NO_REMOTE': '1', 12:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:46 INFO - 'NO_EM_RESTART': '1', 12:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:46 INFO - 'SHELL': '/bin/bash', 12:31:46 INFO - 'SHLVL': '1', 12:31:46 INFO - 'TERM': 'linux', 12:31:46 INFO - 'TMOUT': '86400', 12:31:46 INFO - 'USER': 'cltbld', 12:31:46 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:46 INFO - '_': '/tools/buildbot/bin/python'} 12:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:31:46 INFO - Running setup.py (path:/tmp/pip-zEuaHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:31:46 INFO - Running setup.py (path:/tmp/pip-PzCDrH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:31:46 INFO - Running setup.py (path:/tmp/pip-GRJTPd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:31:46 INFO - Running setup.py (path:/tmp/pip-B0XUYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:31:46 INFO - Running setup.py (path:/tmp/pip-Jihi36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:31:46 INFO - Running setup.py (path:/tmp/pip-lxhrLk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:31:46 INFO - Running setup.py (path:/tmp/pip-DYxP01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:31:46 INFO - Running setup.py (path:/tmp/pip-9tPVmG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:31:46 INFO - Running setup.py (path:/tmp/pip-f0UIeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:31:46 INFO - Running setup.py (path:/tmp/pip-ab11gl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:31:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:31:46 INFO - Running setup.py (path:/tmp/pip-HbTQjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:31:47 INFO - Running setup.py (path:/tmp/pip-sZzmu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:31:47 INFO - Running setup.py (path:/tmp/pip-7V3yon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:31:47 INFO - Running setup.py (path:/tmp/pip-v2aqfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:31:47 INFO - Running setup.py (path:/tmp/pip-AVQobu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:31:47 INFO - Running setup.py (path:/tmp/pip-CyeCUE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:31:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:31:47 INFO - Running setup.py (path:/tmp/pip-PFCmKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:31:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:31:47 INFO - Running setup.py install for manifestparser 12:31:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:31:47 INFO - Running setup.py install for mozcrash 12:31:47 INFO - Running setup.py install for mozdebug 12:31:47 INFO - Running setup.py install for mozdevice 12:31:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:31:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:31:47 INFO - Running setup.py install for mozfile 12:31:48 INFO - Running setup.py install for mozhttpd 12:31:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozinfo 12:31:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozInstall 12:31:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozleak 12:31:48 INFO - Running setup.py install for mozlog 12:31:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for moznetwork 12:31:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozprocess 12:31:48 INFO - Running setup.py install for mozprofile 12:31:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozrunner 12:31:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:31:48 INFO - Running setup.py install for mozscreenshot 12:31:49 INFO - Running setup.py install for moztest 12:31:49 INFO - Running setup.py install for mozversion 12:31:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:31:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:31:49 INFO - Cleaning up... 12:31:49 INFO - Return code: 0 12:31:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:49 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:49 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 12:31:49 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 12:31:49 INFO - Using env: {'DISPLAY': ':0', 12:31:49 INFO - 'HOME': '/home/cltbld', 12:31:49 INFO - 'LANG': 'en_US.UTF-8', 12:31:49 INFO - 'LANGUAGE': 'en_US:en', 12:31:49 INFO - 'LOGNAME': 'cltbld', 12:31:49 INFO - 'MAIL': '/var/mail/cltbld', 12:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:49 INFO - 'MOZ_NO_REMOTE': '1', 12:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:49 INFO - 'NO_EM_RESTART': '1', 12:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:49 INFO - 'SHELL': '/bin/bash', 12:31:49 INFO - 'SHLVL': '1', 12:31:49 INFO - 'TERM': 'linux', 12:31:49 INFO - 'TMOUT': '86400', 12:31:49 INFO - 'USER': 'cltbld', 12:31:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:49 INFO - '_': '/tools/buildbot/bin/python'} 12:31:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:31:49 INFO - Running setup.py (path:/tmp/pip-zRqguK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:31:49 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)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:31:49 INFO - Running setup.py (path:/tmp/pip-hefRY9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:31:49 INFO - Running setup.py (path:/tmp/pip-IBlzUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:31:49 INFO - Running setup.py (path:/tmp/pip-OREUXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:31:49 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)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:31:49 INFO - Running setup.py (path:/tmp/pip-NTq6IH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:31:49 INFO - Running setup.py (path:/tmp/pip-XARLtx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 12:31:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:31:49 INFO - Running setup.py (path:/tmp/pip-Dnaz3T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:31:50 INFO - Running setup.py (path:/tmp/pip-21n9jr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:31:50 INFO - Running setup.py (path:/tmp/pip-jKBOtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:31:50 INFO - Running setup.py (path:/tmp/pip-bEkHU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:31:50 INFO - Running setup.py (path:/tmp/pip-uZSXTt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:31:50 INFO - Running setup.py (path:/tmp/pip-6YODbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:31:50 INFO - Running setup.py (path:/tmp/pip-cWkoqY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:31:50 INFO - Running setup.py (path:/tmp/pip-3uaeS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:31:50 INFO - Running setup.py (path:/tmp/pip-HXutqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:31:50 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)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:31:50 INFO - Running setup.py (path:/tmp/pip-fVBBWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 12:31:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:31:50 INFO - Running setup.py (path:/tmp/pip-dlXPqu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:31:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:52 INFO - Downloading blessings-1.6.tar.gz 12:31:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:31:52 INFO - Installing collected packages: blessings 12:31:52 INFO - Running setup.py install for blessings 12:31:52 INFO - Successfully installed blessings 12:31:52 INFO - Cleaning up... 12:31:52 INFO - Return code: 0 12:31:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:31:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:31:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:31:52 INFO - Reading from file tmpfile_stdout 12:31:52 INFO - Current package versions: 12:31:52 INFO - argparse == 1.2.1 12:31:52 INFO - blessings == 1.6 12:31:52 INFO - blobuploader == 1.2.4 12:31:52 INFO - docopt == 0.6.1 12:31:52 INFO - manifestparser == 1.1 12:31:52 INFO - mozInstall == 1.12 12:31:52 INFO - mozcrash == 0.16 12:31:52 INFO - mozdebug == 0.1 12:31:52 INFO - mozdevice == 0.48 12:31:52 INFO - mozfile == 1.2 12:31:52 INFO - mozhttpd == 0.7 12:31:52 INFO - mozinfo == 0.9 12:31:52 INFO - mozleak == 0.1 12:31:52 INFO - mozlog == 3.1 12:31:52 INFO - moznetwork == 0.27 12:31:52 INFO - mozprocess == 0.22 12:31:52 INFO - mozprofile == 0.28 12:31:52 INFO - mozrunner == 6.11 12:31:52 INFO - mozscreenshot == 0.1 12:31:52 INFO - mozsystemmonitor == 0.0 12:31:52 INFO - moztest == 0.7 12:31:52 INFO - mozversion == 1.4 12:31:52 INFO - psutil == 3.1.1 12:31:52 INFO - requests == 1.2.3 12:31:52 INFO - wsgiref == 0.1.2 12:31:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:52 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:52 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 12:31:52 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 12:31:52 INFO - Using env: {'DISPLAY': ':0', 12:31:52 INFO - 'HOME': '/home/cltbld', 12:31:52 INFO - 'LANG': 'en_US.UTF-8', 12:31:52 INFO - 'LANGUAGE': 'en_US:en', 12:31:52 INFO - 'LOGNAME': 'cltbld', 12:31:52 INFO - 'MAIL': '/var/mail/cltbld', 12:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:52 INFO - 'MOZ_NO_REMOTE': '1', 12:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:52 INFO - 'NO_EM_RESTART': '1', 12:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:52 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:52 INFO - 'SHELL': '/bin/bash', 12:31:52 INFO - 'SHLVL': '1', 12:31:52 INFO - 'TERM': 'linux', 12:31:52 INFO - 'TMOUT': '86400', 12:31:52 INFO - 'USER': 'cltbld', 12:31:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:52 INFO - '_': '/tools/buildbot/bin/python'} 12:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 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)) 12:31:53 INFO - Cleaning up... 12:31:53 INFO - Return code: 0 12:31:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:31:53 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')]} 12:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:53 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')]} 12:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:53 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:53 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 12:31:53 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 12:31:53 INFO - Using env: {'DISPLAY': ':0', 12:31:53 INFO - 'HOME': '/home/cltbld', 12:31:53 INFO - 'LANG': 'en_US.UTF-8', 12:31:53 INFO - 'LANGUAGE': 'en_US:en', 12:31:53 INFO - 'LOGNAME': 'cltbld', 12:31:53 INFO - 'MAIL': '/var/mail/cltbld', 12:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:53 INFO - 'MOZ_NO_REMOTE': '1', 12:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:53 INFO - 'NO_EM_RESTART': '1', 12:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:53 INFO - 'SHELL': '/bin/bash', 12:31:53 INFO - 'SHLVL': '1', 12:31:53 INFO - 'TERM': 'linux', 12:31:53 INFO - 'TMOUT': '86400', 12:31:53 INFO - 'USER': 'cltbld', 12:31:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:53 INFO - '_': '/tools/buildbot/bin/python'} 12:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:53 INFO - Downloading/unpacking jsonschema 12:31:53 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 12:31:53 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 12:31:53 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 12:31:53 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 12:31:53 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 12:31:53 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 12:31:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:31:55 INFO - Downloading/unpacking functools32 (from jsonschema) 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:31:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:31:55 INFO - warning: no files found matching '*.txt' 12:31:55 INFO - no previously-included directories found matching 'build' 12:31:55 INFO - no previously-included directories found matching 'dist' 12:31:55 INFO - no previously-included directories found matching '.git*' 12:31:55 INFO - Installing collected packages: jsonschema, functools32 12:31:55 INFO - Running setup.py install for functools32 12:31:55 INFO - warning: no files found matching '*.txt' 12:31:55 INFO - no previously-included directories found matching 'build' 12:31:55 INFO - no previously-included directories found matching 'dist' 12:31:55 INFO - no previously-included directories found matching '.git*' 12:31:55 INFO - Successfully installed jsonschema functools32 12:31:55 INFO - Cleaning up... 12:31:55 INFO - Return code: 0 12:31:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:31:55 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')]} 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:55 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')]} 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:31:55 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 0x7f45cae5df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f5230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, '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': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', '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 12:31:55 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 12:31:55 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 12:31:55 INFO - Using env: {'DISPLAY': ':0', 12:31:55 INFO - 'HOME': '/home/cltbld', 12:31:55 INFO - 'LANG': 'en_US.UTF-8', 12:31:55 INFO - 'LANGUAGE': 'en_US:en', 12:31:55 INFO - 'LOGNAME': 'cltbld', 12:31:55 INFO - 'MAIL': '/var/mail/cltbld', 12:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:31:55 INFO - 'MOZ_NO_REMOTE': '1', 12:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:31:55 INFO - 'NO_EM_RESTART': '1', 12:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:31:55 INFO - 'PWD': '/builds/slave/test-pgo', 12:31:55 INFO - 'SHELL': '/bin/bash', 12:31:55 INFO - 'SHLVL': '1', 12:31:55 INFO - 'TERM': 'linux', 12:31:55 INFO - 'TMOUT': '86400', 12:31:55 INFO - 'USER': 'cltbld', 12:31:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:31:55 INFO - '_': '/tools/buildbot/bin/python'} 12:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:31:55 INFO - Downloading/unpacking flake8 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:31:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:31:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:31:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:58 INFO - no previously-included directories found matching 'docs/_build' 12:31:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:31:58 INFO - Running setup.py install for pep8 12:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:31:58 INFO - no previously-included directories found matching 'docs/_build' 12:31:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:31:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:31:58 INFO - Cleaning up... 12:31:58 INFO - Return code: 0 12:31:58 INFO - Running post-action listener: _resource_record_post_action 12:31:58 INFO - Running post-action listener: _start_resource_monitoring 12:31:58 INFO - Starting resource monitoring. 12:31:58 INFO - ##### 12:31:58 INFO - ##### Running install step. 12:31:58 INFO - ##### 12:31:58 INFO - Running pre-action listener: _resource_record_pre_action 12:31:58 INFO - Running main action method: install 12:31:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:31:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:31:58 INFO - Reading from file tmpfile_stdout 12:31:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:31:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:31:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:31:58 INFO - Reading from file tmpfile_stdout 12:31:58 INFO - Output received: 12:31:58 INFO - Usage: mozinstall [options] installer 12:31:58 INFO - Options: 12:31:58 INFO - -h, --help show this help message and exit 12:31:58 INFO - -d DEST, --destination=DEST 12:31:58 INFO - Directory to install application into. [default: 12:31:58 INFO - "/builds/slave/test-pgo"] 12:31:58 INFO - --app=APP Application being installed. [default: firefox] 12:31:58 INFO - mkdir: /builds/slave/test-pgo/build/application 12:31:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:31:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:32:16 INFO - Reading from file tmpfile_stdout 12:32:16 INFO - Output received: 12:32:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:32:16 INFO - Running post-action listener: _resource_record_post_action 12:32:16 INFO - ##### 12:32:16 INFO - ##### Running run-tests step. 12:32:16 INFO - ##### 12:32:16 INFO - Running pre-action listener: _resource_record_pre_action 12:32:16 INFO - Running main action method: run_tests 12:32:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:32:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:32:16 INFO - Python 2.7.3 12:32:16 INFO - Return code: 0 12:32:16 INFO - grabbing minidump binary from tooltool 12:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:32:16 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 0x23877f0>, '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 0x22f32d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22f3760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:32:16 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 12:32:16 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 12:32:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:32:16 INFO - Return code: 0 12:32:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:32:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:32:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:32:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:32:17 INFO - Return code: 0 12:32:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:32:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:32:17 INFO - Using env: {'DISPLAY': ':0', 12:32:17 INFO - 'HOME': '/home/cltbld', 12:32:17 INFO - 'LANG': 'en_US.UTF-8', 12:32:17 INFO - 'LANGUAGE': 'en_US:en', 12:32:17 INFO - 'LOGNAME': 'cltbld', 12:32:17 INFO - 'MAIL': '/var/mail/cltbld', 12:32:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:32:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:17 INFO - 'MOZ_NO_REMOTE': '1', 12:32:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:17 INFO - 'NO_EM_RESTART': '1', 12:32:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:32:17 INFO - 'PWD': '/builds/slave/test-pgo', 12:32:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:32:17 INFO - 'SHELL': '/bin/bash', 12:32:17 INFO - 'SHLVL': '1', 12:32:17 INFO - 'TERM': 'linux', 12:32:17 INFO - 'TMOUT': '86400', 12:32:17 INFO - 'USER': 'cltbld', 12:32:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1453753883.43987-2022472447', 12:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:17 INFO - '_': '/tools/buildbot/bin/python'} 12:32:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:32:17 INFO - mozversion application_buildid: 20160125100829 12:32:17 INFO - mozversion application_changeset: af58efa23494fda1b3173ee88835b5cff4ad52e6 12:32:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:32:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:32:17 INFO - mozversion application_name: Firefox 12:32:17 INFO - mozversion application_remotingname: firefox-dev 12:32:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:32:17 INFO - mozversion application_vendor: Mozilla 12:32:17 INFO - mozversion application_version: 46.0a2 12:32:17 INFO - mozversion platform_buildid: 20160125100829 12:32:17 INFO - mozversion platform_changeset: af58efa23494fda1b3173ee88835b5cff4ad52e6 12:32:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:32:17 INFO - mozversion platform_version: 46.0a2 12:32:17 INFO - using testdate: 1453753937 12:32:17 INFO - actual date: 1453753937 12:32:17 INFO - starting webserver on 'localhost:55843' 12:32:17 INFO - SUITE-START | Running 3 tests 12:32:17 INFO - TEST-START | dromaeo_css 12:32:17 INFO - operating with platform_type : linux_ 12:32:17 INFO - Initialising browser for dromaeo_css test... 12:32:18 INFO - TEST-INFO | started process 16300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2mdcQX/profile http://localhost:55843/getInfo.html) 12:32:22 INFO - PROCESS | 16300 | 12:32:22 INFO - PROCESS | 16300 | (process:16379): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:32:23 INFO - PROCESS | 16300 | __metrics Screen width/height:1600/1200 12:32:23 INFO - PROCESS | 16300 | colorDepth:24 12:32:23 INFO - PROCESS | 16300 | Browser inner width/height: 1024/697 12:32:23 INFO - PROCESS | 16300 | __metrics 12:32:24 INFO - TEST-INFO | 16300: exit 0 12:32:24 INFO - Browser initialized. 12:32:24 INFO - Running cycle 1/1 for dromaeo_css test... 12:32:24 INFO - TEST-INFO | started process 16428 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2mdcQX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:32:25 INFO - PROCESS | 16428 | 12:32:25 INFO - PROCESS | 16428 | (process:16494): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:32:36 INFO - PROCESS | 16428 | RSS: Main: 140251136 12:32:36 INFO - PROCESS | 16428 | 12:33:25 INFO - PROCESS | 16428 | 1453754005959 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] 12:35:34 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55843/tests/dromaeo/cssquery-ext.html) 12:35:35 INFO - PROCESS | 16428 | RSS: Main: 144875520 12:35:35 INFO - PROCESS | 16428 | 12:38:37 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-ext.html (next: http://localhost:55843/tests/dromaeo/cssquery-jquery.html) 12:38:37 INFO - PROCESS | 16428 | RSS: Main: 142520320 12:38:37 INFO - PROCESS | 16428 | 12:41:39 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55843/tests/dromaeo/cssquery-mootools.html) 12:41:40 INFO - PROCESS | 16428 | RSS: Main: 142790656 12:41:40 INFO - PROCESS | 16428 | 12:44:41 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55843/tests/dromaeo/cssquery-prototype.html) 12:44:42 INFO - PROCESS | 16428 | RSS: Main: 142233600 12:44:42 INFO - PROCESS | 16428 | 12:47:44 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55843/tests/dromaeo/cssquery-yui.html) 12:47:45 INFO - PROCESS | 16428 | RSS: Main: 144162816 12:47:45 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | Cycle 1(1): loaded http://localhost:55843/tests/dromaeo/cssquery-yui.html (next: http://localhost:55843/tests/dromaeo/cssquery-dojo.html) 12:50:47 INFO - PROCESS | 16428 | RSS: Main: 146112512 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | __start_tp_report 12:50:47 INFO - PROCESS | 16428 | _x_x_mozilla_page_load 12:50:47 INFO - PROCESS | 16428 | _x_x_mozilla_page_load_details 12:50:47 INFO - PROCESS | 16428 | |i|pagename|runs| 12:50:47 INFO - PROCESS | 16428 | |0;dojo.html;3358.479435687468;3413.2661477782285;3424.2809010107876;3457.6715212054846;3462.394081035819;5549.472800083996;5549.889002219963;5572.275604171462;5576.247206627104;5595.636283641566;5569;5578.079616863223;5593.161025846125;5607.411221821701;5635.887282254353;5071.721055341964;5103.209002604603;5151.81968631098;5190.2474141249495;5193.272941788153;4976.328195693589;5059.949400505985;5110.616703747215;5117.385913690362;5144.614153938451;5122.538971492565;5125.461826508219;5147.330846989886;5196.688198708071;5205.193195054753;5103.617228707843;5116.488351164872;5124;5139.15203991341;5151.45909679482;4948.950510494885;5030.899382012376;5032.4212715537815;5036.546710796046;5048.899022019576;5297.761600727938;5300.310959575269;5317.973410132963;5350.464953504618;5359.892802143974;5825.38833422493;5857.15071314657;5878.059510478346;5879.647221166743;5904.763809447617;5917.792877249276;5944.910826337608;5994.920914235436;6013.5489838261865;6015.669138197398;5501.862453438696;5508.889822203533;5521.641093328921;5526.696031718254;5527.917081243784;5965.492933100648;6118.1434599156155;6152.477039451696;6169.475594574512;6188.504919606421;5895.410458954156;5931.851703707355;5949.810037992419;5951.137085122633;5954.077118046623;5877.676727780014;5972.313183983811;5972.701364931736;6035.185249991195;6037.1246169305205;6033.155358249848;6093.512518998469;6103.633781973096;6117.143599896018;6122;5897.056470964625;5913.231279933581;5941.168236446901;5962.55280853929;5964.7912323068485;4473.597376236155;4509.7970591323465;4540.114677637829;4546.840860569864;4551.38556294896;4070.5929407059057;4096.180763847243;4116.238495878212;4119.876403707894;4124.628783409507;5604.607677462538;5661.801836935688;5662.065759149694;5669.603127781098;5677.744501497443;5866;5961.731722072517;5973.641581505123;6032.245969253843;6126.203593532812;5681.517071048925;5683.431656834367;5698.943010569924;5726.3700992890745;5727.627704199213;5124;5141.640085194001;5145.22821576759;5151.9484805152215;5157.174852023658;6032.939670603238;6142.069075791497;6144.293406258248;6321.96839015802;6326.335734747785;6054.545909056838;6076.848078797889;6087.634741915499;6116.174316467398;6118.632882027093;5888.352281249145;6234.688265586793;6240.968795155995;6243.8126856194385;6244.562880598314;5844.181814546052;5861.736221870111;5907.556933229939;5945.613535120204;5965.970170149121;5816.389279125631;5843.328017278068;5849.239598852292;5853.824385268449;5871.970640146943;5700.429957004267;5761.683107429131;5761.971190144022;5767.365589785204;5790.623609465371;5755.251817263729;5769.884602308014;5795.246617939641;5878.059510478303;5920.171176035445;5777.711114444177;5803.129530570448;5808.244928159481;5819.970900145472;5820.94179058204;5761.308642962871;5850.473457388855;5912.852178695395;5923.348431672426;5923.348431672426;5668.461496157858;5736.913946290892;5805.419458054161;5809.535237180931;5810.796622118206 12:50:47 INFO - PROCESS | 16428 | |1;ext.html;548.8024311247952;556.5742207211483;572.9828105156847;574.4112284907969;585.1077107411197;36109;36400.81799591005;36403.817980910055;36678.083047923814;36706.26587468249;39603.80198099012;39965;40018.19963600733;40130.39804402929;40155.397669034915;8507;8750.474971501699;8776.517291548962;8804.691835785748;8813.60338784753;8642.481451112953;8772.824543509127;8793.736187914374;8823.911760882373;8874.689385871496;8867.334949878752;8944;8963.058878817728;8969;8978.551072446384;8857.778555536099;8929.821403571957;8938.106189381042;8943.50810705411;8956.19394254517;8811.735647930509;8875.689350872688;8877.245434138105;8897.065808090187;8901.109889011112;39025.41461878074;39535.60464395377;39760;39765.80117099396;39856.40215396771;3291.1113999220315;3307.7353811695248;3345.882894098695;3480.9825950870086;3919.529656441245;30864.228394290098;31276.218094547592;31610.367792644018;31699.683003170136;31785.84107079473;4103.507579090528;4138.461999939988;4173.9582604173875;4191.3293872980485;4229.619334259901;298372;299225;299498;300196;302142.48928755434;42913.570864291585;43480.347794783105;43496;60912.69543652253;61106.69446652827;44513.777431112634;44578.55421445744;44649;44796.77601612036;45222;15297.6175595611;15351.385944562093;15410.306536205897;15474.148921809183;15479.690406191814;11283.323000619988;11368.943155284336;11419.143564232716;11478.081753459703;11508.194426390073;14803.333849976561;14920.253987300592;14943.252837358088;14943.850561494462;15043.097414155185;5935.821925342247;5970.19400881585;5981.611195272293;5999.400359784095;6073;950.9762255943657;1022.3916769522123;1058.7670712443405;1082.2532452607675;1143.6854864912216;29296.707032929397;29392;29711;30082.84958575237;30124;1110.2672236323988;1133.7732453509166;1143.8455808465917;1146.9942650286696;1236.7650146472142;15390;15526.844731552766;15557.377704891678;15853.920730396274;16266.75599866003;512747;514866;515238;515968;522088;51731;51743.482565173865;51917.74041129846;52153.47846521562;52162.21756673653;1445.3640398224748;1460.678650696845;1464.9047811892406;1465.1868213141595;1474.7787831825312;28625.71374286314;29434.558481622364;30077;30306.393872122873;31692.366152677278;47322.52677473319;47786.28320575125;47800.52199477961;48027.5197248023;48044;333222;334451;336402;336610;336834;33419.83290083534;33715;33737.66262337443;33958.66041339555;34127.82936085304;43806;44067;44246;44446.777766110965;44890;37063;38049;38295;38417.80791096027;39231.41152882652;38611.420828688155;41249;44341.55658443374;44756.55243447654;45032.77483612561;38090.0477488065;38165;38582.42126368163;38825.417618736305;38860.2227955445;33429.83285083657;33834.154146146546;33880.3223935515;33888.322233555686;33961.320773583895;26863.597046044717;26946.81090264025;27075;27249.31876703019;27295.863520683062 12:50:47 INFO - PROCESS | 16428 | |2;jquery.html;388.8988862895647;393.1037235103964;394.8302230041083;397.1897329447926;397.74345547122124;15442.768358474632;16289.42986995454;16371.263293151807;18918;19037.904810475946;15555.53333399997;16352.264148113334;16754.413595524158;17023.57441063974;17023.91488042561;5134.332536770224;5267.1045922193125;5474.260974768415;5480.479354461319;5483.067878460672;5268.0517506848755;5361.651492652984;5427.782888684448;5433.809816656418;5491.2312276281355;5443.564514838823;5472.452754724535;5620.100783874581;5850.151727999438;5867.4719275265215;5914.940850591482;6044.214252147215;6063.272407311107;6135.386461353851;6156.322804491502;5559.58303127263;5569.8607534811545;5580;5592.888142237132;5613.158026296048;16514.504564863073;20407.693884591743;20965.79034209669;21099.47251318714;21114.472138196514;695.6139342664819;2226.6882636430914;2342.02805835578;2349.7469580060147;2380.1081685751897;9292.39599426035;9430.10414010668;9741.756456088584;10973.490221147898;13146.737065258736;1753.1584839277218;1842.6959551673958;1885.1139964216795;1895;1955.9511012224666;59128;60618.090728639545;61177;61355;61732.69133654303;10624.20318476102;10755.193360497993;10854.891451085388;10914.290571112851;11002.834957475645;14278.643033924234;14333.06835055718;14366.56900292993;14473.27633618315;14589.124652520883;7981.2018798119725;8039.678412863537;8049.718259860877;8080.353571714249;8104.351651867836;7709.614519274014;7747.109082455477;7755.612219389008;7773.41699372538;7805.258500442449;4589.2198326284615;4678.1813182692895;4771.475137734847;4801.423829140455;4818.132736107535;1827.5248435406625;1931.3529967461059;1939.059556115283;1962.6359680022533;1964.567795085079;999.9500024998866;1023.8720159980003;1053.5575058475458;1067.386252904583;1125.0999200639455;16763.580910477336;16811.915940420466;17134.742978855327;17141.314347425963;17295.135243237786;1011.367895065584;1012.5645972231864;1012.8784545854545;1024.6464969585481;1034.5603118674683;9970.351927124713;10086.293959422917;10389.9480502597;10666.306690065121;10728.892711072946;559272;568973;590684;595051;597908;46328.305075423894;47220.7638961803;62126.68936655378;74266;75927;1206.4691535724428;1209.5585111434264;1210.7941649919535;1218.65268398506;1224.7305592769756;15381.846181538041;15663.921680391524;15839.970401923838;16037.518874433787;16159.192040398168;32417.675823241465;32620.947046893994;32776.672233277364;33831.830840845636;34470.82764586161;44226;44544.77727611341;44683;45722;47180.056398871144;7440.665170067252;7841.372690184658;7874.8818767717385;7878.763637090897;8108.554029528196;10737.731556711145;10781;10879.891201088205;11067.778644426906;11145.72135696614;9572.377795443273;9756.85364719544;10007.849882251627;10087.445190514298;10104.747381315527;9761.951190244003;10059.597616095274;10301.815291241302;10323.122534584645;10569.365838049742;9624.855627165458;9668.516574171123;9867;10151.593936242467;10162.796744065225;7523.924760752322;7625.542467451971;7721.150673426031;7805.648745806566;7995.760127196193;9841.704748857546;10438.164946804085;10492;10679.57281708754;10737.302075365076 12:50:47 INFO - PROCESS | 16428 | |3;mootools.html;1530.75507918733;1540.391545339591;1773.6452709458113;1863.366455405162;1899.9050047497622;8010.5594192319395;8134.064582573006;8229.711960081399;8348.081711011791;8441.95779021104;8147.796305092375;8166.79583010425;8203.26170644642;8227.341812654988;8261.380396470273;2443.096054459848;2472.1223965492263;2473.2332976777166;2478.3184624228393;2482.9255122346267;2474.7277799442045;2558.168595206556;2572.858492782896;2582.0317380982133;2585.7802086822644;2432.075811191745;2483.019207413071;2492.7258001619807;2494.775470207681;2513.396784771651;2482.0692240409844;2485.9254222373356;2498.650188973545;2512.38446580588;2530.2029860593852;2469.1728271029046;2495.9251222463354;2496.5755821510206;2515.6478093066985;2527.330257481769;8370.748877533684;8379.70671026511;8382.07797142314;8423.410361274713;8423.578821058984;5086.847394578169;5240.816571419982;5278.155495120763;5282.788688452457;5297.576193904479;3286.09632351103;3326.3846188454972;3353.144948038259;3364.2934983653463;3377.257003459235;1013.4324778124274;1017.5878769098526;1096.5175322857917;1916.444231172958;2034.5422279987033;10883.891161088366;11102.056325212367;11117.055050320732;11121.388323642197;11121.72195695106;4686.757013789813;4687.742174180453;4787.832425865078;4832.830850920201;4841.394825646794;9981.60073597048;10013.49932503372;10088.293819432569;10089.142422894136;10101.19190464761;5243.23973023917;5276.129438642658;5290.259363689087;5328.733563321818;5367;4829.758512074382;4875.1224779540025;4882.462929077798;4902.48523904992;4903.681260718042;3892.143728379752;3924.3328634132267;3977.423273625366;4021.1354558770004;4027.275090483741;1253.6051143889645;1282.8652991435765;1334.8197993270978;1340.1958824705098;1342.2483409290828;1062.8193207154802;1064.3294724323628;1274.585759628106;1376.2018029542842;1459.0370355565276;7536.472446928772;7574.962125189339;7620.390368770485;7757.263060009403;7759.806004849811;573.0945106731355;578.9913151302734;581.3314688108625;599.9141553787658;763.6563546404029;5863.941360586339;5923.822285331447;5991.191189189403;6004.3395226525045;6035.6076855004285;9673.70978870635;9787.853182202272;9873.456959867277;10033.799324013478;10084;9698;9893;9908.355956862924;10010.249231307682;10013.649522266685;7708.460407771402;7805.258500442449;7813.804654883674;7858.371330293563;7891.802704932423;8007.439479236397;8056.194380561897;8076.27313541784;8087.393445491729;8092.797680058045;8587.441816281922;8856.512891791013;9066.365354425126;9091.409058411182;9178.862317065115;8781.51701656415;8965.058668839678;9017.323700722342;9040.954795225982;9187.356885018253;7176.641167941478;7306.598137102298;7326;7326;7344.926550734424;7383.114026316876;7548.320651141424;7554.2823431773895;7563.886541701769;7580.05249343832;6548.934510655023;7310.853782924418;7373.520721153108;7469.1037075551285;7649.349805266615;7308.59802710856;7354.816129596803;7423.554586724814;7431.3683336916965;7516.812079698051;7600.46796724224;7620.085589729268;7634.923650763643;7645.159032506309;7651.502652327581;7005;7039.894401583878;7063.611501367269;7071.540349877241;7076.71693132269;6936.271691472524;6946.79159625212;7054.858902821812;7119.394851437479;7168.247334029852 12:50:47 INFO - PROCESS | 16428 | |4;prototype.html;352.1776651518704;352.19523389056013;352.84651176738134;354.02995791531214;361.96742293193614;6251.906221406671;6350.968245158773;6376.904346434807;6433.22801263849;6459.385153711566;6159.630422174672;6309.873802523946;6325.051242313655;6338.176037115169;6354.936450635492;4756.762161891909;4813.205821039524;4853.053654537367;4853.102176097415;4878.829240976566;4880;4889.119958407486;4890.388701412324;4891.217405215166;4900.387451568554;4775.761211939406;4820.734859582722;4827.951720482785;4840.394950631171;4844.370231869852;4812.32627432158;4819.373481447425;4827.903441931159;4851.51484851512;4859.489753575876;4223.852165174204;4224.767637779921;4234.364845273203;4236.364545318196;4237.470316210473;5961.225040744675;6022.69886505673;6023.518118550505;6057.454829065361;6065.332813390523;5655.830325090254;5667.603267771257;5671.149327600851;5671.347795003586;5681.318241810968;6768.6615669216835;6772.255051944282;6774.017767423746;6777.830554236134;6801.877690181114;4713.410823647044;4714.434267887841;4728.739919304437;4731.313959475891;4746.1931471649905;6930.72277108915;7048.118985126859;7064.222935477093;7083.433325334013;7092.397146242575;4779.235322348477;4800.3759511263315;4816.301636262722;4826.420829500483;4846.36997190363;4899.510048995072;4902.142125128088;4917.065757506062;4918.2376731606655;4931.112399768076;5542.808296216333;5646.463585959327;5646.717664116778;5654.46282603152;5666.603337766317;6806.081179040865;6852.6916288767125;6857.5199736018;6862.348076932683;6870.003849441903;1689.7634331193642;1699.2693141948832;1721.956951076233;1728.9221985010704;1742.6950283700303;1114.0975809594254;1132.9320240785414;1137.016480744167;1145.8453108830367;1155.5955415604471;6501.609903405811;6510.316416776171;6524.412802847766;6531.346865313526;6531.673416329165;6925.515213934977;6932.341427564374;6965.79102626922;6981.3367730065565;7002.159740831133;6489.545731798823;6501.252355979028;6523.739050438025;6530.673466326664;6533.1180290661105;3788.3938569829247;3793.279276937373;3804.5814960354337;3808.5810560838286;3809.6380843819793;7098.396636285974;7119.786406407816;7170;7177.102862142232;7201.495895287384;6999.615021173884;7147.9285207148305;7153.248908864494;7166.211716711157;7166.247544007804;7111.182214045348;7127.251638577978;7170.103737032871;7174.246704096099;7184.389326907271;6929.445644348541;6938.687759050754;6961.269066747918;6963.303669633199;6978.825529361604;6721.966390168018;6842.247352791289;6880.346367095118;6880.346367095118;6891.035255064396;7124.501284910007;7172.067631208119;7195.2085270619145;7196.280371962762;7199.992001119952;4806.038792241636;4841.733704646278;4841.927371089366;4842.7336496493035;4852;6860.073890024983;6902.792916212522;6950.165980082423;6965.059716938148;7007.124109486314;6703.128593282842;6719.05147507237;6748.93251067483;6750.763723269662;6774.051632771318;6736.056952026622;6742.022406751092;6751.426128778912;6773.085633439423;6781.050652908695;6546.345365463416;6658.966705166443;6671.799846004627;6674.666266686743;6677.799666010027;6759.324067593201;6782.050512928293;6787.151606049244;6791.286914873867;6795.218549866829;6601.669916504252;6629.3039230882;6650.3682150195655;6650.401463868275;6675.198976122896 12:50:47 INFO - PROCESS | 16428 | |5;yui.html;792.5759718550573;848.5290663681656;865.329369738453;886.0696268917636;934.7008957133711;14345.282735863204;14396;14439.42242310309;14531.418743250271;14538.70922581549;12780;15345.232738363093;15478.535643930672;15528.223588820541;15569.610759731013;858.3047731337605;859.4370687199863;868.1058509734983;874.3442418186361;891.38494438837;880.8546589812673;884.8186121845006;886.4681191285242;887.0685779931079;890.185480285538;902.3322741171552;909.1317791509126;909.5179554835947;910.4218821048648;913.0139449394671;893.3255392178896;896.3098414221046;896.8161526886972;900.9729708108767;903.4263242840777;663.2803408301999;664.5248647217214;664.5846346033729;665.9234188068338;668.84616538196;15193.088414695154;15271.770923436157;15287.159206243652;15320.387184512607;15321.157336346496;13682.384292706853;13722.382492787849;13779.448822047107;13798.862011379959;13893.513727019506;11351.375674337909;11433.828492572535;11482.368469734161;11691.94154029233;11741.88258117425;3921.627445392683;3940.310445672025;3970.602939706035;3979.5423526294558;4006.979965100185;52341;52622.73688631571;52850.47149528494;52863.73568132135;53136;10219.995817191337;10324.225683073799;10466.267361284637;10621.150307975344;10742.73143171427;18860.24559017624;18867.622647546974;18926.33757818497;19243.51891202731;19275;7711.26742959418;7741.92258077412;7780.416468764865;7902;8103.230193131643;4821.349117869113;4845.273209018605;4874.610031197496;4932.827351042696;4964.131277026579;3270.787398819117;3308.073739352985;3315.1712071982006;3327.983360083184;3329.1177837872983;579.5566391710345;579.9449052340021;584.3688816078625;598.7096258314714;599.556328317051;520.092438694473;559.3958524793213;574.9942500575024;580.7357652268208;602.5902386377218;9033.457992520469;9050.909490905007;9170.349337119382;9230.907690923139;10160.374340105547;526.9104252277122;579.2701196492366;650.8828410885991;691.7129391302553;724.026184781468;4380.4305440292555;4533.138703646297;4646.5353464653945;4712.128256272601;4736.076465089274;58643.4135658638;58776.70611646914;58994;59440.40559594435;59627.701861490415;53903.46096539063;54844.72577637086;56514;56622.43377566254;56645.15032274519;48119.51880481221;49552.256716149284;50015;50885.23672144921;50940.74529627328;9087.36388452802;9108.726738197865;9119;9258.120478554527;9447.53644620742;35533.46699799453;36159.096022599646;36792.63207367892;36795.44806827953;37530;44808.551914480435;48672.26991595058;48698.26952595785;48832.75583622059;49501.257481138535;11243.212975091992;11330.093592512743;11383.829242561535;11460.426978650867;11846.11154163424;12286.508539658313;12818.807717884425;12855.485780568673;12966.416511257205;12977.416016279101;12326.322052286852;12693.174943628635;12716.427760750974;12813.551525696555;13005.154664946747;12088.214266072677;12478.251304921734;12649.557265495663;12673.619791406272;12751.808722868978;11653.359065251492;11707.707307317045;11750.94124529372;12079.222757811063;12404.441800118835;9789.804203916025;9894.257930655374;9936.850947235942;9939.105480506789;9973.900260997298;10037.598496060076;10342.37945723259;10539.156867450432;10548.525316360628;10587.20595955322 12:50:47 INFO - PROCESS | 16428 | __end_tp_report 12:50:47 INFO - PROCESS | 16428 | __start_cc_report 12:50:47 INFO - PROCESS | 16428 | _x_x_mozilla_cycle_collect,302 12:50:47 INFO - PROCESS | 16428 | __end_cc_report 12:50:47 INFO - PROCESS | 16428 | __startTimestamp1453755047502__endTimestamp 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | ------- Summary: start ------- 12:50:47 INFO - PROCESS | 16428 | Number of tests: 6 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#0] dojo.html Cycles:165 Average:5552.40 Median:5767.37 stddev:610.37 (10.6%) stddev-sans-first:587.48 12:50:47 INFO - PROCESS | 16428 | Values: 3358.5 3413.3 3424.3 3457.7 3462.4 5549.5 5549.9 5572.3 5576.2 5595.6 5569.0 5578.1 5593.2 5607.4 5635.9 5071.7 5103.2 5151.8 5190.2 5193.3 4976.3 5059.9 5110.6 5117.4 5144.6 5122.5 5125.5 5147.3 5196.7 5205.2 5103.6 5116.5 5124.0 5139.2 5151.5 4949.0 5030.9 5032.4 5036.5 5048.9 5297.8 5300.3 5318.0 5350.5 5359.9 5825.4 5857.2 5878.1 5879.6 5904.8 5917.8 5944.9 5994.9 6013.5 6015.7 5501.9 5508.9 5521.6 5526.7 5527.9 5965.5 6118.1 6152.5 6169.5 6188.5 5895.4 5931.9 5949.8 5951.1 5954.1 5877.7 5972.3 5972.7 6035.2 6037.1 6033.2 6093.5 6103.6 6117.1 6122.0 5897.1 5913.2 5941.2 5962.6 5964.8 4473.6 4509.8 4540.1 4546.8 4551.4 4070.6 4096.2 4116.2 4119.9 4124.6 5604.6 5661.8 5662.1 5669.6 5677.7 5866.0 5961.7 5973.6 6032.2 6126.2 5681.5 5683.4 5698.9 5726.4 5727.6 5124.0 5141.6 5145.2 5151.9 5157.2 6032.9 6142.1 6144.3 6322.0 6326.3 6054.5 6076.8 6087.6 6116.2 6118.6 5888.4 6234.7 6241.0 6243.8 6244.6 5844.2 5861.7 5907.6 5945.6 5966.0 5816.4 5843.3 5849.2 5853.8 5872.0 5700.4 5761.7 5762.0 5767.4 5790.6 5755.3 5769.9 5795.2 5878.1 5920.2 5777.7 5803.1 5808.2 5820.0 5820.9 5761.3 5850.5 5912.9 5923.3 5923.3 5668.5 5736.9 5805.4 5809.5 5810.8 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#1] ext.html Cycles:180 Average:53659.06 Median:38718.42 stddev:104804.49 (270.7%) stddev-sans-first:105022.64 12:50:47 INFO - PROCESS | 16428 | Values: 548.8 556.6 573.0 574.4 585.1 36109.0 36400.8 36403.8 36678.1 36706.3 39603.8 39965.0 40018.2 40130.4 40155.4 8507.0 8750.5 8776.5 8804.7 8813.6 8642.5 8772.8 8793.7 8823.9 8874.7 8867.3 8944.0 8963.1 8969.0 8978.6 8857.8 8929.8 8938.1 8943.5 8956.2 8811.7 8875.7 8877.2 8897.1 8901.1 39025.4 39535.6 39760.0 39765.8 39856.4 3291.1 3307.7 3345.9 3481.0 3919.5 30864.2 31276.2 31610.4 31699.7 31785.8 4103.5 4138.5 4174.0 4191.3 4229.6 298372.0 299225.0 299498.0 300196.0 302142.5 42913.6 43480.3 43496.0 60912.7 61106.7 44513.8 44578.6 44649.0 44796.8 45222.0 15297.6 15351.4 15410.3 15474.1 15479.7 11283.3 11368.9 11419.1 11478.1 11508.2 14803.3 14920.3 14943.3 14943.9 15043.1 5935.8 5970.2 5981.6 5999.4 6073.0 951.0 1022.4 1058.8 1082.3 1143.7 29296.7 29392.0 29711.0 30082.8 30124.0 1110.3 1133.8 1143.8 1147.0 1236.8 15390.0 15526.8 15557.4 15853.9 16266.8 512747.0 514866.0 515238.0 515968.0 522088.0 51731.0 51743.5 51917.7 52153.5 52162.2 1445.4 1460.7 1464.9 1465.2 1474.8 28625.7 29434.6 30077.0 30306.4 31692.4 47322.5 47786.3 47800.5 48027.5 48044.0 333222.0 334451.0 336402.0 336610.0 336834.0 33419.8 33715.0 33737.7 33958.7 34127.8 43806.0 44067.0 44246.0 44446.8 44890.0 37063.0 38049.0 38295.0 38417.8 39231.4 38611.4 41249.0 44341.6 44756.6 45032.8 38090.0 38165.0 38582.4 38825.4 38860.2 33429.8 33834.2 33880.3 33888.3 33961.3 26863.6 26946.8 27075.0 27249.3 27295.9 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#2] jquery.html Cycles:180 Average:28905.37 Median:34151.33 stddev:95002.24 (278.2%) stddev-sans-first:95244.61 12:50:47 INFO - PROCESS | 16428 | Values: 388.9 393.1 394.8 397.2 397.7 15442.8 16289.4 16371.3 18918.0 19037.9 15555.5 16352.3 16754.4 17023.6 17023.9 5134.3 5267.1 5474.3 5480.5 5483.1 5268.1 5361.7 5427.8 5433.8 5491.2 5443.6 5472.5 5620.1 5850.2 5867.5 5914.9 6044.2 6063.3 6135.4 6156.3 5559.6 5569.9 5580.0 5592.9 5613.2 16514.5 20407.7 20965.8 21099.5 21114.5 695.6 2226.7 2342.0 2349.7 2380.1 9292.4 9430.1 9741.8 10973.5 13146.7 1753.2 1842.7 1885.1 1895.0 1956.0 59128.0 60618.1 61177.0 61355.0 61732.7 10624.2 10755.2 10854.9 10914.3 11002.8 14278.6 14333.1 14366.6 14473.3 14589.1 7981.2 8039.7 8049.7 8080.4 8104.4 7709.6 7747.1 7755.6 7773.4 7805.3 4589.2 4678.2 4771.5 4801.4 4818.1 1827.5 1931.4 1939.1 1962.6 1964.6 1000.0 1023.9 1053.6 1067.4 1125.1 16763.6 16811.9 17134.7 17141.3 17295.1 1011.4 1012.6 1012.9 1024.6 1034.6 9970.4 10086.3 10389.9 10666.3 10728.9 559272.0 568973.0 590684.0 595051.0 597908.0 46328.3 47220.8 62126.7 74266.0 75927.0 1206.5 1209.6 1210.8 1218.7 1224.7 15381.8 15663.9 15840.0 16037.5 16159.2 32417.7 32620.9 32776.7 33831.8 34470.8 44226.0 44544.8 44683.0 45722.0 47180.1 7440.7 7841.4 7874.9 7878.8 8108.6 10737.7 10781.0 10879.9 11067.8 11145.7 9572.4 9756.9 10007.8 10087.4 10104.7 9762.0 10059.6 10301.8 10323.1 10569.4 9624.9 9668.5 9867.0 10151.6 10162.8 7523.9 7625.5 7721.2 7805.6 7995.8 9841.7 10438.2 10492.0 10679.6 10737.3 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#3] mootools.html Cycles:180 Average:5853.97 Median:3222.64 stddev:2977.89 (92.4%) stddev-sans-first:2968.51 12:50:47 INFO - PROCESS | 16428 | Values: 1530.8 1540.4 1773.6 1863.4 1899.9 8010.6 8134.1 8229.7 8348.1 8442.0 8147.8 8166.8 8203.3 8227.3 8261.4 2443.1 2472.1 2473.2 2478.3 2482.9 2474.7 2558.2 2572.9 2582.0 2585.8 2432.1 2483.0 2492.7 2494.8 2513.4 2482.1 2485.9 2498.7 2512.4 2530.2 2469.2 2495.9 2496.6 2515.6 2527.3 8370.7 8379.7 8382.1 8423.4 8423.6 5086.8 5240.8 5278.2 5282.8 5297.6 3286.1 3326.4 3353.1 3364.3 3377.3 1013.4 1017.6 1096.5 1916.4 2034.5 10883.9 11102.1 11117.1 11121.4 11121.7 4686.8 4687.7 4787.8 4832.8 4841.4 9981.6 10013.5 10088.3 10089.1 10101.2 5243.2 5276.1 5290.3 5328.7 5367.0 4829.8 4875.1 4882.5 4902.5 4903.7 3892.1 3924.3 3977.4 4021.1 4027.3 1253.6 1282.9 1334.8 1340.2 1342.2 1062.8 1064.3 1274.6 1376.2 1459.0 7536.5 7575.0 7620.4 7757.3 7759.8 573.1 579.0 581.3 599.9 763.7 5863.9 5923.8 5991.2 6004.3 6035.6 9673.7 9787.9 9873.5 10033.8 10084.0 9698.0 9893.0 9908.4 10010.2 10013.6 7708.5 7805.3 7813.8 7858.4 7891.8 8007.4 8056.2 8076.3 8087.4 8092.8 8587.4 8856.5 9066.4 9091.4 9178.9 8781.5 8965.1 9017.3 9041.0 9187.4 7176.6 7306.6 7326.0 7326.0 7344.9 7383.1 7548.3 7554.3 7563.9 7580.1 6548.9 7310.9 7373.5 7469.1 7649.3 7308.6 7354.8 7423.6 7431.4 7516.8 7600.5 7620.1 7634.9 7645.2 7651.5 7005.0 7039.9 7063.6 7071.5 7076.7 6936.3 6946.8 7054.9 7119.4 7168.2 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#4] prototype.html Cycles:180 Average:5652.47 Median:6495.40 stddev:1697.53 (26.1%) stddev-sans-first:1655.02 12:50:47 INFO - PROCESS | 16428 | Values: 352.2 352.2 352.8 354.0 362.0 6251.9 6351.0 6376.9 6433.2 6459.4 6159.6 6309.9 6325.1 6338.2 6354.9 4756.8 4813.2 4853.1 4853.1 4878.8 4880.0 4889.1 4890.4 4891.2 4900.4 4775.8 4820.7 4828.0 4840.4 4844.4 4812.3 4819.4 4827.9 4851.5 4859.5 4223.9 4224.8 4234.4 4236.4 4237.5 5961.2 6022.7 6023.5 6057.5 6065.3 5655.8 5667.6 5671.1 5671.3 5681.3 6768.7 6772.3 6774.0 6777.8 6801.9 4713.4 4714.4 4728.7 4731.3 4746.2 6930.7 7048.1 7064.2 7083.4 7092.4 4779.2 4800.4 4816.3 4826.4 4846.4 4899.5 4902.1 4917.1 4918.2 4931.1 5542.8 5646.5 5646.7 5654.5 5666.6 6806.1 6852.7 6857.5 6862.3 6870.0 1689.8 1699.3 1722.0 1728.9 1742.7 1114.1 1132.9 1137.0 1145.8 1155.6 6501.6 6510.3 6524.4 6531.3 6531.7 6925.5 6932.3 6965.8 6981.3 7002.2 6489.5 6501.3 6523.7 6530.7 6533.1 3788.4 3793.3 3804.6 3808.6 3809.6 7098.4 7119.8 7170.0 7177.1 7201.5 6999.6 7147.9 7153.2 7166.2 7166.2 7111.2 7127.3 7170.1 7174.2 7184.4 6929.4 6938.7 6961.3 6963.3 6978.8 6722.0 6842.2 6880.3 6880.3 6891.0 7124.5 7172.1 7195.2 7196.3 7200.0 4806.0 4841.7 4841.9 4842.7 4852.0 6860.1 6902.8 6950.2 6965.1 7007.1 6703.1 6719.1 6748.9 6750.8 6774.1 6736.1 6742.0 6751.4 6773.1 6781.1 6546.3 6659.0 6671.8 6674.7 6677.8 6759.3 6782.1 6787.2 6791.3 6795.2 6601.7 6629.3 6650.4 6650.4 6675.2 12:50:47 INFO - PROCESS | 16428 | 12:50:47 INFO - PROCESS | 16428 | [#5] yui.html Cycles:180 Average:14815.71 Median:48685.27 stddev:17010.06 (34.9%) stddev-sans-first:17025.18 12:50:47 INFO - PROCESS | 16428 | Values: 792.6 848.5 865.3 886.1 934.7 14345.3 14396.0 14439.4 14531.4 14538.7 12780.0 15345.2 15478.5 15528.2 15569.6 858.3 859.4 868.1 874.3 891.4 880.9 884.8 886.5 887.1 890.2 902.3 909.1 909.5 910.4 913.0 893.3 896.3 896.8 901.0 903.4 663.3 664.5 664.6 665.9 668.8 15193.1 15271.8 15287.2 15320.4 15321.2 13682.4 13722.4 13779.4 13798.9 13893.5 11351.4 11433.8 11482.4 11691.9 11741.9 3921.6 3940.3 3970.6 3979.5 4007.0 52341.0 52622.7 52850.5 52863.7 53136.0 10220.0 10324.2 10466.3 10621.2 10742.7 18860.2 18867.6 18926.3 19243.5 19275.0 7711.3 7741.9 7780.4 7902.0 8103.2 4821.3 4845.3 4874.6 4932.8 4964.1 3270.8 3308.1 3315.2 3328.0 3329.1 579.6 579.9 584.4 598.7 599.6 520.1 559.4 575.0 580.7 602.6 9033.5 9050.9 9170.3 9230.9 10160.4 526.9 579.3 650.9 691.7 724.0 4380.4 4533.1 4646.5 4712.1 4736.1 58643.4 58776.7 58994.0 59440.4 59627.7 53903.5 54844.7 56514.0 56622.4 56645.2 48119.5 49552.3 50015.0 50885.2 50940.7 9087.4 9108.7 9119.0 9258.1 9447.5 35533.5 36159.1 36792.6 36795.4 37530.0 44808.6 48672.3 48698.3 48832.8 49501.3 11243.2 11330.1 11383.8 11460.4 11846.1 12286.5 12818.8 12855.5 12966.4 12977.4 12326.3 12693.2 12716.4 12813.6 13005.2 12088.2 12478.3 12649.6 12673.6 12751.8 11653.4 11707.7 11750.9 12079.2 12404.4 9789.8 9894.3 9936.9 9939.1 9973.9 10037.6 10342.4 10539.2 10548.5 10587.2 12:50:47 INFO - PROCESS | 16428 | -------- Summary: end -------- 12:50:47 INFO - PROCESS | 16428 | 12:50:48 INFO - TEST-INFO | 16428: exit 0 12:50:48 INFO - TEST-OK | dromaeo_css | took 1110249ms 12:50:48 INFO - TEST-START | kraken 12:50:48 INFO - operating with platform_type : linux_ 12:50:48 INFO - Initialising browser for kraken test... 12:50:48 INFO - TEST-INFO | started process 16678 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRrbeRG/profile http://localhost:55843/getInfo.html) 12:50:52 INFO - PROCESS | 16678 | 12:50:52 INFO - PROCESS | 16678 | (process:16763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:50:54 INFO - PROCESS | 16678 | __metrics Screen width/height:1600/1200 12:50:54 INFO - PROCESS | 16678 | colorDepth:24 12:50:54 INFO - PROCESS | 16678 | Browser inner width/height: 1024/697 12:50:54 INFO - PROCESS | 16678 | __metrics 12:50:54 INFO - PROCESS | 16678 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:50:55 INFO - TEST-INFO | 16678: exit 0 12:50:55 INFO - Browser initialized. 12:50:55 INFO - Running cycle 1/1 for kraken test... 12:50:55 INFO - TEST-INFO | started process 16812 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRrbeRG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:56 INFO - PROCESS | 16812 | 12:50:56 INFO - PROCESS | 16812 | (process:16878): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:07 INFO - PROCESS | 16812 | RSS: Main: 140419072 12:51:07 INFO - PROCESS | 16812 | 12:51:09 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55843/tests/kraken/driver.html?testName=audio-beat-detection) 12:51:10 INFO - PROCESS | 16812 | RSS: Main: 144216064 12:51:10 INFO - PROCESS | 16812 | 12:51:12 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55843/tests/kraken/driver.html?testName=audio-dft) 12:51:13 INFO - PROCESS | 16812 | RSS: Main: 143265792 12:51:13 INFO - PROCESS | 16812 | 12:51:16 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55843/tests/kraken/driver.html?testName=audio-fft) 12:51:16 INFO - PROCESS | 16812 | RSS: Main: 144732160 12:51:16 INFO - PROCESS | 16812 | 12:51:18 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55843/tests/kraken/driver.html?testName=audio-oscillator) 12:51:19 INFO - PROCESS | 16812 | RSS: Main: 144457728 12:51:19 INFO - PROCESS | 16812 | 12:51:21 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:51:22 INFO - PROCESS | 16812 | RSS: Main: 143933440 12:51:22 INFO - PROCESS | 16812 | 12:51:25 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55843/tests/kraken/driver.html?testName=imaging-darkroom) 12:51:25 INFO - PROCESS | 16812 | RSS: Main: 143990784 12:51:25 INFO - PROCESS | 16812 | 12:51:28 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55843/tests/kraken/driver.html?testName=imaging-desaturate) 12:51:29 INFO - PROCESS | 16812 | RSS: Main: 144367616 12:51:29 INFO - PROCESS | 16812 | 12:51:32 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55843/tests/kraken/driver.html?testName=json-parse-financial) 12:51:33 INFO - PROCESS | 16812 | RSS: Main: 145743872 12:51:33 INFO - PROCESS | 16812 | 12:51:34 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:51:35 INFO - PROCESS | 16812 | RSS: Main: 145428480 12:51:35 INFO - PROCESS | 16812 | 12:51:36 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:51:37 INFO - PROCESS | 16812 | RSS: Main: 143806464 12:51:37 INFO - PROCESS | 16812 | 12:51:39 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:51:40 INFO - PROCESS | 16812 | RSS: Main: 144855040 12:51:40 INFO - PROCESS | 16812 | 12:51:42 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:51:43 INFO - PROCESS | 16812 | RSS: Main: 144138240 12:51:43 INFO - PROCESS | 16812 | 12:51:45 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:51:46 INFO - PROCESS | 16812 | RSS: Main: 144498688 12:51:46 INFO - PROCESS | 16812 | 12:51:47 INFO - PROCESS | 16812 | Cycle 1(1): loaded http://localhost:55843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55843/tests/kraken/driver.html?testName=ai-astar) 12:51:48 INFO - PROCESS | 16812 | RSS: Main: 146874368 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | __start_tp_report 12:51:48 INFO - PROCESS | 16812 | _x_x_mozilla_page_load 12:51:48 INFO - PROCESS | 16812 | _x_x_mozilla_page_load_details 12:51:48 INFO - PROCESS | 16812 | |i|pagename|runs| 12:51:48 INFO - PROCESS | 16812 | |0;ai-astar;112;106;111;108;114;122;109;109;109;109 12:51:48 INFO - PROCESS | 16812 | |1;audio-beat-detection;150;129;148;160;128;154;153;130;167;128 12:51:48 INFO - PROCESS | 16812 | |2;audio-dft;162;164;163;161;163;162;161;162;163;163 12:51:48 INFO - PROCESS | 16812 | |3;audio-fft;73;75;76;153;76;74;76;76;171;77 12:51:48 INFO - PROCESS | 16812 | |4;audio-oscillator;95;95;151;96;101;96;137;95;96;134 12:51:48 INFO - PROCESS | 16812 | |5;imaging-gaussian-blur;111;110;110;111;110;110;110;110;110;109 12:51:48 INFO - PROCESS | 16812 | |6;imaging-darkroom;150;148;146;147;147;146;148;147;147;147 12:51:48 INFO - PROCESS | 16812 | |7;imaging-desaturate;97;97;96;97;96;97;98;101;96;97 12:51:48 INFO - PROCESS | 16812 | |8;json-parse-financial;56;56;58;55;56;59;55;55;56;53 12:51:48 INFO - PROCESS | 16812 | |9;json-stringify-tinderbox;64;64;65;64;65;64;64;65;65;65 12:51:48 INFO - PROCESS | 16812 | |10;stanford-crypto-aes;89;80;83;86;85;89;83;83;84;82 12:51:48 INFO - PROCESS | 16812 | |11;stanford-crypto-ccm;111;111;121;114;112;115;118;119;114;111 12:51:48 INFO - PROCESS | 16812 | |12;stanford-crypto-pbkdf2;135;147;136;127;125;135;136;124;132;134 12:51:48 INFO - PROCESS | 16812 | |13;stanford-crypto-sha256-iterative;67;68;64;66;65;65;70;67;65;65 12:51:48 INFO - PROCESS | 16812 | __end_tp_report 12:51:48 INFO - PROCESS | 16812 | __start_cc_report 12:51:48 INFO - PROCESS | 16812 | _x_x_mozilla_cycle_collect,743 12:51:48 INFO - PROCESS | 16812 | __end_cc_report 12:51:48 INFO - PROCESS | 16812 | __startTimestamp1453755108001__endTimestamp 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | ------- Summary: start ------- 12:51:48 INFO - PROCESS | 16812 | Number of tests: 14 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.00 stddev:4.48 (4.1%) stddev-sans-first:4.74 12:51:48 INFO - PROCESS | 16812 | Values: 112.0 106.0 111.0 108.0 114.0 122.0 109.0 109.0 109.0 109.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:14.70 (9.7%) stddev-sans-first:15.47 12:51:48 INFO - PROCESS | 16812 | Values: 150.0 129.0 148.0 160.0 128.0 154.0 153.0 130.0 167.0 128.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 12:51:48 INFO - PROCESS | 16812 | Values: 162.0 164.0 163.0 161.0 163.0 162.0 161.0 162.0 163.0 163.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:36.79 (48.4%) stddev-sans-first:38.32 12:51:48 INFO - PROCESS | 16812 | Values: 73.0 75.0 76.0 153.0 76.0 74.0 76.0 76.0 171.0 77.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:21.93 (23.1%) stddev-sans-first:22.62 12:51:48 INFO - PROCESS | 16812 | Values: 95.0 95.0 151.0 96.0 101.0 96.0 137.0 95.0 96.0 134.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 12:51:48 INFO - PROCESS | 16812 | Values: 111.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 109.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:0.71 12:51:48 INFO - PROCESS | 16812 | Values: 150.0 148.0 146.0 147.0 147.0 146.0 148.0 147.0 147.0 147.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:1.48 (1.5%) stddev-sans-first:1.56 12:51:48 INFO - PROCESS | 16812 | Values: 97.0 97.0 96.0 97.0 96.0 97.0 98.0 101.0 96.0 97.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:1.76 12:51:48 INFO - PROCESS | 16812 | Values: 56.0 56.0 58.0 55.0 56.0 59.0 55.0 55.0 56.0 53.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 12:51:48 INFO - PROCESS | 16812 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:2.91 (3.4%) stddev-sans-first:2.57 12:51:48 INFO - PROCESS | 16812 | Values: 89.0 80.0 83.0 86.0 85.0 89.0 83.0 83.0 84.0 82.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:114.50 stddev:3.63 (3.2%) stddev-sans-first:3.61 12:51:48 INFO - PROCESS | 16812 | Values: 111.0 111.0 121.0 114.0 112.0 115.0 118.0 119.0 114.0 111.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.10 Median:135.00 stddev:6.71 (5.0%) stddev-sans-first:7.08 12:51:48 INFO - PROCESS | 16812 | Values: 135.0 147.0 136.0 127.0 125.0 135.0 136.0 124.0 132.0 134.0 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - PROCESS | 16812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.81 (2.7%) stddev-sans-first:1.90 12:51:48 INFO - PROCESS | 16812 | Values: 67.0 68.0 64.0 66.0 65.0 65.0 70.0 67.0 65.0 65.0 12:51:48 INFO - PROCESS | 16812 | -------- Summary: end -------- 12:51:48 INFO - PROCESS | 16812 | 12:51:48 INFO - TEST-INFO | 16812: exit 0 12:51:48 INFO - TEST-OK | kraken | took 60731ms 12:51:48 INFO - TEST-START | v8_7 12:51:48 INFO - operating with platform_type : linux_ 12:51:48 INFO - Initialising browser for v8_7 test... 12:51:48 INFO - TEST-INFO | started process 17106 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3XSsg4/profile http://localhost:55843/getInfo.html) 12:51:53 INFO - PROCESS | 17106 | 12:51:53 INFO - PROCESS | 17106 | (process:17187): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:51:54 INFO - PROCESS | 17106 | __metrics Screen width/height:1600/1200 12:51:54 INFO - PROCESS | 17106 | colorDepth:24 12:51:54 INFO - PROCESS | 17106 | Browser inner width/height: 1024/697 12:51:54 INFO - PROCESS | 17106 | __metrics 12:51:55 INFO - TEST-INFO | 17106: exit 0 12:51:55 INFO - Browser initialized. 12:51:55 INFO - Running cycle 1/1 for v8_7 test... 12:51:55 INFO - TEST-INFO | started process 17236 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3XSsg4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:56 INFO - PROCESS | 17236 | 12:51:56 INFO - PROCESS | 17236 | (process:17295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:52:07 INFO - PROCESS | 17236 | RSS: Main: 139673600 12:52:07 INFO - PROCESS | 17236 | 12:52:29 INFO - PROCESS | 17236 | Cycle 1(1): loaded http://localhost:55843/tests/v8_7/run.html (next: http://localhost:55843/tests/v8_7/run.html) 12:52:30 INFO - PROCESS | 17236 | RSS: Main: 143065088 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | __start_tp_report 12:52:30 INFO - PROCESS | 17236 | _x_x_mozilla_page_load 12:52:30 INFO - PROCESS | 17236 | _x_x_mozilla_page_load_details 12:52:30 INFO - PROCESS | 17236 | |i|pagename|runs| 12:52:30 INFO - PROCESS | 17236 | |0;Richards;167.7289500167729 12:52:30 INFO - PROCESS | 17236 | |1;DeltaBlue;169.92353440951572 12:52:30 INFO - PROCESS | 17236 | |2;Encrypt;279.01785714285717 12:52:30 INFO - PROCESS | 17236 | |3;Decrypt;5246.073298429319 12:52:30 INFO - PROCESS | 17236 | |4;RayTrace;948.7666034155598 12:52:30 INFO - PROCESS | 17236 | |5;Earley;569.1519635742743 12:52:30 INFO - PROCESS | 17236 | |6;Boyer;11087.912087912087 12:52:30 INFO - PROCESS | 17236 | |7;RegExp;39711.53846153846 12:52:30 INFO - PROCESS | 17236 | |8;Splay;518.9413596263622 12:52:30 INFO - PROCESS | 17236 | |9;NavierStokes;4830.917874396136 12:52:30 INFO - PROCESS | 17236 | __end_tp_report 12:52:30 INFO - PROCESS | 17236 | __startTimestamp1453755150018__endTimestamp 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | ------- Summary: start ------- 12:52:30 INFO - PROCESS | 17236 | Number of tests: 10 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 167.7 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#1] DeltaBlue Cycles:1 Average:169.92 Median:169.92 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 169.9 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 279.0 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 5246.1 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 948.8 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#5] Earley Cycles:1 Average:569.15 Median:569.15 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 569.2 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#6] Boyer Cycles:1 Average:11087.91 Median:11087.91 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 11087.9 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#7] RegExp Cycles:1 Average:39711.54 Median:39711.54 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 39711.5 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#8] Splay Cycles:1 Average:518.94 Median:518.94 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 518.9 12:52:30 INFO - PROCESS | 17236 | 12:52:30 INFO - PROCESS | 17236 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:52:30 INFO - PROCESS | 17236 | Values: 4830.9 12:52:30 INFO - PROCESS | 17236 | -------- Summary: end -------- 12:52:30 INFO - PROCESS | 17236 | 12:52:31 INFO - TEST-INFO | 17236: exit 0 12:52:31 INFO - TEST-OK | v8_7 | took 42131ms 12:52:31 INFO - SUITE-END | took 1213s 12:52:31 INFO - Completed test suite (00:20:13) 12:52:31 INFO - Working with test: dromaeo_css 12:52:31 INFO - Generating results file: dromaeo_css 12:52:31 INFO - Working with test: kraken 12:52:31 INFO - Generating results file: kraken 12:52:31 INFO - javascript benchmark 12:52:31 INFO - Working with test: v8_7 12:52:31 INFO - Generating results file: v8_7 12:52:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:52:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 12:52:31 INFO - process_Request line: dromaeo_css 7261.74 graph.html#tests=[[72,52,43]] 12:52:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:52:31 INFO - process_Request line: kraken 1493.60 graph.html#tests=[[232,52,43]] 12:52:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:52:31 INFO - process_Request line: v8_7 21901.75 graph.html#tests=[[230,52,43]] 12:52:31 INFO - RETURN: dromaeo_css: 7261.74 12:52:31 INFO - RETURN: kraken: 1493.60 12:52:31 INFO - RETURN: v8_7: 21901.75 12:52:31 INFO - javascript benchmark 12:52:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3358.479435687468, 3413.2661477782285, 3424.2809010107876, 3457.6715212054846, 3462.394081035819, 5549.472800083996, 5549.889002219963, 5572.275604171462, 5576.247206627104, 5595.636283641566, 5569.0, 5578.079616863223, 5593.161025846125, 5607.411221821701, 5635.887282254353, 5071.721055341964, 5103.209002604603, 5151.81968631098, 5190.2474141249495, 5193.272941788153, 4976.328195693589, 5059.949400505985, 5110.616703747215, 5117.385913690362, 5144.614153938451, 5122.538971492565, 5125.461826508219, 5147.330846989886, 5196.688198708071, 5205.193195054753, 5103.617228707843, 5116.488351164872, 5124.0, 5139.15203991341, 5151.45909679482, 4948.950510494885, 5030.899382012376, 5032.4212715537815, 5036.546710796046, 5048.899022019576, 5297.761600727938, 5300.310959575269, 5317.973410132963, 5350.464953504618, 5359.892802143974, 5825.38833422493, 5857.15071314657, 5878.059510478346, 5879.647221166743, 5904.763809447617, 5917.792877249276, 5944.910826337608, 5994.920914235436, 6013.5489838261865, 6015.669138197398, 5501.862453438696, 5508.889822203533, 5521.641093328921, 5526.696031718254, 5527.917081243784, 5965.492933100648, 6118.1434599156155, 6152.477039451696, 6169.475594574512, 6188.504919606421, 5895.410458954156, 5931.851703707355, 5949.810037992419, 5951.137085122633, 5954.077118046623, 5877.676727780014, 5972.313183983811, 5972.701364931736, 6035.185249991195, 6037.1246169305205, 6033.155358249848, 6093.512518998469, 6103.633781973096, 6117.143599896018, 6122.0, 5897.056470964625, 5913.231279933581, 5941.168236446901, 5962.55280853929, 5964.7912323068485, 4473.597376236155, 4509.7970591323465, 4540.114677637829, 4546.840860569864, 4551.38556294896, 4070.5929407059057, 4096.180763847243, 4116.238495878212, 4119.876403707894, 4124.628783409507, 5604.607677462538, 5661.801836935688, 5662.065759149694, 5669.603127781098, 5677.744501497443, 5866.0, 5961.731722072517, 5973.641581505123, 6032.245969253843, 6126.203593532812, 5681.517071048925, 5683.431656834367, 5698.943010569924, 5726.3700992890745, 5727.627704199213, 5124.0, 5141.640085194001, 5145.22821576759, 5151.9484805152215, 5157.174852023658, 6032.939670603238, 6142.069075791497, 6144.293406258248, 6321.96839015802, 6326.335734747785, 6054.545909056838, 6076.848078797889, 6087.634741915499, 6116.174316467398, 6118.632882027093, 5888.352281249145, 6234.688265586793, 6240.968795155995, 6243.8126856194385, 6244.562880598314, 5844.181814546052, 5861.736221870111, 5907.556933229939, 5945.613535120204, 5965.970170149121, 5816.389279125631, 5843.328017278068, 5849.239598852292, 5853.824385268449, 5871.970640146943, 5700.429957004267, 5761.683107429131, 5761.971190144022, 5767.365589785204, 5790.623609465371, 5755.251817263729, 5769.884602308014, 5795.246617939641, 5878.059510478303, 5920.171176035445, 5777.711114444177, 5803.129530570448, 5808.244928159481, 5819.970900145472, 5820.94179058204, 5761.308642962871, 5850.473457388855, 5912.852178695395, 5923.348431672426, 5923.348431672426, 5668.461496157858, 5736.913946290892, 5805.419458054161, 5809.535237180931, 5810.796622118206], "unit": "score", "name": "dojo.html", "value": 5513.577707610991}, {"lowerIsBetter": false, "replicates": [548.8024311247952, 556.5742207211483, 572.9828105156847, 574.4112284907969, 585.1077107411197, 36109.0, 36400.81799591005, 36403.817980910055, 36678.083047923814, 36706.26587468249, 39603.80198099012, 39965.0, 40018.19963600733, 40130.39804402929, 40155.397669034915, 8507.0, 8750.474971501699, 8776.517291548962, 8804.691835785748, 8813.60338784753, 8642.481451112953, 8772.824543509127, 8793.736187914374, 8823.911760882373, 8874.689385871496, 8867.334949878752, 8944.0, 8963.058878817728, 8969.0, 8978.551072446384, 8857.778555536099, 8929.821403571957, 8938.106189381042, 8943.50810705411, 8956.19394254517, 8811.735647930509, 8875.689350872688, 8877.245434138105, 8897.065808090187, 8901.109889011112, 39025.41461878074, 39535.60464395377, 39760.0, 39765.80117099396, 39856.40215396771, 3291.1113999220315, 3307.7353811695248, 3345.882894098695, 3480.9825950870086, 3919.529656441245, 30864.228394290098, 31276.218094547592, 31610.367792644018, 31699.683003170136, 31785.84107079473, 4103.507579090528, 4138.461999939988, 4173.9582604173875, 4191.3293872980485, 4229.619334259901, 298372.0, 299225.0, 299498.0, 300196.0, 302142.48928755434, 42913.570864291585, 43480.347794783105, 43496.0, 60912.69543652253, 61106.69446652827, 44513.777431112634, 44578.55421445744, 44649.0, 44796.77601612036, 45222.0, 15297.6175595611, 15351.385944562093, 15410.306536205897, 15474.148921809183, 15479.690406191814, 11283.323000619988, 11368.943155284336, 11419.143564232716, 11478.081753459703, 11508.194426390073, 14803.333849976561, 14920.253987300592, 14943.252837358088, 14943.850561494462, 15043.097414155185, 5935.821925342247, 5970.19400881585, 5981.611195272293, 5999.400359784095, 6073.0, 950.9762255943657, 1022.3916769522123, 1058.7670712443405, 1082.2532452607675, 1143.6854864912216, 29296.707032929397, 29392.0, 29711.0, 30082.84958575237, 30124.0, 1110.2672236323988, 1133.7732453509166, 1143.8455808465917, 1146.9942650286696, 1236.7650146472142, 15390.0, 15526.844731552766, 15557.377704891678, 15853.920730396274, 16266.75599866003, 512747.0, 514866.0, 515238.0, 515968.0, 522088.0, 51731.0, 51743.482565173865, 51917.74041129846, 52153.47846521562, 52162.21756673653, 1445.3640398224748, 1460.678650696845, 1464.9047811892406, 1465.1868213141595, 1474.7787831825312, 28625.71374286314, 29434.558481622364, 30077.0, 30306.393872122873, 31692.366152677278, 47322.52677473319, 47786.28320575125, 47800.52199477961, 48027.5197248023, 48044.0, 333222.0, 334451.0, 336402.0, 336610.0, 336834.0, 33419.83290083534, 33715.0, 33737.66262337443, 33958.66041339555, 34127.82936085304, 43806.0, 44067.0, 44246.0, 44446.777766110965, 44890.0, 37063.0, 38049.0, 38295.0, 38417.80791096027, 39231.41152882652, 38611.420828688155, 41249.0, 44341.55658443374, 44756.55243447654, 45032.77483612561, 38090.0477488065, 38165.0, 38582.42126368163, 38825.417618736305, 38860.2227955445, 33429.83285083657, 33834.154146146546, 33880.3223935515, 33888.322233555686, 33961.320773583895, 26863.597046044717, 26946.81090264025, 27075.0, 27249.31876703019, 27295.863520683062], "unit": "score", "name": "ext.html", "value": 18838.542625694703}, {"lowerIsBetter": false, "replicates": [388.8988862895647, 393.1037235103964, 394.8302230041083, 397.1897329447926, 397.74345547122124, 15442.768358474632, 16289.42986995454, 16371.263293151807, 18918.0, 19037.904810475946, 15555.53333399997, 16352.264148113334, 16754.413595524158, 17023.57441063974, 17023.91488042561, 5134.332536770224, 5267.1045922193125, 5474.260974768415, 5480.479354461319, 5483.067878460672, 5268.0517506848755, 5361.651492652984, 5427.782888684448, 5433.809816656418, 5491.2312276281355, 5443.564514838823, 5472.452754724535, 5620.100783874581, 5850.151727999438, 5867.4719275265215, 5914.940850591482, 6044.214252147215, 6063.272407311107, 6135.386461353851, 6156.322804491502, 5559.58303127263, 5569.8607534811545, 5580.0, 5592.888142237132, 5613.158026296048, 16514.504564863073, 20407.693884591743, 20965.79034209669, 21099.47251318714, 21114.472138196514, 695.6139342664819, 2226.6882636430914, 2342.02805835578, 2349.7469580060147, 2380.1081685751897, 9292.39599426035, 9430.10414010668, 9741.756456088584, 10973.490221147898, 13146.737065258736, 1753.1584839277218, 1842.6959551673958, 1885.1139964216795, 1895.0, 1955.9511012224666, 59128.0, 60618.090728639545, 61177.0, 61355.0, 61732.69133654303, 10624.20318476102, 10755.193360497993, 10854.891451085388, 10914.290571112851, 11002.834957475645, 14278.643033924234, 14333.06835055718, 14366.56900292993, 14473.27633618315, 14589.124652520883, 7981.2018798119725, 8039.678412863537, 8049.718259860877, 8080.353571714249, 8104.351651867836, 7709.614519274014, 7747.109082455477, 7755.612219389008, 7773.41699372538, 7805.258500442449, 4589.2198326284615, 4678.1813182692895, 4771.475137734847, 4801.423829140455, 4818.132736107535, 1827.5248435406625, 1931.3529967461059, 1939.059556115283, 1962.6359680022533, 1964.567795085079, 999.9500024998866, 1023.8720159980003, 1053.5575058475458, 1067.386252904583, 1125.0999200639455, 16763.580910477336, 16811.915940420466, 17134.742978855327, 17141.314347425963, 17295.135243237786, 1011.367895065584, 1012.5645972231864, 1012.8784545854545, 1024.6464969585481, 1034.5603118674683, 9970.351927124713, 10086.293959422917, 10389.9480502597, 10666.306690065121, 10728.892711072946, 559272.0, 568973.0, 590684.0, 595051.0, 597908.0, 46328.305075423894, 47220.7638961803, 62126.68936655378, 74266.0, 75927.0, 1206.4691535724428, 1209.5585111434264, 1210.7941649919535, 1218.65268398506, 1224.7305592769756, 15381.846181538041, 15663.921680391524, 15839.970401923838, 16037.518874433787, 16159.192040398168, 32417.675823241465, 32620.947046893994, 32776.672233277364, 33831.830840845636, 34470.82764586161, 44226.0, 44544.77727611341, 44683.0, 45722.0, 47180.056398871144, 7440.665170067252, 7841.372690184658, 7874.8818767717385, 7878.763637090897, 8108.554029528196, 10737.731556711145, 10781.0, 10879.891201088205, 11067.778644426906, 11145.72135696614, 9572.377795443273, 9756.85364719544, 10007.849882251627, 10087.445190514298, 10104.747381315527, 9761.951190244003, 10059.597616095274, 10301.815291241302, 10323.122534584645, 10569.365838049742, 9624.855627165458, 9668.516574171123, 9867.0, 10151.593936242467, 10162.796744065225, 7523.924760752322, 7625.542467451971, 7721.150673426031, 7805.648745806566, 7995.760127196193, 9841.704748857546, 10438.164946804085, 10492.0, 10679.57281708754, 10737.302075365076], "unit": "score", "name": "jquery.html", "value": 8551.260547472626}, {"lowerIsBetter": false, "replicates": [1530.75507918733, 1540.391545339591, 1773.6452709458113, 1863.366455405162, 1899.9050047497622, 8010.5594192319395, 8134.064582573006, 8229.711960081399, 8348.081711011791, 8441.95779021104, 8147.796305092375, 8166.79583010425, 8203.26170644642, 8227.341812654988, 8261.380396470273, 2443.096054459848, 2472.1223965492263, 2473.2332976777166, 2478.3184624228393, 2482.9255122346267, 2474.7277799442045, 2558.168595206556, 2572.858492782896, 2582.0317380982133, 2585.7802086822644, 2432.075811191745, 2483.019207413071, 2492.7258001619807, 2494.775470207681, 2513.396784771651, 2482.0692240409844, 2485.9254222373356, 2498.650188973545, 2512.38446580588, 2530.2029860593852, 2469.1728271029046, 2495.9251222463354, 2496.5755821510206, 2515.6478093066985, 2527.330257481769, 8370.748877533684, 8379.70671026511, 8382.07797142314, 8423.410361274713, 8423.578821058984, 5086.847394578169, 5240.816571419982, 5278.155495120763, 5282.788688452457, 5297.576193904479, 3286.09632351103, 3326.3846188454972, 3353.144948038259, 3364.2934983653463, 3377.257003459235, 1013.4324778124274, 1017.5878769098526, 1096.5175322857917, 1916.444231172958, 2034.5422279987033, 10883.891161088366, 11102.056325212367, 11117.055050320732, 11121.388323642197, 11121.72195695106, 4686.757013789813, 4687.742174180453, 4787.832425865078, 4832.830850920201, 4841.394825646794, 9981.60073597048, 10013.49932503372, 10088.293819432569, 10089.142422894136, 10101.19190464761, 5243.23973023917, 5276.129438642658, 5290.259363689087, 5328.733563321818, 5367.0, 4829.758512074382, 4875.1224779540025, 4882.462929077798, 4902.48523904992, 4903.681260718042, 3892.143728379752, 3924.3328634132267, 3977.423273625366, 4021.1354558770004, 4027.275090483741, 1253.6051143889645, 1282.8652991435765, 1334.8197993270978, 1340.1958824705098, 1342.2483409290828, 1062.8193207154802, 1064.3294724323628, 1274.585759628106, 1376.2018029542842, 1459.0370355565276, 7536.472446928772, 7574.962125189339, 7620.390368770485, 7757.263060009403, 7759.806004849811, 573.0945106731355, 578.9913151302734, 581.3314688108625, 599.9141553787658, 763.6563546404029, 5863.941360586339, 5923.822285331447, 5991.191189189403, 6004.3395226525045, 6035.6076855004285, 9673.70978870635, 9787.853182202272, 9873.456959867277, 10033.799324013478, 10084.0, 9698.0, 9893.0, 9908.355956862924, 10010.249231307682, 10013.649522266685, 7708.460407771402, 7805.258500442449, 7813.804654883674, 7858.371330293563, 7891.802704932423, 8007.439479236397, 8056.194380561897, 8076.27313541784, 8087.393445491729, 8092.797680058045, 8587.441816281922, 8856.512891791013, 9066.365354425126, 9091.409058411182, 9178.862317065115, 8781.51701656415, 8965.058668839678, 9017.323700722342, 9040.954795225982, 9187.356885018253, 7176.641167941478, 7306.598137102298, 7326.0, 7326.0, 7344.926550734424, 7383.114026316876, 7548.320651141424, 7554.2823431773895, 7563.886541701769, 7580.05249343832, 6548.934510655023, 7310.853782924418, 7373.520721153108, 7469.1037075551285, 7649.349805266615, 7308.59802710856, 7354.816129596803, 7423.554586724814, 7431.3683336916965, 7516.812079698051, 7600.46796724224, 7620.085589729268, 7634.923650763643, 7645.159032506309, 7651.502652327581, 7005.0, 7039.894401583878, 7063.611501367269, 7071.540349877241, 7076.71693132269, 6936.271691472524, 6946.79159625212, 7054.858902821812, 7119.394851437479, 7168.247334029852], "unit": "score", "name": "mootools.html", "value": 4799.540965490399}, {"lowerIsBetter": false, "replicates": [352.1776651518704, 352.19523389056013, 352.84651176738134, 354.02995791531214, 361.96742293193614, 6251.906221406671, 6350.968245158773, 6376.904346434807, 6433.22801263849, 6459.385153711566, 6159.630422174672, 6309.873802523946, 6325.051242313655, 6338.176037115169, 6354.936450635492, 4756.762161891909, 4813.205821039524, 4853.053654537367, 4853.102176097415, 4878.829240976566, 4880.0, 4889.119958407486, 4890.388701412324, 4891.217405215166, 4900.387451568554, 4775.761211939406, 4820.734859582722, 4827.951720482785, 4840.394950631171, 4844.370231869852, 4812.32627432158, 4819.373481447425, 4827.903441931159, 4851.51484851512, 4859.489753575876, 4223.852165174204, 4224.767637779921, 4234.364845273203, 4236.364545318196, 4237.470316210473, 5961.225040744675, 6022.69886505673, 6023.518118550505, 6057.454829065361, 6065.332813390523, 5655.830325090254, 5667.603267771257, 5671.149327600851, 5671.347795003586, 5681.318241810968, 6768.6615669216835, 6772.255051944282, 6774.017767423746, 6777.830554236134, 6801.877690181114, 4713.410823647044, 4714.434267887841, 4728.739919304437, 4731.313959475891, 4746.1931471649905, 6930.72277108915, 7048.118985126859, 7064.222935477093, 7083.433325334013, 7092.397146242575, 4779.235322348477, 4800.3759511263315, 4816.301636262722, 4826.420829500483, 4846.36997190363, 4899.510048995072, 4902.142125128088, 4917.065757506062, 4918.2376731606655, 4931.112399768076, 5542.808296216333, 5646.463585959327, 5646.717664116778, 5654.46282603152, 5666.603337766317, 6806.081179040865, 6852.6916288767125, 6857.5199736018, 6862.348076932683, 6870.003849441903, 1689.7634331193642, 1699.2693141948832, 1721.956951076233, 1728.9221985010704, 1742.6950283700303, 1114.0975809594254, 1132.9320240785414, 1137.016480744167, 1145.8453108830367, 1155.5955415604471, 6501.609903405811, 6510.316416776171, 6524.412802847766, 6531.346865313526, 6531.673416329165, 6925.515213934977, 6932.341427564374, 6965.79102626922, 6981.3367730065565, 7002.159740831133, 6489.545731798823, 6501.252355979028, 6523.739050438025, 6530.673466326664, 6533.1180290661105, 3788.3938569829247, 3793.279276937373, 3804.5814960354337, 3808.5810560838286, 3809.6380843819793, 7098.396636285974, 7119.786406407816, 7170.0, 7177.102862142232, 7201.495895287384, 6999.615021173884, 7147.9285207148305, 7153.248908864494, 7166.211716711157, 7166.247544007804, 7111.182214045348, 7127.251638577978, 7170.103737032871, 7174.246704096099, 7184.389326907271, 6929.445644348541, 6938.687759050754, 6961.269066747918, 6963.303669633199, 6978.825529361604, 6721.966390168018, 6842.247352791289, 6880.346367095118, 6880.346367095118, 6891.035255064396, 7124.501284910007, 7172.067631208119, 7195.2085270619145, 7196.280371962762, 7199.992001119952, 4806.038792241636, 4841.733704646278, 4841.927371089366, 4842.7336496493035, 4852.0, 6860.073890024983, 6902.792916212522, 6950.165980082423, 6965.059716938148, 7007.124109486314, 6703.128593282842, 6719.05147507237, 6748.93251067483, 6750.763723269662, 6774.051632771318, 6736.056952026622, 6742.022406751092, 6751.426128778912, 6773.085633439423, 6781.050652908695, 6546.345365463416, 6658.966705166443, 6671.799846004627, 6674.666266686743, 6677.799666010027, 6759.324067593201, 6782.050512928293, 6787.151606049244, 6791.286914873867, 6795.218549866829, 6601.669916504252, 6629.3039230882, 6650.3682150195655, 6650.401463868275, 6675.198976122896], "unit": "score", "name": "prototype.html", "value": 5097.951922735744}, {"lowerIsBetter": false, "replicates": [792.5759718550573, 848.5290663681656, 865.329369738453, 886.0696268917636, 934.7008957133711, 14345.282735863204, 14396.0, 14439.42242310309, 14531.418743250271, 14538.70922581549, 12780.0, 15345.232738363093, 15478.535643930672, 15528.223588820541, 15569.610759731013, 858.3047731337605, 859.4370687199863, 868.1058509734983, 874.3442418186361, 891.38494438837, 880.8546589812673, 884.8186121845006, 886.4681191285242, 887.0685779931079, 890.185480285538, 902.3322741171552, 909.1317791509126, 909.5179554835947, 910.4218821048648, 913.0139449394671, 893.3255392178896, 896.3098414221046, 896.8161526886972, 900.9729708108767, 903.4263242840777, 663.2803408301999, 664.5248647217214, 664.5846346033729, 665.9234188068338, 668.84616538196, 15193.088414695154, 15271.770923436157, 15287.159206243652, 15320.387184512607, 15321.157336346496, 13682.384292706853, 13722.382492787849, 13779.448822047107, 13798.862011379959, 13893.513727019506, 11351.375674337909, 11433.828492572535, 11482.368469734161, 11691.94154029233, 11741.88258117425, 3921.627445392683, 3940.310445672025, 3970.602939706035, 3979.5423526294558, 4006.979965100185, 52341.0, 52622.73688631571, 52850.47149528494, 52863.73568132135, 53136.0, 10219.995817191337, 10324.225683073799, 10466.267361284637, 10621.150307975344, 10742.73143171427, 18860.24559017624, 18867.622647546974, 18926.33757818497, 19243.51891202731, 19275.0, 7711.26742959418, 7741.92258077412, 7780.416468764865, 7902.0, 8103.230193131643, 4821.349117869113, 4845.273209018605, 4874.610031197496, 4932.827351042696, 4964.131277026579, 3270.787398819117, 3308.073739352985, 3315.1712071982006, 3327.983360083184, 3329.1177837872983, 579.5566391710345, 579.9449052340021, 584.3688816078625, 598.7096258314714, 599.556328317051, 520.092438694473, 559.3958524793213, 574.9942500575024, 580.7357652268208, 602.5902386377218, 9033.457992520469, 9050.909490905007, 9170.349337119382, 9230.907690923139, 10160.374340105547, 526.9104252277122, 579.2701196492366, 650.8828410885991, 691.7129391302553, 724.026184781468, 4380.4305440292555, 4533.138703646297, 4646.5353464653945, 4712.128256272601, 4736.076465089274, 58643.4135658638, 58776.70611646914, 58994.0, 59440.40559594435, 59627.701861490415, 53903.46096539063, 54844.72577637086, 56514.0, 56622.43377566254, 56645.15032274519, 48119.51880481221, 49552.256716149284, 50015.0, 50885.23672144921, 50940.74529627328, 9087.36388452802, 9108.726738197865, 9119.0, 9258.120478554527, 9447.53644620742, 35533.46699799453, 36159.096022599646, 36792.63207367892, 36795.44806827953, 37530.0, 44808.551914480435, 48672.26991595058, 48698.26952595785, 48832.75583622059, 49501.257481138535, 11243.212975091992, 11330.093592512743, 11383.829242561535, 11460.426978650867, 11846.11154163424, 12286.508539658313, 12818.807717884425, 12855.485780568673, 12966.416511257205, 12977.416016279101, 12326.322052286852, 12693.174943628635, 12716.427760750974, 12813.551525696555, 13005.154664946747, 12088.214266072677, 12478.251304921734, 12649.557265495663, 12673.619791406272, 12751.808722868978, 11653.359065251492, 11707.707307317045, 11750.94124529372, 12079.222757811063, 12404.441800118835, 9789.804203916025, 9894.257930655374, 9936.850947235942, 9939.105480506789, 9973.900260997298, 10037.598496060076, 10342.37945723259, 10539.156867450432, 10548.525316360628, 10587.20595955322], "unit": "score", "name": "yui.html", "value": 6746.88976242348}], "name": "dromaeo_css", "value": 7261.738977582302}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 108.0, 114.0, 122.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 148.0, 160.0, 128.0, 154.0, 153.0, 130.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 161.0, 163.0, 162.0, 161.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 76.0, 153.0, 76.0, 74.0, 76.0, 76.0, 171.0, 77.0], "unit": "score", "name": "audio-fft", "value": 92.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 151.0, 96.0, 101.0, 96.0, 137.0, 95.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 98.0, 101.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 55.0, 56.0, 59.0, 55.0, 55.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [89.0, 80.0, 83.0, 86.0, 85.0, 89.0, 83.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 121.0, 114.0, 112.0, 115.0, 118.0, 119.0, 114.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.6}, {"lowerIsBetter": true, "replicates": [135.0, 147.0, 136.0, 127.0, 125.0, 135.0, 136.0, 124.0, 132.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 64.0, 66.0, 65.0, 65.0, 70.0, 67.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1493.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [169.92353440951572], "unit": "score", "name": "DeltaBlue", "value": 389.1044300000001}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [569.1519635742743], "unit": "score", "name": "Earley", "value": 1170.975491}, {"lowerIsBetter": false, "replicates": [11087.912087912087], "unit": "score", "name": "Boyer", "value": 60.107168483647186}, {"lowerIsBetter": false, "replicates": [39711.53846153846], "unit": "score", "name": "RegExp", "value": 22.94005811138016}, {"lowerIsBetter": false, "replicates": [518.9413596263622], "unit": "score", "name": "Splay", "value": 157.03315700000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21901.74748859677}]} 12:52:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21901.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1493.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7261.74"}}} 12:52:31 INFO - Return code: 0 12:52:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:52:31 INFO - # TBPL SUCCESS # 12:52:31 INFO - Running post-action listener: _resource_record_post_action 12:52:31 INFO - Running post-run listener: _resource_record_post_run 12:52:32 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 518606848; Read time: 0; Write time: 1411944 12:52:32 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 239583232; Read time: 0; Write time: 1020888 12:52:32 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 263905280; Read time: 0; Write time: 372364 12:52:32 INFO - Running post-run listener: _upload_blobber_files 12:52:32 INFO - Blob upload gear active. 12:52:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 12:52:32 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 12:52:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 12:52:32 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 12:52:33 INFO - (blobuploader) - INFO - Open directory for files ... 12:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:52:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:34 INFO - (blobuploader) - INFO - Done attempting. 12:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:52:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:35 INFO - (blobuploader) - INFO - Done attempting. 12:52:35 INFO - (blobuploader) - INFO - Iteration through files over. 12:52:35 INFO - Return code: 0 12:52:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 12:52:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 12:52:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/195cb3095b5fdead846d8cb0ec256c9a05a2514dc74dcdac6916dbd2fe6dd8a316248c55cda7e09e3658f2d1305dc4cef9e8dcc42d2b6720c5dbc76281484d7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a18c9ebe01d6ac0e4aa7074dc1ed53b87bab329fca4a96c5483b7692d43623d91ddda3f3d24c6d73eb38fb0d6f20b59060462b50db00d40d033661d24e34141"} 12:52:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 12:52:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 12:52:35 INFO - Contents: 12:52:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/195cb3095b5fdead846d8cb0ec256c9a05a2514dc74dcdac6916dbd2fe6dd8a316248c55cda7e09e3658f2d1305dc4cef9e8dcc42d2b6720c5dbc76281484d7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a18c9ebe01d6ac0e4aa7074dc1ed53b87bab329fca4a96c5483b7692d43623d91ddda3f3d24c6d73eb38fb0d6f20b59060462b50db00d40d033661d24e34141"} 12:52:35 INFO - Running post-run listener: copy_logs_to_upload_dir 12:52:35 INFO - Copying logs to upload dir... 12:52:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 12:52:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.262207 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 12:52:34.698618) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 12:52:34.701863) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/195cb3095b5fdead846d8cb0ec256c9a05a2514dc74dcdac6916dbd2fe6dd8a316248c55cda7e09e3658f2d1305dc4cef9e8dcc42d2b6720c5dbc76281484d7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a18c9ebe01d6ac0e4aa7074dc1ed53b87bab329fca4a96c5483b7692d43623d91ddda3f3d24c6d73eb38fb0d6f20b59060462b50db00d40d033661d24e34141"} build_url:https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Qs-rEjwBQoeLLpKIc-6HgA/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/195cb3095b5fdead846d8cb0ec256c9a05a2514dc74dcdac6916dbd2fe6dd8a316248c55cda7e09e3658f2d1305dc4cef9e8dcc42d2b6720c5dbc76281484d7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a18c9ebe01d6ac0e4aa7074dc1ed53b87bab329fca4a96c5483b7692d43623d91ddda3f3d24c6d73eb38fb0d6f20b59060462b50db00d40d033661d24e34141"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 12:52:34.727219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:52:34.727682) ========= 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=745a4373a2a16df560f216e000000264-1453753883.43987-2022472447 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 12:52:34.810671) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 12:52:34.811152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 12:52:34.811562) ========= ========= Total master_lag: 0.27 =========