builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1455780136.69 results: success (0) buildid: 20160217203148 builduid: 816943245ed24d92ba63757c302e9c17 revision: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.689055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.689458) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.689776) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.712608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.712877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.729159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.729411) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.778894) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.779242) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.779599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.779882) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 23:22:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-02-17 23:22:17 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.896126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.896456) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.946545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:16.946895) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb --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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 23:22:17,202 truncating revision to first 12 chars 2016-02-17 23:22:17,202 Setting DEBUG logging. 2016-02-17 23:22:17,202 attempt 1/10 2016-02-17 23:22:17,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b35f0a98eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 23:22:17,482 unpacking tar archive at: fx-team-3b35f0a98eba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:17.535680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:17.536010) ========= echo 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb'] 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb program finished with exit code 0 elapsedTime=0.004673 script_repo_revision: '3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:17.586732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:17.587037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 23:22:17.597257) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-17 23:22:17.597556) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:17 INFO - MultiFileLogger online at 20160217 23:22:17 in /builds/slave/test-pgo 23:22:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:22:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:22:17 INFO - {'append_to_log': False, 23:22:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:22:17 INFO - 'blob_upload_branch': 'Fx-Team', 23:22:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:22:17 INFO - 'branch': 'Fx-Team', 23:22:17 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:17 INFO - 'config_files': ('talos/linux_config.py',), 23:22:17 INFO - 'default_actions': ('clobber', 23:22:17 INFO - 'read-buildbot-config', 23:22:17 INFO - 'download-and-extract', 23:22:17 INFO - 'populate-webroot', 23:22:17 INFO - 'create-virtualenv', 23:22:17 INFO - 'install', 23:22:17 INFO - 'run-tests'), 23:22:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:17 INFO - 'download_minidump_stackwalk': True, 23:22:17 INFO - 'download_symbols': 'ondemand', 23:22:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:17 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:17 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:17 INFO - 'installer_path': 'installer.exe', 23:22:17 INFO - 'log_level': 'info', 23:22:17 INFO - 'log_name': 'talos', 23:22:17 INFO - 'log_to_console': True, 23:22:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:17 INFO - 'opt_config_files': (), 23:22:17 INFO - 'pip_index': False, 23:22:17 INFO - 'sps_profile': False, 23:22:17 INFO - 'sps_profile_interval': 0, 23:22:17 INFO - 'suite': 'dromaeojs', 23:22:17 INFO - 'system_bits': '32', 23:22:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:17 INFO - 'title': 'talos-linux64-ix-055', 23:22:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:17 INFO - 'use_talos_json': True, 23:22:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:22:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:17 INFO - 'work_dir': 'build'} 23:22:17 INFO - ##### 23:22:17 INFO - ##### Running clobber step. 23:22:17 INFO - ##### 23:22:17 INFO - Running pre-action listener: _resource_record_pre_action 23:22:17 INFO - Running main action method: clobber 23:22:17 INFO - rmtree: /builds/slave/test-pgo/build 23:22:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:22:18 INFO - Running post-action listener: _resource_record_post_action 23:22:18 INFO - ##### 23:22:18 INFO - ##### Running read-buildbot-config step. 23:22:18 INFO - ##### 23:22:18 INFO - Running pre-action listener: _resource_record_pre_action 23:22:18 INFO - Running main action method: read_buildbot_config 23:22:18 INFO - Using buildbot properties: 23:22:18 INFO - { 23:22:18 INFO - "project": "", 23:22:18 INFO - "product": "firefox", 23:22:18 INFO - "script_repo_revision": "production", 23:22:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:22:18 INFO - "repository": "", 23:22:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:22:18 INFO - "buildid": "20160217203148", 23:22:18 INFO - "pgo_build": "True", 23:22:18 INFO - "basedir": "/builds/slave/test-pgo", 23:22:18 INFO - "buildnumber": 947, 23:22:18 INFO - "slavename": "talos-linux64-ix-055", 23:22:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:22:18 INFO - "platform": "ubuntu64_hw", 23:22:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:22:18 INFO - "branch": "fx-team", 23:22:18 INFO - "repo_path": "integration/fx-team", 23:22:18 INFO - "revision": "3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb", 23:22:18 INFO - "stage_platform": "linux64-pgo", 23:22:18 INFO - "builduid": "816943245ed24d92ba63757c302e9c17", 23:22:18 INFO - "slavebuilddir": "test" 23:22:18 INFO - } 23:22:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 23:22:18 INFO - Running post-action listener: _resource_record_post_action 23:22:18 INFO - ##### 23:22:18 INFO - ##### Running download-and-extract step. 23:22:18 INFO - ##### 23:22:18 INFO - Running pre-action listener: _resource_record_pre_action 23:22:18 INFO - Running main action method: download_and_extract 23:22:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:22:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:18 INFO - https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/test_packages.json 23:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/test_packages.json 23:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:22:22 INFO - Downloaded 1448 bytes. 23:22:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:22:22 INFO - Using the following test package requirements: 23:22:22 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:22:22 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:22 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:22:22 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'jsshell-linux-x86_64.zip'], 23:22:22 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:22 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:22:22 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:22:22 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:22:22 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:22 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:22:22 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:22:22 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:22 INFO - https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:23 INFO - Downloaded 23346734 bytes. 23:22:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:22:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:22:24 INFO - Return code: 0 23:22:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:24 INFO - https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:22:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:22:25 INFO - Downloaded 23346734 bytes. 23:22:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:22:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 23:22:27 INFO - Return code: 0 23:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:27 INFO - https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:22:28 INFO - Downloaded 10707071 bytes. 23:22:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 23:22:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 23:22:28 INFO - Return code: 0 23:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:28 INFO - https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:22:30 INFO - Downloaded 56570076 bytes. 23:22:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:22:30 INFO - mkdir: /builds/slave/test-pgo/properties 23:22:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:22:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:22:30 INFO - Contents: 23:22:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:22:31 INFO - Running post-action listener: _resource_record_post_action 23:22:31 INFO - Running post-action listener: set_extra_try_arguments 23:22:31 INFO - ##### 23:22:31 INFO - ##### Running populate-webroot step. 23:22:31 INFO - ##### 23:22:31 INFO - Running pre-action listener: _resource_record_pre_action 23:22:31 INFO - Running main action method: populate_webroot 23:22:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:31 INFO - '--tppagecycles', 23:22:31 INFO - '7'], 23:22:31 INFO - 'tests': ['tsvgm']}}, 23:22:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:22:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:22:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'tests': ['damp', 'tps']}, 23:22:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['damp', 'tps']}, 23:22:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:22:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:31 INFO - 'other': {'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'other_l64': {'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'other_nol64': {'tests': ['a11yr', 23:22:31 INFO - 'ts_paint', 23:22:31 INFO - 'tpaint', 23:22:31 INFO - 'sessionrestore', 23:22:31 INFO - 'sessionrestore_no_auto_restore']}, 23:22:31 INFO - 'svgr': {'tests': ['tsvgx', 23:22:31 INFO - 'tsvgr_opacity', 23:22:31 INFO - 'tart', 23:22:31 INFO - 'tscrollx', 23:22:31 INFO - 'cart']}, 23:22:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['tsvgx', 23:22:31 INFO - 'tsvgr_opacity', 23:22:31 INFO - 'tart', 23:22:31 INFO - 'tscrollx', 23:22:31 INFO - 'cart']}, 23:22:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'tests': ['tp5o']}, 23:22:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'talos_options': ['--e10s'], 23:22:31 INFO - 'tests': ['tp5o']}, 23:22:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'talos_options': ['--xperf_path', 23:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:31 INFO - 'tests': ['tp5n']}, 23:22:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:31 INFO - 'talos_options': ['--e10s', 23:22:31 INFO - '--xperf_path', 23:22:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:31 INFO - 'tests': ['tp5n']}}, 23:22:31 INFO - 'talos.zip': {'path': '', 23:22:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:31 INFO - Running post-action listener: _resource_record_post_action 23:22:31 INFO - ##### 23:22:31 INFO - ##### Running create-virtualenv step. 23:22:31 INFO - ##### 23:22:31 INFO - Running pre-action listener: _resource_record_pre_action 23:22:31 INFO - Running main action method: create_virtualenv 23:22:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:22:31 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 23:22:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:22:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:31 INFO - Using real prefix '/usr' 23:22:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:22:31 INFO - Installing distribute.............................................................................................................................................................................................done. 23:22:33 INFO - Installing pip.................done. 23:22:33 INFO - Return code: 0 23:22:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:22: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')]} 23:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:22:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:22:33 INFO - Using env: {'DISPLAY': ':0', 23:22:33 INFO - 'HOME': '/home/cltbld', 23:22:33 INFO - 'LANG': 'en_US.UTF-8', 23:22:33 INFO - 'LANGUAGE': 'en_US:en', 23:22:33 INFO - 'LOGNAME': 'cltbld', 23:22:33 INFO - 'MAIL': '/var/mail/cltbld', 23:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:33 INFO - 'MOZ_NO_REMOTE': '1', 23:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:33 INFO - 'NO_EM_RESTART': '1', 23:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:33 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:33 INFO - 'SHELL': '/bin/bash', 23:22:33 INFO - 'SHLVL': '1', 23:22:33 INFO - 'TERM': 'linux', 23:22:33 INFO - 'TMOUT': '86400', 23:22:33 INFO - 'USER': 'cltbld', 23:22:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:33 INFO - '_': '/tools/buildbot/bin/python'} 23:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:33 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 23:22:33 INFO - Cleaning up... 23:22:33 INFO - Return code: 0 23:22:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:22: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')]} 23:22:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:22:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 23:22:33 INFO - Using env: {'DISPLAY': ':0', 23:22:33 INFO - 'HOME': '/home/cltbld', 23:22:33 INFO - 'LANG': 'en_US.UTF-8', 23:22:33 INFO - 'LANGUAGE': 'en_US:en', 23:22:33 INFO - 'LOGNAME': 'cltbld', 23:22:33 INFO - 'MAIL': '/var/mail/cltbld', 23:22:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:33 INFO - 'MOZ_NO_REMOTE': '1', 23:22:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:33 INFO - 'NO_EM_RESTART': '1', 23:22:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:33 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:33 INFO - 'SHELL': '/bin/bash', 23:22:33 INFO - 'SHLVL': '1', 23:22:33 INFO - 'TERM': 'linux', 23:22:33 INFO - 'TMOUT': '86400', 23:22:33 INFO - 'USER': 'cltbld', 23:22:33 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:33 INFO - '_': '/tools/buildbot/bin/python'} 23:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:34 INFO - Downloading/unpacking psutil>=0.7.1 23:22:34 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 23:22:34 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 23:22:34 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 23:22:34 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 23:22:34 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 23:22:34 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 23:22:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:36 INFO - Installing collected packages: psutil 23:22:36 INFO - Running setup.py install for psutil 23:22:36 INFO - building 'psutil._psutil_linux' extension 23:22:36 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 23:22:36 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 23:22:36 INFO - building 'psutil._psutil_posix' extension 23:22:36 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 23:22:36 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 23:22:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:22:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:22:36 INFO - Successfully installed psutil 23:22:36 INFO - Cleaning up... 23:22:36 INFO - Return code: 0 23:22:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:36 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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:36 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 23:22:36 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 23:22:36 INFO - Using env: {'DISPLAY': ':0', 23:22:36 INFO - 'HOME': '/home/cltbld', 23:22:36 INFO - 'LANG': 'en_US.UTF-8', 23:22:36 INFO - 'LANGUAGE': 'en_US:en', 23:22:36 INFO - 'LOGNAME': 'cltbld', 23:22:36 INFO - 'MAIL': '/var/mail/cltbld', 23:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:36 INFO - 'MOZ_NO_REMOTE': '1', 23:22:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:36 INFO - 'NO_EM_RESTART': '1', 23:22:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:36 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:36 INFO - 'SHELL': '/bin/bash', 23:22:36 INFO - 'SHLVL': '1', 23:22:36 INFO - 'TERM': 'linux', 23:22:36 INFO - 'TMOUT': '86400', 23:22:36 INFO - 'USER': 'cltbld', 23:22:36 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:36 INFO - '_': '/tools/buildbot/bin/python'} 23:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:36 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 23:22:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:22:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:22:38 INFO - Installing collected packages: mozsystemmonitor 23:22:38 INFO - Running setup.py install for mozsystemmonitor 23:22:38 INFO - Successfully installed mozsystemmonitor 23:22:38 INFO - Cleaning up... 23:22:38 INFO - Return code: 0 23:22:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:38 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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:38 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 23:22:38 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 23:22:38 INFO - Using env: {'DISPLAY': ':0', 23:22:38 INFO - 'HOME': '/home/cltbld', 23:22:38 INFO - 'LANG': 'en_US.UTF-8', 23:22:38 INFO - 'LANGUAGE': 'en_US:en', 23:22:38 INFO - 'LOGNAME': 'cltbld', 23:22:38 INFO - 'MAIL': '/var/mail/cltbld', 23:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:38 INFO - 'MOZ_NO_REMOTE': '1', 23:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:38 INFO - 'NO_EM_RESTART': '1', 23:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:38 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:38 INFO - 'SHELL': '/bin/bash', 23:22:38 INFO - 'SHLVL': '1', 23:22:38 INFO - 'TERM': 'linux', 23:22:38 INFO - 'TMOUT': '86400', 23:22:38 INFO - 'USER': 'cltbld', 23:22:38 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:38 INFO - '_': '/tools/buildbot/bin/python'} 23:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:39 INFO - Downloading/unpacking blobuploader==1.2.4 23:22:39 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 23:22:39 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 23:22:39 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 23:22:39 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 23:22:39 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 23:22:39 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 23:22:40 INFO - Downloading blobuploader-1.2.4.tar.gz 23:22:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:22:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:22:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:41 INFO - Downloading docopt-0.6.1.tar.gz 23:22:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:22:41 INFO - Installing collected packages: blobuploader, requests, docopt 23:22:41 INFO - Running setup.py install for blobuploader 23:22:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:22:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:22:41 INFO - Running setup.py install for requests 23:22:41 INFO - Running setup.py install for docopt 23:22:42 INFO - Successfully installed blobuploader requests docopt 23:22:42 INFO - Cleaning up... 23:22:42 INFO - Return code: 0 23:22:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:22: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')]} 23:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:42 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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:42 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 23:22:42 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 23:22:42 INFO - Using env: {'DISPLAY': ':0', 23:22:42 INFO - 'HOME': '/home/cltbld', 23:22:42 INFO - 'LANG': 'en_US.UTF-8', 23:22:42 INFO - 'LANGUAGE': 'en_US:en', 23:22:42 INFO - 'LOGNAME': 'cltbld', 23:22:42 INFO - 'MAIL': '/var/mail/cltbld', 23:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:42 INFO - 'MOZ_NO_REMOTE': '1', 23:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:42 INFO - 'NO_EM_RESTART': '1', 23:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:42 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:42 INFO - 'SHELL': '/bin/bash', 23:22:42 INFO - 'SHLVL': '1', 23:22:42 INFO - 'TERM': 'linux', 23:22:42 INFO - 'TMOUT': '86400', 23:22:42 INFO - 'USER': 'cltbld', 23:22:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:42 INFO - '_': '/tools/buildbot/bin/python'} 23:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:22:42 INFO - Running setup.py (path:/tmp/pip-62pU93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:22:42 INFO - Running setup.py (path:/tmp/pip-FnD4sP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:22:42 INFO - Running setup.py (path:/tmp/pip-QqFewM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:22:42 INFO - Running setup.py (path:/tmp/pip-LAYIX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:22:42 INFO - Running setup.py (path:/tmp/pip-RA112v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:22:42 INFO - Running setup.py (path:/tmp/pip-CFEPKc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:22:42 INFO - Running setup.py (path:/tmp/pip-GgZ18m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:22:42 INFO - Running setup.py (path:/tmp/pip-PYFTvp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:22:42 INFO - Running setup.py (path:/tmp/pip-FqZyOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:22:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:22:42 INFO - Running setup.py (path:/tmp/pip-mirhrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:22:43 INFO - Running setup.py (path:/tmp/pip-SMkQQK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:22:43 INFO - Running setup.py (path:/tmp/pip-6bLERR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:22:43 INFO - Running setup.py (path:/tmp/pip-QNVtxR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:22:43 INFO - Running setup.py (path:/tmp/pip-RAjRGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:22:43 INFO - Running setup.py (path:/tmp/pip-xlWk4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:22:43 INFO - Running setup.py (path:/tmp/pip-MqTMKl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:22:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:22:43 INFO - Running setup.py (path:/tmp/pip-FstKzf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:22:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:22:43 INFO - Running setup.py install for manifestparser 23:22:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:22:43 INFO - Running setup.py install for mozcrash 23:22:43 INFO - Running setup.py install for mozdebug 23:22:43 INFO - Running setup.py install for mozdevice 23:22:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozfile 23:22:44 INFO - Running setup.py install for mozhttpd 23:22:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozinfo 23:22:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozInstall 23:22:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozleak 23:22:44 INFO - Running setup.py install for mozlog 23:22:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for moznetwork 23:22:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozprocess 23:22:44 INFO - Running setup.py install for mozprofile 23:22:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:22:44 INFO - Running setup.py install for mozrunner 23:22:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:22:45 INFO - Running setup.py install for mozscreenshot 23:22:45 INFO - Running setup.py install for moztest 23:22:45 INFO - Running setup.py install for mozversion 23:22:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:22:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:22:45 INFO - Cleaning up... 23:22:45 INFO - Return code: 0 23:22:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:45 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 23:22:45 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 23:22:45 INFO - Using env: {'DISPLAY': ':0', 23:22:45 INFO - 'HOME': '/home/cltbld', 23:22:45 INFO - 'LANG': 'en_US.UTF-8', 23:22:45 INFO - 'LANGUAGE': 'en_US:en', 23:22:45 INFO - 'LOGNAME': 'cltbld', 23:22:45 INFO - 'MAIL': '/var/mail/cltbld', 23:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:45 INFO - 'MOZ_NO_REMOTE': '1', 23:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:45 INFO - 'NO_EM_RESTART': '1', 23:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:45 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:45 INFO - 'SHELL': '/bin/bash', 23:22:45 INFO - 'SHLVL': '1', 23:22:45 INFO - 'TERM': 'linux', 23:22:45 INFO - 'TMOUT': '86400', 23:22:45 INFO - 'USER': 'cltbld', 23:22:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:45 INFO - '_': '/tools/buildbot/bin/python'} 23:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:22:45 INFO - Running setup.py (path:/tmp/pip-l8zNIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:22:45 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)) 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:22:45 INFO - Running setup.py (path:/tmp/pip-fSruIp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:22:45 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)) 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:22:45 INFO - Running setup.py (path:/tmp/pip-xMT5Qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:22:45 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)) 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:22:45 INFO - Running setup.py (path:/tmp/pip-ijhejP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:22:45 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)) 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:22:45 INFO - Running setup.py (path:/tmp/pip-8HZSV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:22:45 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)) 23:22:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:22:45 INFO - Running setup.py (path:/tmp/pip-C2S66J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:22:46 INFO - Running setup.py (path:/tmp/pip-uDWqSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:22:46 INFO - Running setup.py (path:/tmp/pip-TIZckb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:22:46 INFO - Running setup.py (path:/tmp/pip-A1eT_5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:22:46 INFO - Running setup.py (path:/tmp/pip-iCyxaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:22:46 INFO - Running setup.py (path:/tmp/pip-6pm39X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:22:46 INFO - Running setup.py (path:/tmp/pip-70b0Ca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:22:46 INFO - Running setup.py (path:/tmp/pip-X9O_xn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:22:46 INFO - Running setup.py (path:/tmp/pip-cWVsM4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:22:46 INFO - Running setup.py (path:/tmp/pip-hTemsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:22:46 INFO - Running setup.py (path:/tmp/pip-AsZ5wP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:22:46 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)) 23:22:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:22:46 INFO - Running setup.py (path:/tmp/pip-St1cea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:22:46 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)) 23:22:46 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)) 23:22:46 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)) 23:22:46 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)) 23:22:46 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)) 23:22:46 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)) 23:22:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:48 INFO - Downloading blessings-1.6.tar.gz 23:22:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:22:48 INFO - Installing collected packages: blessings 23:22:48 INFO - Running setup.py install for blessings 23:22:48 INFO - Successfully installed blessings 23:22:48 INFO - Cleaning up... 23:22:48 INFO - Return code: 0 23:22:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:22:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:22:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:22:49 INFO - Reading from file tmpfile_stdout 23:22:49 INFO - Current package versions: 23:22:49 INFO - argparse == 1.2.1 23:22:49 INFO - blessings == 1.6 23:22:49 INFO - blobuploader == 1.2.4 23:22:49 INFO - docopt == 0.6.1 23:22:49 INFO - manifestparser == 1.1 23:22:49 INFO - mozInstall == 1.12 23:22:49 INFO - mozcrash == 0.16 23:22:49 INFO - mozdebug == 0.1 23:22:49 INFO - mozdevice == 0.48 23:22:49 INFO - mozfile == 1.2 23:22:49 INFO - mozhttpd == 0.7 23:22:49 INFO - mozinfo == 0.9 23:22:49 INFO - mozleak == 0.1 23:22:49 INFO - mozlog == 3.1 23:22:49 INFO - moznetwork == 0.27 23:22:49 INFO - mozprocess == 0.22 23:22:49 INFO - mozprofile == 0.28 23:22:49 INFO - mozrunner == 6.11 23:22:49 INFO - mozscreenshot == 0.1 23:22:49 INFO - mozsystemmonitor == 0.0 23:22:49 INFO - moztest == 0.7 23:22:49 INFO - mozversion == 1.4 23:22:49 INFO - psutil == 3.1.1 23:22:49 INFO - requests == 1.2.3 23:22:49 INFO - wsgiref == 0.1.2 23:22:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:22: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')]} 23:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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/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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:49 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 23:22:49 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 23:22:49 INFO - Using env: {'DISPLAY': ':0', 23:22:49 INFO - 'HOME': '/home/cltbld', 23:22:49 INFO - 'LANG': 'en_US.UTF-8', 23:22:49 INFO - 'LANGUAGE': 'en_US:en', 23:22:49 INFO - 'LOGNAME': 'cltbld', 23:22:49 INFO - 'MAIL': '/var/mail/cltbld', 23:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:49 INFO - 'MOZ_NO_REMOTE': '1', 23:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:49 INFO - 'NO_EM_RESTART': '1', 23:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:49 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:49 INFO - 'SHELL': '/bin/bash', 23:22:49 INFO - 'SHLVL': '1', 23:22:49 INFO - 'TERM': 'linux', 23:22:49 INFO - 'TMOUT': '86400', 23:22:49 INFO - 'USER': 'cltbld', 23:22:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:49 INFO - '_': '/tools/buildbot/bin/python'} 23:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 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)) 23:22:49 INFO - Cleaning up... 23:22:49 INFO - Return code: 0 23:22:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:22: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')]} 23:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22: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')]} 23:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:49 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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:49 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 23:22:49 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 23:22:49 INFO - Using env: {'DISPLAY': ':0', 23:22:49 INFO - 'HOME': '/home/cltbld', 23:22:49 INFO - 'LANG': 'en_US.UTF-8', 23:22:49 INFO - 'LANGUAGE': 'en_US:en', 23:22:49 INFO - 'LOGNAME': 'cltbld', 23:22:49 INFO - 'MAIL': '/var/mail/cltbld', 23:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:49 INFO - 'MOZ_NO_REMOTE': '1', 23:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:49 INFO - 'NO_EM_RESTART': '1', 23:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:49 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:49 INFO - 'SHELL': '/bin/bash', 23:22:49 INFO - 'SHLVL': '1', 23:22:49 INFO - 'TERM': 'linux', 23:22:49 INFO - 'TMOUT': '86400', 23:22:49 INFO - 'USER': 'cltbld', 23:22:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:49 INFO - '_': '/tools/buildbot/bin/python'} 23:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:49 INFO - Downloading/unpacking jsonschema 23:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:22:51 INFO - Downloading/unpacking functools32 (from jsonschema) 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 INFO - Downloading functools32-3.2.3-2.tar.gz 23:22:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:22:51 INFO - warning: no files found matching '*.txt' 23:22:51 INFO - no previously-included directories found matching 'build' 23:22:51 INFO - no previously-included directories found matching 'dist' 23:22:51 INFO - no previously-included directories found matching '.git*' 23:22:51 INFO - Installing collected packages: jsonschema, functools32 23:22:51 INFO - Running setup.py install for functools32 23:22:51 INFO - warning: no files found matching '*.txt' 23:22:51 INFO - no previously-included directories found matching 'build' 23:22:51 INFO - no previously-included directories found matching 'dist' 23:22:51 INFO - no previously-included directories found matching '.git*' 23:22:51 INFO - Successfully installed jsonschema functools32 23:22:51 INFO - Cleaning up... 23:22:51 INFO - Return code: 0 23:22:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:22:51 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')]} 23:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 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')]} 23:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:22:51 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 0x7f060d5aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x224d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, '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': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', '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 23:22:51 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 23:22:51 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 23:22:51 INFO - Using env: {'DISPLAY': ':0', 23:22:51 INFO - 'HOME': '/home/cltbld', 23:22:51 INFO - 'LANG': 'en_US.UTF-8', 23:22:51 INFO - 'LANGUAGE': 'en_US:en', 23:22:51 INFO - 'LOGNAME': 'cltbld', 23:22:51 INFO - 'MAIL': '/var/mail/cltbld', 23:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:22:51 INFO - 'MOZ_NO_REMOTE': '1', 23:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:22:51 INFO - 'NO_EM_RESTART': '1', 23:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:22:51 INFO - 'PWD': '/builds/slave/test-pgo', 23:22:51 INFO - 'SHELL': '/bin/bash', 23:22:51 INFO - 'SHLVL': '1', 23:22:51 INFO - 'TERM': 'linux', 23:22:51 INFO - 'TMOUT': '86400', 23:22:51 INFO - 'USER': 'cltbld', 23:22:51 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:22:51 INFO - '_': '/tools/buildbot/bin/python'} 23:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:22:51 INFO - Downloading/unpacking flake8 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:51 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 23:22:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:22:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:22:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22: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 23:22:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:22:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:22:54 INFO - no previously-included directories found matching 'docs/_build' 23:22:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:22:54 INFO - Running setup.py install for pep8 23:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:22:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:22:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:22:54 INFO - no previously-included directories found matching 'docs/_build' 23:22:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:22:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:22:54 INFO - Cleaning up... 23:22:54 INFO - Return code: 0 23:22:54 INFO - Running post-action listener: _resource_record_post_action 23:22:54 INFO - Running post-action listener: _start_resource_monitoring 23:22:54 INFO - Starting resource monitoring. 23:22:54 INFO - ##### 23:22:54 INFO - ##### Running install step. 23:22:54 INFO - ##### 23:22:54 INFO - Running pre-action listener: _resource_record_pre_action 23:22:54 INFO - Running main action method: install 23:22:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:22:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:22:54 INFO - Reading from file tmpfile_stdout 23:22:54 INFO - Detecting whether we're running mozinstall >=1.0... 23:22:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:22:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:22:55 INFO - Reading from file tmpfile_stdout 23:22:55 INFO - Output received: 23:22:55 INFO - Usage: mozinstall [options] installer 23:22:55 INFO - Options: 23:22:55 INFO - -h, --help show this help message and exit 23:22:55 INFO - -d DEST, --destination=DEST 23:22:55 INFO - Directory to install application into. [default: 23:22:55 INFO - "/builds/slave/test-pgo"] 23:22:55 INFO - --app=APP Application being installed. [default: firefox] 23:22:55 INFO - mkdir: /builds/slave/test-pgo/build/application 23:22:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:22:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:23:11 INFO - Reading from file tmpfile_stdout 23:23:11 INFO - Output received: 23:23:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:23:11 INFO - Running post-action listener: _resource_record_post_action 23:23:11 INFO - ##### 23:23:11 INFO - ##### Running run-tests step. 23:23:11 INFO - ##### 23:23:11 INFO - Running pre-action listener: _resource_record_pre_action 23:23:11 INFO - Running main action method: run_tests 23:23:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:23:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:23:11 INFO - Python 2.7.3 23:23:11 INFO - Return code: 0 23:23:11 INFO - grabbing minidump binary from tooltool 23:23:11 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')]} 23:23:11 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 0x22dc8c0>, '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 0x22dd7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22ddc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:23:11 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 23:23:11 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 23:23:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:11 INFO - Return code: 0 23:23:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:23:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:23:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:23:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:23:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:23:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:23:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:23:12 INFO - Return code: 0 23:23:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 23:23:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 23:23:12 INFO - Using env: {'DISPLAY': ':0', 23:23:12 INFO - 'HOME': '/home/cltbld', 23:23:12 INFO - 'LANG': 'en_US.UTF-8', 23:23:12 INFO - 'LANGUAGE': 'en_US:en', 23:23:12 INFO - 'LOGNAME': 'cltbld', 23:23:12 INFO - 'MAIL': '/var/mail/cltbld', 23:23:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:23:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:12 INFO - 'MOZ_NO_REMOTE': '1', 23:23:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:12 INFO - 'NO_EM_RESTART': '1', 23:23:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:23:12 INFO - 'PWD': '/builds/slave/test-pgo', 23:23:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:23:12 INFO - 'SHELL': '/bin/bash', 23:23:12 INFO - 'SHLVL': '1', 23:23:12 INFO - 'TERM': 'linux', 23:23:12 INFO - 'TMOUT': '86400', 23:23:12 INFO - 'USER': 'cltbld', 23:23:12 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720', 23:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:12 INFO - '_': '/tools/buildbot/bin/python'} 23:23:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:23:12 INFO - mozversion application_buildid: 20160217203148 23:23:12 INFO - mozversion application_changeset: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb 23:23:12 INFO - mozversion application_display_name: Nightly 23:23:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:12 INFO - mozversion application_name: Firefox 23:23:12 INFO - mozversion application_remotingname: firefox 23:23:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:23:12 INFO - mozversion application_vendor: Mozilla 23:23:12 INFO - mozversion application_version: 47.0a1 23:23:12 INFO - mozversion platform_buildid: 20160217203148 23:23:12 INFO - mozversion platform_changeset: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb 23:23:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:23:12 INFO - mozversion platform_version: 47.0a1 23:23:12 INFO - using testdate: 1455780192 23:23:12 INFO - actual date: 1455780192 23:23:12 INFO - starting webserver on 'localhost:41095' 23:23:12 INFO - SUITE-START | Running 2 tests 23:23:12 INFO - TEST-START | dromaeo_css 23:23:12 INFO - operating with platform_type : linux_ 23:23:12 INFO - Initialising browser for dromaeo_css test... 23:23:12 INFO - TEST-INFO | started process 20343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxi14sj/profile http://localhost:41095/getInfo.html) 23:23:16 INFO - PROCESS | 20343 | __metrics Screen width/height:1600/1200 23:23:16 INFO - PROCESS | 20343 | colorDepth:24 23:23:16 INFO - PROCESS | 20343 | Browser inner width/height: 1024/697 23:23:16 INFO - PROCESS | 20343 | __metrics 23:23:17 INFO - PROCESS | 20343 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:23:18 INFO - TEST-INFO | 20343: exit 0 23:23:18 INFO - Browser initialized. 23:23:18 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:18 INFO - TEST-INFO | started process 20436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxi14sj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:30 INFO - PROCESS | 20436 | RSS: Main: 147361792 23:23:30 INFO - PROCESS | 20436 | 23:24:21 INFO - PROCESS | 20436 | 1455780261813 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] 23:26:29 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41095/tests/dromaeo/cssquery-ext.html) 23:26:31 INFO - PROCESS | 20436 | RSS: Main: 263966720 23:26:31 INFO - PROCESS | 20436 | 23:29:33 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-ext.html (next: http://localhost:41095/tests/dromaeo/cssquery-jquery.html) 23:29:33 INFO - PROCESS | 20436 | RSS: Main: 241303552 23:29:33 INFO - PROCESS | 20436 | 23:32:35 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41095/tests/dromaeo/cssquery-mootools.html) 23:32:36 INFO - PROCESS | 20436 | RSS: Main: 243625984 23:32:36 INFO - PROCESS | 20436 | 23:35:38 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41095/tests/dromaeo/cssquery-prototype.html) 23:35:38 INFO - PROCESS | 20436 | RSS: Main: 218460160 23:35:38 INFO - PROCESS | 20436 | 23:38:41 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41095/tests/dromaeo/cssquery-yui.html) 23:38:42 INFO - PROCESS | 20436 | RSS: Main: 220852224 23:38:42 INFO - PROCESS | 20436 | 23:41:44 INFO - PROCESS | 20436 | Cycle 1(1): loaded http://localhost:41095/tests/dromaeo/cssquery-yui.html (next: http://localhost:41095/tests/dromaeo/cssquery-dojo.html) 23:41:45 INFO - PROCESS | 20436 | RSS: Main: 295219200 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | __start_tp_report 23:41:45 INFO - PROCESS | 20436 | _x_x_mozilla_page_load 23:41:45 INFO - PROCESS | 20436 | _x_x_mozilla_page_load_details 23:41:45 INFO - PROCESS | 20436 | |i|pagename|runs| 23:41:45 INFO - PROCESS | 20436 | |0;dojo.html;3187.6652951440115;3187.713105820476;3232.434323993302;3234.369297986892;3270.640229574747;5192.247124166994;5220.84337469876;5232.2674825524455;5294.470552944704;5345.946540534598;5141.331626888499;5161.535461808437;5184.300119483869;5198.246254293125;5255.159174532076;4700.106979673859;4718.97640511797;4743.264793956942;4861.829835955742;4951.306817045598;4768.356271903283;4773.665843390964;4866.683665561727;4873.24464707969;4982.00359928014;4802.807887684488;4817.132916075105;4819.325294458778;4854.781534830941;4855.56299933006;4786.880327991793;4797.352357431737;4814.085323788504;4820.566149046567;4848.5636292733825;4711.952880471185;4795;4816.470188279286;4833.299171620095;4886.804527818883;5052.797888084472;5107.974460127675;5120.078385890538;5139.3099465858195;5166.509181627739;5538;5663.546916246691;5673.971630141864;5676.858078548028;5686.5735069869925;5568.470995255444;5601.075822489284;5604.971975140098;5641.435856414367;5646.632968857052;5284.313039304904;5286.814961476368;5290.338707661581;5290.947090529084;5295.655782374133;5605.971970140205;5729.455701708331;5738.139279108083;5739.540836733051;5774.931637647049;5449.155380915964;5543.057680194376;5545.417731138173;5546.77812887488;5604.579656525777;5619.157126430986;5631.7747290108755;5637.9718101409235;5640.717964101778;5641.294838145232;5531.170324451365;5614.2701448811395;5624.775008999594;5624.971875140598;5708.514776244066;5614.578906581941;5620.1288800236025;5621.213030175779;5621.213030175779;5624.268845050117;4358.0412309291905;4361.760103194291;4365.105153443536;4371.060222052274;4406.383106365111;3834.654881060718;3850.7882066486613;3854.2676891391106;3874.263889860974;3906.8632597858937;5188.092083885305;5201.08980928336;5203.5576975957465;5222.791088356423;5240.633155679066;5468.316460442445;5576.414476479911;5593.8321850344555;5594.636348637326;5637.9718101409235;5198.844034678966;5228.241904923765;5274.815381461707;5281.577473802086;5304.708241046702;4762.238041913277;4775.785089670973;4776.737279449594;4778.880527986758;4806.255030470283;5798.362180160179;5841.065429531254;5844.12338149281;5855.736491857877;5857.414258574194;5555.666660000413;5646.887062258814;5669.262995810518;5687.146927960839;5748.741306641127;5901.527877769682;5938.851528711644;5942.168096466412;5942.970285148546;5950.553708471795;5576;5600.803971860965;5608;5615.3823079462045;5658.094704847204;5639.971800140973;5677.489025987681;5685.090385538294;5687.260656114844;5745.569082318759;5456.590755693418;5494.917576236279;5503.7798488061635;5543.501084902378;5552.361478430033;5394.919076213939;5428.050091233939;5522.088855338824;5535.916961245665;5584.050711379156;5384.542313903362;5411.756470958895;5422.267993820941;5427.077396842467;5434.375046869661;5494.066008778597;5522.0336441121835;5546.251256080377;5559.749811258584;5586.77652893896;5265.78936842522;5391.272178256042;5426.67439953604;5432.972835135799;5462.180672899097 23:41:45 INFO - PROCESS | 20436 | |1;ext.html;528.34221394364;533.6157966264288;554.1549137565213;556.596467561018;566.9376368599453;28550.286242843915;28931.566026509594;28939.855300723495;35443.1139221519;36048.63951360486;39761.801190994076;40023.39964900529;40179.59820401795;40238.59761402385;40340;8466.830663386729;8652;8662;8667.653293868238;8676.045634980179;8467.915320846774;8607.827843443127;8609.698660546883;8611.35414843886;8611.913880861173;8768.34237432192;8843.911560884373;8854.02605713371;8856.601452934634;8864.778380540474;8704.564771761417;8737.868931966026;8785.604647790864;8798.076201998825;8814.206721395105;8621.61202745878;8831.60257788401;8837.072107428692;8846.336524760605;8855.822883542292;38966.22067558633;39206.60793392058;39446.40830387546;39467.407988880186;39631.40552891709;3259.445894197992;3324.8503817328037;3418.060033490785;3499.422595271777;3524.2951409717903;28378.432431351463;29028.08120903672;29269.26826829325;29309.706902931124;29323.560146597818;3578.964210357889;3641.708663306929;3758.248350329945;3820.9044773880596;3873.225354928997;196720;198447;201258;201469;201703;57618.42381576131;64059.35940640627;64059.99999999907;64068.35931640717;64172.67913660402;66510.66744666343;67059.32940670628;67088;67092;67203.3279667197;16351.100689461955;16620.58448538772;16695.415660451825;16739.414120505724;16750.4137355192;12138.271703697807;12283.815742763865;12320.199187052813;12328;12342.197757145757;20267.391978240677;21417.357479275648;21447;21450.356489305344;21492;7189.5686258824635;8133.959330203429;8565.143485651384;8624.655013799378;8660.437071590326;909.8908131024187;973.6738192705523;1031.169908223872;1076.853151393763;1109.3732041396586;25828.48343033129;26578.867105664347;26844.463110737677;31160;31491.37017259642;1067.1836045425257;1090.9672709818717;1132.3432409202642;1148.7932172209082;1162.7790719763218;14468.27658617065;15159.09045457276;15179.848201518063;15271.541853744406;15451.459198927983;349450;354022;355570;416992;638904;52562.16032438846;53021.734891326065;53150.20274695883;53210.46789532055;53336.199957000674;1345.475264646769;1351.86481351866;1358.3072632957064;1362.271184916065;1371.9039667223199;28356.858215708788;29136.562951556167;29365.41269174647;29980;30116;45147.322790157516;45372;45569.31646025246;45570.31644525401;45587;223220;224849;269592;380582;385183;32416.35167296688;32484.35031299408;32551;32560.67439325671;32983.83508082444;42219.57780422157;42717;42774.35838462488;42977.14045719131;43383;36193.45709814302;36252.63747362493;36357;36555.81722091373;37468.43797342988;36110.638893610725;36639.816800915825;36864.26271474609;36955.26089478249;37366.626333737404;37896.24207515779;38475.42286865755;38684;39233.803830980665;39297.410538841366;28300.71699282981;29633.25916852096;31460.37079258448;31905.8404707975;32209.67790322067;25674.358141045876;32760.50859237161;32793.34413311673;33003.83498082494;33949.321013579094 23:41:45 INFO - PROCESS | 20436 | |2;jquery.html;362.44364899878684;363.7017645530665;368.44365008836667;370.20590832663936;374.3243445580726;13576.592702218924;13988.37052332645;16666.58333541662;16797.66404671906;17370.218340174673;11050.834237486424;11360.545578176863;16153.353865845382;16319.91840040801;16371.345146194139;4843.660943733948;4983.227599722049;4984.576311013569;4987.675801072936;4989.176785830334;3721.2371463849845;3883.0680636647285;4897.142999975008;5380.139177731564;5580.944190558083;5350.91973620396;5503.091989821674;5523.420040895709;5528.917066244009;5563.248961390222;5462.945370546303;5501.092319767234;5504.394516603171;5509.614326997112;5511.476409741088;5163;5248.6588371755715;5280.815171469018;5287.550558202557;5296.761645725952;12886.1623994441;12911.031672624496;12929.547465838745;18352.71530992818;20843.270485532932;2111.4510227341;2269.466675331296;2397.8681172535503;2600.8686221493713;2791.483575538532;9567.37812042215;9639.460800087063;9814.901850981541;10311.123554497877;13525.106485092096;1775.3786174838833;1871.1953859840264;1907.6947688369794;1911.3214808742973;1919.587288732915;62825;63745;65127;65690;66270.66864665694;10164.949175254076;10340.948295258475;10475.161987041018;10476.895231047745;10528.263021588415;13970.441182352592;14070.366833492517;14088.43646254159;14098.013139080165;14118.85881141196;7808.414368922354;7809.539994901588;7813.687452501837;7923.920760792434;7936.801579960547;7624.390048796083;7658;7681.462297639112;7729.420293478011;7749.8450030999065;4103.774292413946;4336.588024137765;4341.5007274163245;4542.863714088583;4615.792289346988;1743.8256174382461;1803.504036389977;1821.1440622907212;1825.6987597046339;1832.3128826689992;908.42315129893;948.3525605022077;972.8054389122062;1040.1003132290514;1060.9522571484301;12670.619881403572;15974.201289935456;16330.591735206477;17570.209340579448;18437.7234341485;880.9559522023873;899.9685011024583;935.3779736475303;944.5088553952044;948.4641177734696;9552.331336806357;9675.806483870423;10189;10200.0819926207;10223.437710925971;528929;543876;572039;577902;586727;66998.33001670019;67745.66127169333;67961.66019169873;69390.30609693838;70766;1132.3432409202642;1155.6128696886637;1164.5807509296815;1170.449888552379;1172.941352932367;15329.693406132037;15451.227438628248;15673.608159796097;15804.130772807606;16216.10811405384;35462.645373545936;35894.8205258972;36682.63317366792;37152.25695486021;37796.811015944746;46581.3012804815;51021;51624;51656.483435165166;52298.73850630722;7797.493162944391;7884.6057697113765;7926.603669816602;7961.283484486424;8021.679132834622;8666.350023748118;11521.88478115208;11906.464209110783;12025;12096.879031209575;9985.1512621428;10230.6419275325;10231.693049208536;10322.380657160595;10701.143908487147;10155.7461063474;10699.304545204848;10841.403722795321;11338;11358.26171298863;11146.777064458503;11244.887551124384;11338;11409;11606.94196529012;7328.926710733038;7587.34742616732;7640.083190017233;7853.842923141619;8130.918690813016;9830;10635.8936410638;10653.307535010199;10696.144308455461;10908.454577271263 23:41:45 INFO - PROCESS | 20436 | |3;mootools.html;1350.270853738981;1496.7455532559463;1512.206091801804;1696.5588946873809;1858.7769467663882;7107.644617769117;7750;7897.447178697486;7922.128565857751;7931.960340198291;7744.535327880331;7885.842283154348;7924.92075079249;7942.722004729836;7944.086430060544;1965.8990965059613;2307.1809507624844;2320.2227253869974;2327.011020316367;2373.335466069503;2327.534493101378;2337.474068334628;2337.8947947342413;2339.0526836631107;2344.3084290134366;2279.794818466338;2329.4642232286583;2331.9067237310574;2334.8832558372096;2336.1473062332298;2295.9897645036212;2329.9650505242435;2339.0760649543336;2349.6592994015773;2358.056777289081;2290.7594702556326;2302.7236731592147;2308.549832782608;2370.8577485350934;2390.2351247600773;8052.758417247492;8059.153788852144;8066.7579972600915;8086.312663423616;8113.675452981874;4938.530839570235;5034.270030845543;5039.143345631252;5075.593952483792;5080.339555857715;3184.7452203823636;3196.280836811699;3269.4605390110605;3282.638909719929;3304.7686661933676;992.9404235745878;1017.8574999500075;1036.9740756481074;1074.4466599701161;1078.01361753995;11373.20387572862;11381.601643942506;11387.487563059682;11392.088632909348;11424.314541127642;4445.088756804847;4549.203889319356;4565.634749220121;4567.862964111082;4605.516420775837;8750.824983500293;8816.471011739317;8819.91180088191;8833.911660883437;8841.867371989425;4929;4939.678920870132;4969.0807200668;4974.353334066548;4986.725730084808;4505.324201369821;4564.7032942858605;4607.0785842831565;4611.861644150681;4614.769261536977;3373.2916087621384;3451.3442445935193;3595.6404359563835;3651.926961460756;3672.412414013745;1119.3899324867966;1127.7237076916208;1144.7481554058095;1151.9942400287946;1158.9362585057734;1039.5529922133403;1059.6026490066224;1059.941703206331;1204.6446298341834;1344.8789608935242;7365.447591430557;7557.584332861746;7587.734429295058;7590.354819840265;7595.278448547379;1049.4333060147587;1068.9001894505839;1080.184460732158;1134.6766171641043;1162.5524173193382;5855.486707975181;5871.853203669943;5937.554683398763;5939.168516407706;5944.256967879015;9529.142377186086;9863.901360986441;9995.400275983464;9995.650152244782;10001.399916005063;9603.183729382941;9702.90297097034;9836.557354918903;9851.50742462874;9855.655052073143;7557.697692092254;7787.766367008999;7790.9220907790195;7792.181820908723;7798.766037018899;7372.225916278928;7379.963100184679;7452;7463.701451941862;7464.552126872405;8586.22723954847;8741.650333986569;8806.603702833516;8899.288056955298;8932.106789321017;9009.864852027356;9156.404833685789;9181.908180918106;9191.586378612845;9225.815483690154;6818.795436136924;6913.688884000333;6915.965420173068;6925.89611155823;6925.995730618932;6871.828204294932;7419.258074192538;7613.124490683642;7634.427417943565;7639.579823109782;6996.860062798817;7025.332593403618;7170.103737032871;7242.348188663045;7245.38414234796;7114.430845532242;7118.644067796693;7119.82200444993;7147.070880785673;7227.385672217921;7115.67979440916;7116.146062472537;7171.318724721144;7176.461765367722;7372.852542949004;6589.769358072636;6613.900791488228;6618.404343609098;6621.867562648624;6628.204615445984;6818.8636227276165;6876.415504682158;6913.792586222421;6927.3419025192525;6929.480288978448 23:41:45 INFO - PROCESS | 20436 | |4;prototype.html;334.9447341188704;345.08724423898786;347.35392170562756;348.1748256631783;348.41640252576946;5709.286339207599;5895.705214739262;5958.106284057388;5966.731497082631;5989.131575921489;5768.509676677488;5851.444112809277;5886.735096920638;5900.3214630317525;5913.822585322448;4559.293309537011;4589.678722489427;4606.355110284546;4613.884652883671;4624.907501849961;4380.408644832939;4464;4557.225271703802;4607.861764147065;4636.397268355109;4567.08658268346;4573.93139102912;4574.79413426395;4581.931271030937;4588.380568623244;4578.404807375036;4581.015081757439;4593.402857628487;4596.816127354902;4596.908061838778;4043.1105156865738;4046.0491784430637;4047.433359329696;4048;4048.67610591152;5515.669059856381;5546.27898373213;5576.721163941827;5600.0759874620635;5604.2714447122025;5349.090654588729;5358.571314294847;5361.195820626898;5364.22218778275;5366.409694933554;5959.582829201958;6282.246130464374;6293;6295.590786598902;6302.873942521124;4385.320275357293;4477.619402350804;4502.684812063157;4509.233430316854;4510.25580779171;6529.183852018497;6554.639494827783;6554.770583029619;6561.376669216417;6563.212414510242;4617;4617.307403889444;4619.030003699194;4621.514740952219;4621.537846215351;4362.236608593547;4516.593506584423;4534.36518887356;4677.438707355139;4686.906261874743;5240.187770895517;5244.580433565306;5249.947500525022;5253.13323301651;5255.185446255837;6253.218347706536;6325.5255855811;6328.778492752732;6329.556931014877;6332;1555.9611009724622;1564.9921750391175;1565.3503795924792;1566.749320108777;1567.6629524652255;1052.3633201912885;1053.2416660004785;1056.0020780362638;1056.0495554001461;1086.875009373932;5928.407159284124;5931.4958228550195;5939.821805345847;5943.405659434022;5945.048792193228;6471.352864713585;6473;6486.67566621667;6491.935080649133;6492.805215843532;5934.020886553671;5938.2280303560265;5938.465538101592;5944.078667806497;5945.910811337833;3420.2817408344526;3496.056064862473;3515.4199557072798;3518.4194607889413;3520.436730123168;6810.523263371517;6925.515213934977;6929.064576282238;6931.34152255545;6933.1333583302085;6732.427743641747;6738.696758645872;6739.528233023641;6748.190217173872;6748.966255168692;6655.367740064686;6849.1780986281965;6898.310168983062;6914.377706006484;6919.619420931796;6250.749970001149;6389.137466442156;6551.4103730664465;6554.016897465418;6572.539922205399;6428.228612566522;6482.546221764431;6498.447631951337;6498.707558159799;6515.185601799775;6818.897716534355;6819.659017049227;6820.693068812015;6822.249552549315;6833.89749153773;4412.448443944507;4461.531539188469;4501.572350626816;4508.346289787897;4520.4575450944785;6547.574407663486;6549.838553277502;6556.0493728410065;6570.868582628225;6574.539782215199;6367.490600751836;6372.299047104908;6375.266844312778;6382;6387.457066149429;6210.782622608187;6354.586951848115;6373.458256048288;6374.458171055512;6376.52176086786;6215.564910456224;6217.440430361108;6222.315545290105;6228.159198508143;6233.252009758858;6360.681965901779;6405.2313722351755;6411.903821442589;6416.486681065597;6422.775202867877;6067;6223.37766223374;6224.128621992834;6267.122602835516;6279.058141278845 23:41:45 INFO - PROCESS | 20436 | |5;yui.html;725.673446948873;747.2228881962759;820.3560205238889;832.9208725171109;838.8028813228894;12596;13846.58460246193;14026.859731402683;14033.368498417583;14033.859661403383;13028.869711302885;13060.477580896753;13090.607281781538;13112.868871311284;13119.868801311984;660.7357057177144;686.6738299307839;830.3647709502236;834.42007804576;855.9529225892574;835.603088532948;842.2756429470651;844.67902197165;844.9915500844975;852.4970267542149;689.3623398356525;888.2627419242014;890.3856339125982;890.4256754393413;891.0999890111002;840.1850205300848;881.088073843572;884.2307192742355;884.4472204871955;884.5754038061702;654.9214094308713;655.4821690864212;655.7016557466342;656.3305428462941;656.6125985668431;13614.795778063337;13663.043586948917;13672;13678.110922789987;13690.315484225748;12995.220286782824;13264;13345.13256638325;13949.302534873317;13968.790468142986;10674.679759607225;10800.5679772809;10911.727206819814;11153.553857845676;11226.214165008452;3648.981755091234;3662.7069834413182;3683.521142251517;3697.8335974881193;3701.2782507411066;46760.2985955211;46951.765241173576;47368.763156184345;47402.52597474016;48026.5197348029;9794.608215671293;9801.950990245146;9827.557759900821;10381.948090259652;10455.895441045492;18544.536386590175;18788.906055469633;18817.623647526972;18832.24671013144;18840.528986775167;7407.296306850841;7642.19756925526;7811.882821757678;7831.490953088031;7843.843123137505;4422.09347083847;4454.443194600675;4487.326900964816;4554.567316104964;4577.313402989578;3130.8591113399953;3149.0710240479116;3155.763317751132;3156.352947645727;3159.699828516287;555.7249161665002;561.0490219078704;564.7494733487051;566.9177969194444;587.3011116771029;629.1374247175333;643.5655932245716;644.6583310845259;649.1204418013524;670.4669787518836;8819.867701984474;8848.46909185451;8889;9004.59479323432;9015.2787776979;591.2432086928738;674.1438373265925;693.968771405288;703.5602748282323;747.2639450141714;3978.76127432355;4334.718243314238;4353.847615333448;4449.265871131227;4464.43229475007;54453.72773136109;55394;55423.44576554183;55738.44261557414;56045;51519;51580.48419515832;52004.739976299876;52355;52694.73652631712;43993.34009989853;44987.550124498994;45511.089778204914;45865.312020319725;45880.541194588965;8304.750857474286;8586.098459661645;8609.225169734755;8615.655373784979;8719.38964272495;31889.362212756077;33430.83284583561;34016;34139.14652133716;34522.48216276808;39351.80324098361;44013.11973760571;44280.335794962455;44497.332540012576;45370;10624.415657138932;11006.889931100586;11115.055220306365;11139.777204456028;11609.941950290195;11605.419729013347;11685.123615728684;11876.881231187577;12065.698357541132;12474.18917770342;10485.68542943713;10790.813010568989;10837.45812709377;11154.051905588116;11451.312921224753;10918.454077295944;11310.717232068935;11371.43142842871;11736.88263117358;11774.116941229271;11228.55085796559;11506.597269095542;11529.077673786245;11549.717755136233;11715.707107322385;9421.576029078571;9572.712818615453;9733.805323893625;9918.206543476648;10099.899001009895;8674.38610501083;9405.811883762422;9674.24677367021;9687.128158465772;9689.12797848197 23:41:45 INFO - PROCESS | 20436 | __end_tp_report 23:41:45 INFO - PROCESS | 20436 | __start_cc_report 23:41:45 INFO - PROCESS | 20436 | _x_x_mozilla_cycle_collect,842 23:41:45 INFO - PROCESS | 20436 | __end_cc_report 23:41:45 INFO - PROCESS | 20436 | __startTimestamp1455781305004__endTimestamp 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | ------- Summary: start ------- 23:41:45 INFO - PROCESS | 20436 | Number of tests: 6 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#0] dojo.html Cycles:165 Average:5233.85 Median:5427.08 stddev:571.59 (10.5%) stddev-sans-first:550.34 23:41:45 INFO - PROCESS | 20436 | Values: 3187.7 3187.7 3232.4 3234.4 3270.6 5192.2 5220.8 5232.3 5294.5 5345.9 5141.3 5161.5 5184.3 5198.2 5255.2 4700.1 4719.0 4743.3 4861.8 4951.3 4768.4 4773.7 4866.7 4873.2 4982.0 4802.8 4817.1 4819.3 4854.8 4855.6 4786.9 4797.4 4814.1 4820.6 4848.6 4712.0 4795.0 4816.5 4833.3 4886.8 5052.8 5108.0 5120.1 5139.3 5166.5 5538.0 5663.5 5674.0 5676.9 5686.6 5568.5 5601.1 5605.0 5641.4 5646.6 5284.3 5286.8 5290.3 5290.9 5295.7 5606.0 5729.5 5738.1 5739.5 5774.9 5449.2 5543.1 5545.4 5546.8 5604.6 5619.2 5631.8 5638.0 5640.7 5641.3 5531.2 5614.3 5624.8 5625.0 5708.5 5614.6 5620.1 5621.2 5621.2 5624.3 4358.0 4361.8 4365.1 4371.1 4406.4 3834.7 3850.8 3854.3 3874.3 3906.9 5188.1 5201.1 5203.6 5222.8 5240.6 5468.3 5576.4 5593.8 5594.6 5638.0 5198.8 5228.2 5274.8 5281.6 5304.7 4762.2 4775.8 4776.7 4778.9 4806.3 5798.4 5841.1 5844.1 5855.7 5857.4 5555.7 5646.9 5669.3 5687.1 5748.7 5901.5 5938.9 5942.2 5943.0 5950.6 5576.0 5600.8 5608.0 5615.4 5658.1 5640.0 5677.5 5685.1 5687.3 5745.6 5456.6 5494.9 5503.8 5543.5 5552.4 5394.9 5428.1 5522.1 5535.9 5584.1 5384.5 5411.8 5422.3 5427.1 5434.4 5494.1 5522.0 5546.3 5559.7 5586.8 5265.8 5391.3 5426.7 5433.0 5462.2 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#1] ext.html Cycles:180 Average:47884.47 Median:36597.82 stddev:87245.66 (238.4%) stddev-sans-first:87417.95 23:41:45 INFO - PROCESS | 20436 | Values: 528.3 533.6 554.2 556.6 566.9 28550.3 28931.6 28939.9 35443.1 36048.6 39761.8 40023.4 40179.6 40238.6 40340.0 8466.8 8652.0 8662.0 8667.7 8676.0 8467.9 8607.8 8609.7 8611.4 8611.9 8768.3 8843.9 8854.0 8856.6 8864.8 8704.6 8737.9 8785.6 8798.1 8814.2 8621.6 8831.6 8837.1 8846.3 8855.8 38966.2 39206.6 39446.4 39467.4 39631.4 3259.4 3324.9 3418.1 3499.4 3524.3 28378.4 29028.1 29269.3 29309.7 29323.6 3579.0 3641.7 3758.2 3820.9 3873.2 196720.0 198447.0 201258.0 201469.0 201703.0 57618.4 64059.4 64060.0 64068.4 64172.7 66510.7 67059.3 67088.0 67092.0 67203.3 16351.1 16620.6 16695.4 16739.4 16750.4 12138.3 12283.8 12320.2 12328.0 12342.2 20267.4 21417.4 21447.0 21450.4 21492.0 7189.6 8134.0 8565.1 8624.7 8660.4 909.9 973.7 1031.2 1076.9 1109.4 25828.5 26578.9 26844.5 31160.0 31491.4 1067.2 1091.0 1132.3 1148.8 1162.8 14468.3 15159.1 15179.8 15271.5 15451.5 349450.0 354022.0 355570.0 416992.0 638904.0 52562.2 53021.7 53150.2 53210.5 53336.2 1345.5 1351.9 1358.3 1362.3 1371.9 28356.9 29136.6 29365.4 29980.0 30116.0 45147.3 45372.0 45569.3 45570.3 45587.0 223220.0 224849.0 269592.0 380582.0 385183.0 32416.4 32484.4 32551.0 32560.7 32983.8 42219.6 42717.0 42774.4 42977.1 43383.0 36193.5 36252.6 36357.0 36555.8 37468.4 36110.6 36639.8 36864.3 36955.3 37366.6 37896.2 38475.4 38684.0 39233.8 39297.4 28300.7 29633.3 31460.4 31905.8 32209.7 25674.4 32760.5 32793.3 33003.8 33949.3 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#2] jquery.html Cycles:180 Average:28615.74 Median:18761.23 stddev:91888.73 (489.8%) stddev-sans-first:92122.01 23:41:45 INFO - PROCESS | 20436 | Values: 362.4 363.7 368.4 370.2 374.3 13576.6 13988.4 16666.6 16797.7 17370.2 11050.8 11360.5 16153.4 16319.9 16371.3 4843.7 4983.2 4984.6 4987.7 4989.2 3721.2 3883.1 4897.1 5380.1 5580.9 5350.9 5503.1 5523.4 5528.9 5563.2 5462.9 5501.1 5504.4 5509.6 5511.5 5163.0 5248.7 5280.8 5287.6 5296.8 12886.2 12911.0 12929.5 18352.7 20843.3 2111.5 2269.5 2397.9 2600.9 2791.5 9567.4 9639.5 9814.9 10311.1 13525.1 1775.4 1871.2 1907.7 1911.3 1919.6 62825.0 63745.0 65127.0 65690.0 66270.7 10164.9 10340.9 10475.2 10476.9 10528.3 13970.4 14070.4 14088.4 14098.0 14118.9 7808.4 7809.5 7813.7 7923.9 7936.8 7624.4 7658.0 7681.5 7729.4 7749.8 4103.8 4336.6 4341.5 4542.9 4615.8 1743.8 1803.5 1821.1 1825.7 1832.3 908.4 948.4 972.8 1040.1 1061.0 12670.6 15974.2 16330.6 17570.2 18437.7 881.0 900.0 935.4 944.5 948.5 9552.3 9675.8 10189.0 10200.1 10223.4 528929.0 543876.0 572039.0 577902.0 586727.0 66998.3 67745.7 67961.7 69390.3 70766.0 1132.3 1155.6 1164.6 1170.4 1172.9 15329.7 15451.2 15673.6 15804.1 16216.1 35462.6 35894.8 36682.6 37152.3 37796.8 46581.3 51021.0 51624.0 51656.5 52298.7 7797.5 7884.6 7926.6 7961.3 8021.7 8666.4 11521.9 11906.5 12025.0 12096.9 9985.2 10230.6 10231.7 10322.4 10701.1 10155.7 10699.3 10841.4 11338.0 11358.3 11146.8 11244.9 11338.0 11409.0 11606.9 7328.9 7587.3 7640.1 7853.8 8130.9 9830.0 10635.9 10653.3 10696.1 10908.5 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#3] mootools.html Cycles:180 Average:5636.86 Median:6601.84 stddev:2937.34 (44.5%) stddev-sans-first:2927.91 23:41:45 INFO - PROCESS | 20436 | Values: 1350.3 1496.7 1512.2 1696.6 1858.8 7107.6 7750.0 7897.4 7922.1 7932.0 7744.5 7885.8 7924.9 7942.7 7944.1 1965.9 2307.2 2320.2 2327.0 2373.3 2327.5 2337.5 2337.9 2339.1 2344.3 2279.8 2329.5 2331.9 2334.9 2336.1 2296.0 2330.0 2339.1 2349.7 2358.1 2290.8 2302.7 2308.5 2370.9 2390.2 8052.8 8059.2 8066.8 8086.3 8113.7 4938.5 5034.3 5039.1 5075.6 5080.3 3184.7 3196.3 3269.5 3282.6 3304.8 992.9 1017.9 1037.0 1074.4 1078.0 11373.2 11381.6 11387.5 11392.1 11424.3 4445.1 4549.2 4565.6 4567.9 4605.5 8750.8 8816.5 8819.9 8833.9 8841.9 4929.0 4939.7 4969.1 4974.4 4986.7 4505.3 4564.7 4607.1 4611.9 4614.8 3373.3 3451.3 3595.6 3651.9 3672.4 1119.4 1127.7 1144.7 1152.0 1158.9 1039.6 1059.6 1059.9 1204.6 1344.9 7365.4 7557.6 7587.7 7590.4 7595.3 1049.4 1068.9 1080.2 1134.7 1162.6 5855.5 5871.9 5937.6 5939.2 5944.3 9529.1 9863.9 9995.4 9995.7 10001.4 9603.2 9702.9 9836.6 9851.5 9855.7 7557.7 7787.8 7790.9 7792.2 7798.8 7372.2 7380.0 7452.0 7463.7 7464.6 8586.2 8741.7 8806.6 8899.3 8932.1 9009.9 9156.4 9181.9 9191.6 9225.8 6818.8 6913.7 6916.0 6925.9 6926.0 6871.8 7419.3 7613.1 7634.4 7639.6 6996.9 7025.3 7170.1 7242.3 7245.4 7114.4 7118.6 7119.8 7147.1 7227.4 7115.7 7116.1 7171.3 7176.5 7372.9 6589.8 6613.9 6618.4 6621.9 6628.2 6818.9 6876.4 6913.8 6927.3 6929.5 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#4] prototype.html Cycles:180 Average:5297.68 Median:5938.35 stddev:1595.92 (26.9%) stddev-sans-first:1556.32 23:41:45 INFO - PROCESS | 20436 | Values: 334.9 345.1 347.4 348.2 348.4 5709.3 5895.7 5958.1 5966.7 5989.1 5768.5 5851.4 5886.7 5900.3 5913.8 4559.3 4589.7 4606.4 4613.9 4624.9 4380.4 4464.0 4557.2 4607.9 4636.4 4567.1 4573.9 4574.8 4581.9 4588.4 4578.4 4581.0 4593.4 4596.8 4596.9 4043.1 4046.0 4047.4 4048.0 4048.7 5515.7 5546.3 5576.7 5600.1 5604.3 5349.1 5358.6 5361.2 5364.2 5366.4 5959.6 6282.2 6293.0 6295.6 6302.9 4385.3 4477.6 4502.7 4509.2 4510.3 6529.2 6554.6 6554.8 6561.4 6563.2 4617.0 4617.3 4619.0 4621.5 4621.5 4362.2 4516.6 4534.4 4677.4 4686.9 5240.2 5244.6 5249.9 5253.1 5255.2 6253.2 6325.5 6328.8 6329.6 6332.0 1556.0 1565.0 1565.4 1566.7 1567.7 1052.4 1053.2 1056.0 1056.0 1086.9 5928.4 5931.5 5939.8 5943.4 5945.0 6471.4 6473.0 6486.7 6491.9 6492.8 5934.0 5938.2 5938.5 5944.1 5945.9 3420.3 3496.1 3515.4 3518.4 3520.4 6810.5 6925.5 6929.1 6931.3 6933.1 6732.4 6738.7 6739.5 6748.2 6749.0 6655.4 6849.2 6898.3 6914.4 6919.6 6250.7 6389.1 6551.4 6554.0 6572.5 6428.2 6482.5 6498.4 6498.7 6515.2 6818.9 6819.7 6820.7 6822.2 6833.9 4412.4 4461.5 4501.6 4508.3 4520.5 6547.6 6549.8 6556.0 6570.9 6574.5 6367.5 6372.3 6375.3 6382.0 6387.5 6210.8 6354.6 6373.5 6374.5 6376.5 6215.6 6217.4 6222.3 6228.2 6233.3 6360.7 6405.2 6411.9 6416.5 6422.8 6067.0 6223.4 6224.1 6267.1 6279.1 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - PROCESS | 20436 | [#5] yui.html Cycles:180 Average:13734.23 Median:25221.31 stddev:15601.80 (61.9%) stddev-sans-first:15614.98 23:41:45 INFO - PROCESS | 20436 | Values: 725.7 747.2 820.4 832.9 838.8 12596.0 13846.6 14026.9 14033.4 14033.9 13028.9 13060.5 13090.6 13112.9 13119.9 660.7 686.7 830.4 834.4 856.0 835.6 842.3 844.7 845.0 852.5 689.4 888.3 890.4 890.4 891.1 840.2 881.1 884.2 884.4 884.6 654.9 655.5 655.7 656.3 656.6 13614.8 13663.0 13672.0 13678.1 13690.3 12995.2 13264.0 13345.1 13949.3 13968.8 10674.7 10800.6 10911.7 11153.6 11226.2 3649.0 3662.7 3683.5 3697.8 3701.3 46760.3 46951.8 47368.8 47402.5 48026.5 9794.6 9802.0 9827.6 10381.9 10455.9 18544.5 18788.9 18817.6 18832.2 18840.5 7407.3 7642.2 7811.9 7831.5 7843.8 4422.1 4454.4 4487.3 4554.6 4577.3 3130.9 3149.1 3155.8 3156.4 3159.7 555.7 561.0 564.7 566.9 587.3 629.1 643.6 644.7 649.1 670.5 8819.9 8848.5 8889.0 9004.6 9015.3 591.2 674.1 694.0 703.6 747.3 3978.8 4334.7 4353.8 4449.3 4464.4 54453.7 55394.0 55423.4 55738.4 56045.0 51519.0 51580.5 52004.7 52355.0 52694.7 43993.3 44987.6 45511.1 45865.3 45880.5 8304.8 8586.1 8609.2 8615.7 8719.4 31889.4 33430.8 34016.0 34139.1 34522.5 39351.8 44013.1 44280.3 44497.3 45370.0 10624.4 11006.9 11115.1 11139.8 11609.9 11605.4 11685.1 11876.9 12065.7 12474.2 10485.7 10790.8 10837.5 11154.1 11451.3 10918.5 11310.7 11371.4 11736.9 11774.1 11228.6 11506.6 11529.1 11549.7 11715.7 9421.6 9572.7 9733.8 9918.2 10099.9 8674.4 9405.8 9674.2 9687.1 9689.1 23:41:45 INFO - PROCESS | 20436 | -------- Summary: end -------- 23:41:45 INFO - PROCESS | 20436 | 23:41:45 INFO - TEST-INFO | 20436: exit 0 23:41:45 INFO - TEST-OK | dromaeo_css | took 1113104ms 23:41:45 INFO - TEST-START | kraken 23:41:45 INFO - operating with platform_type : linux_ 23:41:45 INFO - Initialising browser for kraken test... 23:41:45 INFO - TEST-INFO | started process 20623 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr2xpjG/profile http://localhost:41095/getInfo.html) 23:41:49 INFO - PROCESS | 20623 | __metrics Screen width/height:1600/1200 23:41:49 INFO - PROCESS | 20623 | colorDepth:24 23:41:49 INFO - PROCESS | 20623 | Browser inner width/height: 1024/697 23:41:49 INFO - PROCESS | 20623 | __metrics 23:41:50 INFO - PROCESS | 20623 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:41:51 INFO - TEST-INFO | 20623: exit 0 23:41:51 INFO - Browser initialized. 23:41:51 INFO - Running cycle 1/1 for kraken test... 23:41:51 INFO - TEST-INFO | started process 20708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpr2xpjG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:03 INFO - PROCESS | 20708 | RSS: Main: 148238336 23:42:03 INFO - PROCESS | 20708 | 23:42:05 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:06 INFO - PROCESS | 20708 | RSS: Main: 192733184 23:42:06 INFO - PROCESS | 20708 | 23:42:08 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-dft) 23:42:09 INFO - PROCESS | 20708 | RSS: Main: 181821440 23:42:09 INFO - PROCESS | 20708 | 23:42:12 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-fft) 23:42:12 INFO - PROCESS | 20708 | RSS: Main: 165969920 23:42:12 INFO - PROCESS | 20708 | 23:42:14 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41095/tests/kraken/driver.html?testName=audio-oscillator) 23:42:15 INFO - PROCESS | 20708 | RSS: Main: 169439232 23:42:15 INFO - PROCESS | 20708 | 23:42:17 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:18 INFO - PROCESS | 20708 | RSS: Main: 171036672 23:42:18 INFO - PROCESS | 20708 | 23:42:21 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:21 INFO - PROCESS | 20708 | RSS: Main: 170958848 23:42:21 INFO - PROCESS | 20708 | 23:42:25 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41095/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:25 INFO - PROCESS | 20708 | RSS: Main: 171761664 23:42:25 INFO - PROCESS | 20708 | 23:42:28 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41095/tests/kraken/driver.html?testName=json-parse-financial) 23:42:29 INFO - PROCESS | 20708 | RSS: Main: 169512960 23:42:29 INFO - PROCESS | 20708 | 23:42:30 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:31 INFO - PROCESS | 20708 | RSS: Main: 182841344 23:42:31 INFO - PROCESS | 20708 | 23:42:33 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:42:33 INFO - PROCESS | 20708 | RSS: Main: 178221056 23:42:33 INFO - PROCESS | 20708 | 23:42:35 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:42:36 INFO - PROCESS | 20708 | RSS: Main: 189042688 23:42:36 INFO - PROCESS | 20708 | 23:42:38 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:42:39 INFO - PROCESS | 20708 | RSS: Main: 192020480 23:42:39 INFO - PROCESS | 20708 | 23:42:42 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:42:42 INFO - PROCESS | 20708 | RSS: Main: 191684608 23:42:42 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | Cycle 1(1): loaded http://localhost:41095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41095/tests/kraken/driver.html?testName=ai-astar) 23:42:44 INFO - PROCESS | 20708 | RSS: Main: 251031552 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | __start_tp_report 23:42:44 INFO - PROCESS | 20708 | _x_x_mozilla_page_load 23:42:44 INFO - PROCESS | 20708 | _x_x_mozilla_page_load_details 23:42:44 INFO - PROCESS | 20708 | |i|pagename|runs| 23:42:44 INFO - PROCESS | 20708 | |0;ai-astar;110;112;105;111;112;113;100;110;111;111 23:42:44 INFO - PROCESS | 20708 | |1;audio-beat-detection;159;124;161;173;125;151;150;127;164;128 23:42:44 INFO - PROCESS | 20708 | |2;audio-dft;161;164;161;162;160;160;161;164;162;161 23:42:44 INFO - PROCESS | 20708 | |3;audio-fft;73;73;93;97;73;72;74;119;96;72 23:42:44 INFO - PROCESS | 20708 | |4;audio-oscillator;96;95;139;95;95;96;140;96;96;142 23:42:44 INFO - PROCESS | 20708 | |5;imaging-gaussian-blur;118;115;115;115;115;114;115;115;114;114 23:42:44 INFO - PROCESS | 20708 | |6;imaging-darkroom;146;145;145;146;146;146;146;146;146;146 23:42:44 INFO - PROCESS | 20708 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;95 23:42:44 INFO - PROCESS | 20708 | |8;json-parse-financial;58;60;63;57;58;57;57;66;56;54 23:42:44 INFO - PROCESS | 20708 | |9;json-stringify-tinderbox;67;68;67;66;67;68;69;68;69;68 23:42:44 INFO - PROCESS | 20708 | |10;stanford-crypto-aes;82;81;82;83;83;82;82;83;83;83 23:42:44 INFO - PROCESS | 20708 | |11;stanford-crypto-ccm;120;116;116;123;127;116;134;116;117;123 23:42:44 INFO - PROCESS | 20708 | |12;stanford-crypto-pbkdf2;149;143;155;155;155;144;156;154;153;164 23:42:44 INFO - PROCESS | 20708 | |13;stanford-crypto-sha256-iterative;71;68;71;68;70;71;69;71;68;69 23:42:44 INFO - PROCESS | 20708 | __end_tp_report 23:42:44 INFO - PROCESS | 20708 | __start_cc_report 23:42:44 INFO - PROCESS | 20708 | _x_x_mozilla_cycle_collect,949 23:42:44 INFO - PROCESS | 20708 | __end_cc_report 23:42:44 INFO - PROCESS | 20708 | __startTimestamp1455781364551__endTimestamp 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | ------- Summary: start ------- 23:42:44 INFO - PROCESS | 20708 | Number of tests: 14 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.98 (3.6%) stddev-sans-first:4.22 23:42:44 INFO - PROCESS | 20708 | Values: 110.0 112.0 105.0 111.0 112.0 113.0 100.0 110.0 111.0 111.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.00 stddev:18.55 (12.0%) stddev-sans-first:19.09 23:42:44 INFO - PROCESS | 20708 | Values: 159.0 124.0 161.0 173.0 125.0 151.0 150.0 127.0 164.0 128.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 23:42:44 INFO - PROCESS | 20708 | Values: 161.0 164.0 161.0 162.0 160.0 160.0 161.0 164.0 162.0 161.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#3] audio-fft Cycles:10 Average:84.20 Median:73.50 stddev:16.23 (22.1%) stddev-sans-first:16.70 23:42:44 INFO - PROCESS | 20708 | Values: 73.0 73.0 93.0 97.0 73.0 72.0 74.0 119.0 96.0 72.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.50 stddev:21.64 (22.7%) stddev-sans-first:22.43 23:42:44 INFO - PROCESS | 20708 | Values: 96.0 95.0 139.0 95.0 95.0 96.0 140.0 96.0 96.0 142.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.15 (1.0%) stddev-sans-first:0.50 23:42:44 INFO - PROCESS | 20708 | Values: 118.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 114.0 114.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 23:42:44 INFO - PROCESS | 20708 | Values: 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:42:44 INFO - PROCESS | 20708 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.53 (6.1%) stddev-sans-first:3.74 23:42:44 INFO - PROCESS | 20708 | Values: 58.0 60.0 63.0 57.0 58.0 57.0 57.0 66.0 56.0 54.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 23:42:44 INFO - PROCESS | 20708 | Values: 67.0 68.0 67.0 66.0 67.0 68.0 69.0 68.0 69.0 68.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 23:42:44 INFO - PROCESS | 20708 | Values: 82.0 81.0 82.0 83.0 83.0 82.0 82.0 83.0 83.0 83.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.50 stddev:6.05 (5.0%) stddev-sans-first:6.41 23:42:44 INFO - PROCESS | 20708 | Values: 120.0 116.0 116.0 123.0 127.0 116.0 134.0 116.0 117.0 123.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:155.00 stddev:6.14 (4.0%) stddev-sans-first:6.36 23:42:44 INFO - PROCESS | 20708 | Values: 149.0 143.0 155.0 155.0 155.0 144.0 156.0 154.0 153.0 164.0 23:42:44 INFO - PROCESS | 20708 | 23:42:44 INFO - PROCESS | 20708 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.50 stddev:1.35 (1.9%) stddev-sans-first:1.33 23:42:44 INFO - PROCESS | 20708 | Values: 71.0 68.0 71.0 68.0 70.0 71.0 69.0 71.0 68.0 69.0 23:42:44 INFO - PROCESS | 20708 | -------- Summary: end -------- 23:42:44 INFO - PROCESS | 20708 | 23:42:45 INFO - TEST-INFO | 20708: exit 0 23:42:45 INFO - TEST-OK | kraken | took 59936ms 23:42:45 INFO - SUITE-END | took 1173s 23:42:45 INFO - Completed test suite (00:19:33) 23:42:45 INFO - Working with test: dromaeo_css 23:42:45 INFO - Generating results file: dromaeo_css 23:42:45 INFO - Working with test: kraken 23:42:45 INFO - Generating results file: kraken 23:42:45 INFO - javascript benchmark 23:42:45 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:42:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:42:45 INFO - process_Request line: dromaeo_css 6971.53 graph.html#tests=[[72,64,35]] 23:42:45 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:42:45 INFO - process_Request line: kraken 1519.00 graph.html#tests=[[232,64,35]] 23:42:45 INFO - RETURN: dromaeo_css: 6971.53 23:42:45 INFO - RETURN: kraken: 1519.00 23:42:45 INFO - javascript benchmark 23:42:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3187.6652951440115, 3187.713105820476, 3232.434323993302, 3234.369297986892, 3270.640229574747, 5192.247124166994, 5220.84337469876, 5232.2674825524455, 5294.470552944704, 5345.946540534598, 5141.331626888499, 5161.535461808437, 5184.300119483869, 5198.246254293125, 5255.159174532076, 4700.106979673859, 4718.97640511797, 4743.264793956942, 4861.829835955742, 4951.306817045598, 4768.356271903283, 4773.665843390964, 4866.683665561727, 4873.24464707969, 4982.00359928014, 4802.807887684488, 4817.132916075105, 4819.325294458778, 4854.781534830941, 4855.56299933006, 4786.880327991793, 4797.352357431737, 4814.085323788504, 4820.566149046567, 4848.5636292733825, 4711.952880471185, 4795.0, 4816.470188279286, 4833.299171620095, 4886.804527818883, 5052.797888084472, 5107.974460127675, 5120.078385890538, 5139.3099465858195, 5166.509181627739, 5538.0, 5663.546916246691, 5673.971630141864, 5676.858078548028, 5686.5735069869925, 5568.470995255444, 5601.075822489284, 5604.971975140098, 5641.435856414367, 5646.632968857052, 5284.313039304904, 5286.814961476368, 5290.338707661581, 5290.947090529084, 5295.655782374133, 5605.971970140205, 5729.455701708331, 5738.139279108083, 5739.540836733051, 5774.931637647049, 5449.155380915964, 5543.057680194376, 5545.417731138173, 5546.77812887488, 5604.579656525777, 5619.157126430986, 5631.7747290108755, 5637.9718101409235, 5640.717964101778, 5641.294838145232, 5531.170324451365, 5614.2701448811395, 5624.775008999594, 5624.971875140598, 5708.514776244066, 5614.578906581941, 5620.1288800236025, 5621.213030175779, 5621.213030175779, 5624.268845050117, 4358.0412309291905, 4361.760103194291, 4365.105153443536, 4371.060222052274, 4406.383106365111, 3834.654881060718, 3850.7882066486613, 3854.2676891391106, 3874.263889860974, 3906.8632597858937, 5188.092083885305, 5201.08980928336, 5203.5576975957465, 5222.791088356423, 5240.633155679066, 5468.316460442445, 5576.414476479911, 5593.8321850344555, 5594.636348637326, 5637.9718101409235, 5198.844034678966, 5228.241904923765, 5274.815381461707, 5281.577473802086, 5304.708241046702, 4762.238041913277, 4775.785089670973, 4776.737279449594, 4778.880527986758, 4806.255030470283, 5798.362180160179, 5841.065429531254, 5844.12338149281, 5855.736491857877, 5857.414258574194, 5555.666660000413, 5646.887062258814, 5669.262995810518, 5687.146927960839, 5748.741306641127, 5901.527877769682, 5938.851528711644, 5942.168096466412, 5942.970285148546, 5950.553708471795, 5576.0, 5600.803971860965, 5608.0, 5615.3823079462045, 5658.094704847204, 5639.971800140973, 5677.489025987681, 5685.090385538294, 5687.260656114844, 5745.569082318759, 5456.590755693418, 5494.917576236279, 5503.7798488061635, 5543.501084902378, 5552.361478430033, 5394.919076213939, 5428.050091233939, 5522.088855338824, 5535.916961245665, 5584.050711379156, 5384.542313903362, 5411.756470958895, 5422.267993820941, 5427.077396842467, 5434.375046869661, 5494.066008778597, 5522.0336441121835, 5546.251256080377, 5559.749811258584, 5586.77652893896, 5265.78936842522, 5391.272178256042, 5426.67439953604, 5432.972835135799, 5462.180672899097], "unit": "score", "name": "dojo.html", "value": 5197.726088409452}, {"lowerIsBetter": false, "replicates": [528.34221394364, 533.6157966264288, 554.1549137565213, 556.596467561018, 566.9376368599453, 28550.286242843915, 28931.566026509594, 28939.855300723495, 35443.1139221519, 36048.63951360486, 39761.801190994076, 40023.39964900529, 40179.59820401795, 40238.59761402385, 40340.0, 8466.830663386729, 8652.0, 8662.0, 8667.653293868238, 8676.045634980179, 8467.915320846774, 8607.827843443127, 8609.698660546883, 8611.35414843886, 8611.913880861173, 8768.34237432192, 8843.911560884373, 8854.02605713371, 8856.601452934634, 8864.778380540474, 8704.564771761417, 8737.868931966026, 8785.604647790864, 8798.076201998825, 8814.206721395105, 8621.61202745878, 8831.60257788401, 8837.072107428692, 8846.336524760605, 8855.822883542292, 38966.22067558633, 39206.60793392058, 39446.40830387546, 39467.407988880186, 39631.40552891709, 3259.445894197992, 3324.8503817328037, 3418.060033490785, 3499.422595271777, 3524.2951409717903, 28378.432431351463, 29028.08120903672, 29269.26826829325, 29309.706902931124, 29323.560146597818, 3578.964210357889, 3641.708663306929, 3758.248350329945, 3820.9044773880596, 3873.225354928997, 196720.0, 198447.0, 201258.0, 201469.0, 201703.0, 57618.42381576131, 64059.35940640627, 64059.99999999907, 64068.35931640717, 64172.67913660402, 66510.66744666343, 67059.32940670628, 67088.0, 67092.0, 67203.3279667197, 16351.100689461955, 16620.58448538772, 16695.415660451825, 16739.414120505724, 16750.4137355192, 12138.271703697807, 12283.815742763865, 12320.199187052813, 12328.0, 12342.197757145757, 20267.391978240677, 21417.357479275648, 21447.0, 21450.356489305344, 21492.0, 7189.5686258824635, 8133.959330203429, 8565.143485651384, 8624.655013799378, 8660.437071590326, 909.8908131024187, 973.6738192705523, 1031.169908223872, 1076.853151393763, 1109.3732041396586, 25828.48343033129, 26578.867105664347, 26844.463110737677, 31160.0, 31491.37017259642, 1067.1836045425257, 1090.9672709818717, 1132.3432409202642, 1148.7932172209082, 1162.7790719763218, 14468.27658617065, 15159.09045457276, 15179.848201518063, 15271.541853744406, 15451.459198927983, 349450.0, 354022.0, 355570.0, 416992.0, 638904.0, 52562.16032438846, 53021.734891326065, 53150.20274695883, 53210.46789532055, 53336.199957000674, 1345.475264646769, 1351.86481351866, 1358.3072632957064, 1362.271184916065, 1371.9039667223199, 28356.858215708788, 29136.562951556167, 29365.41269174647, 29980.0, 30116.0, 45147.322790157516, 45372.0, 45569.31646025246, 45570.31644525401, 45587.0, 223220.0, 224849.0, 269592.0, 380582.0, 385183.0, 32416.35167296688, 32484.35031299408, 32551.0, 32560.67439325671, 32983.83508082444, 42219.57780422157, 42717.0, 42774.35838462488, 42977.14045719131, 43383.0, 36193.45709814302, 36252.63747362493, 36357.0, 36555.81722091373, 37468.43797342988, 36110.638893610725, 36639.816800915825, 36864.26271474609, 36955.26089478249, 37366.626333737404, 37896.24207515779, 38475.42286865755, 38684.0, 39233.803830980665, 39297.410538841366, 28300.71699282981, 29633.25916852096, 31460.37079258448, 31905.8404707975, 32209.67790322067, 25674.358141045876, 32760.50859237161, 32793.34413311673, 33003.83498082494, 33949.321013579094], "unit": "score", "name": "ext.html", "value": 18725.09810368753}, {"lowerIsBetter": false, "replicates": [362.44364899878684, 363.7017645530665, 368.44365008836667, 370.20590832663936, 374.3243445580726, 13576.592702218924, 13988.37052332645, 16666.58333541662, 16797.66404671906, 17370.218340174673, 11050.834237486424, 11360.545578176863, 16153.353865845382, 16319.91840040801, 16371.345146194139, 4843.660943733948, 4983.227599722049, 4984.576311013569, 4987.675801072936, 4989.176785830334, 3721.2371463849845, 3883.0680636647285, 4897.142999975008, 5380.139177731564, 5580.944190558083, 5350.91973620396, 5503.091989821674, 5523.420040895709, 5528.917066244009, 5563.248961390222, 5462.945370546303, 5501.092319767234, 5504.394516603171, 5509.614326997112, 5511.476409741088, 5163.0, 5248.6588371755715, 5280.815171469018, 5287.550558202557, 5296.761645725952, 12886.1623994441, 12911.031672624496, 12929.547465838745, 18352.71530992818, 20843.270485532932, 2111.4510227341, 2269.466675331296, 2397.8681172535503, 2600.8686221493713, 2791.483575538532, 9567.37812042215, 9639.460800087063, 9814.901850981541, 10311.123554497877, 13525.106485092096, 1775.3786174838833, 1871.1953859840264, 1907.6947688369794, 1911.3214808742973, 1919.587288732915, 62825.0, 63745.0, 65127.0, 65690.0, 66270.66864665694, 10164.949175254076, 10340.948295258475, 10475.161987041018, 10476.895231047745, 10528.263021588415, 13970.441182352592, 14070.366833492517, 14088.43646254159, 14098.013139080165, 14118.85881141196, 7808.414368922354, 7809.539994901588, 7813.687452501837, 7923.920760792434, 7936.801579960547, 7624.390048796083, 7658.0, 7681.462297639112, 7729.420293478011, 7749.8450030999065, 4103.774292413946, 4336.588024137765, 4341.5007274163245, 4542.863714088583, 4615.792289346988, 1743.8256174382461, 1803.504036389977, 1821.1440622907212, 1825.6987597046339, 1832.3128826689992, 908.42315129893, 948.3525605022077, 972.8054389122062, 1040.1003132290514, 1060.9522571484301, 12670.619881403572, 15974.201289935456, 16330.591735206477, 17570.209340579448, 18437.7234341485, 880.9559522023873, 899.9685011024583, 935.3779736475303, 944.5088553952044, 948.4641177734696, 9552.331336806357, 9675.806483870423, 10189.0, 10200.0819926207, 10223.437710925971, 528929.0, 543876.0, 572039.0, 577902.0, 586727.0, 66998.33001670019, 67745.66127169333, 67961.66019169873, 69390.30609693838, 70766.0, 1132.3432409202642, 1155.6128696886637, 1164.5807509296815, 1170.449888552379, 1172.941352932367, 15329.693406132037, 15451.227438628248, 15673.608159796097, 15804.130772807606, 16216.10811405384, 35462.645373545936, 35894.8205258972, 36682.63317366792, 37152.25695486021, 37796.811015944746, 46581.3012804815, 51021.0, 51624.0, 51656.483435165166, 52298.73850630722, 7797.493162944391, 7884.6057697113765, 7926.603669816602, 7961.283484486424, 8021.679132834622, 8666.350023748118, 11521.88478115208, 11906.464209110783, 12025.0, 12096.879031209575, 9985.1512621428, 10230.6419275325, 10231.693049208536, 10322.380657160595, 10701.143908487147, 10155.7461063474, 10699.304545204848, 10841.403722795321, 11338.0, 11358.26171298863, 11146.777064458503, 11244.887551124384, 11338.0, 11409.0, 11606.94196529012, 7328.926710733038, 7587.34742616732, 7640.083190017233, 7853.842923141619, 8130.918690813016, 9830.0, 10635.8936410638, 10653.307535010199, 10696.144308455461, 10908.454577271263], "unit": "score", "name": "jquery.html", "value": 8393.32427989842}, {"lowerIsBetter": false, "replicates": [1350.270853738981, 1496.7455532559463, 1512.206091801804, 1696.5588946873809, 1858.7769467663882, 7107.644617769117, 7750.0, 7897.447178697486, 7922.128565857751, 7931.960340198291, 7744.535327880331, 7885.842283154348, 7924.92075079249, 7942.722004729836, 7944.086430060544, 1965.8990965059613, 2307.1809507624844, 2320.2227253869974, 2327.011020316367, 2373.335466069503, 2327.534493101378, 2337.474068334628, 2337.8947947342413, 2339.0526836631107, 2344.3084290134366, 2279.794818466338, 2329.4642232286583, 2331.9067237310574, 2334.8832558372096, 2336.1473062332298, 2295.9897645036212, 2329.9650505242435, 2339.0760649543336, 2349.6592994015773, 2358.056777289081, 2290.7594702556326, 2302.7236731592147, 2308.549832782608, 2370.8577485350934, 2390.2351247600773, 8052.758417247492, 8059.153788852144, 8066.7579972600915, 8086.312663423616, 8113.675452981874, 4938.530839570235, 5034.270030845543, 5039.143345631252, 5075.593952483792, 5080.339555857715, 3184.7452203823636, 3196.280836811699, 3269.4605390110605, 3282.638909719929, 3304.7686661933676, 992.9404235745878, 1017.8574999500075, 1036.9740756481074, 1074.4466599701161, 1078.01361753995, 11373.20387572862, 11381.601643942506, 11387.487563059682, 11392.088632909348, 11424.314541127642, 4445.088756804847, 4549.203889319356, 4565.634749220121, 4567.862964111082, 4605.516420775837, 8750.824983500293, 8816.471011739317, 8819.91180088191, 8833.911660883437, 8841.867371989425, 4929.0, 4939.678920870132, 4969.0807200668, 4974.353334066548, 4986.725730084808, 4505.324201369821, 4564.7032942858605, 4607.0785842831565, 4611.861644150681, 4614.769261536977, 3373.2916087621384, 3451.3442445935193, 3595.6404359563835, 3651.926961460756, 3672.412414013745, 1119.3899324867966, 1127.7237076916208, 1144.7481554058095, 1151.9942400287946, 1158.9362585057734, 1039.5529922133403, 1059.6026490066224, 1059.941703206331, 1204.6446298341834, 1344.8789608935242, 7365.447591430557, 7557.584332861746, 7587.734429295058, 7590.354819840265, 7595.278448547379, 1049.4333060147587, 1068.9001894505839, 1080.184460732158, 1134.6766171641043, 1162.5524173193382, 5855.486707975181, 5871.853203669943, 5937.554683398763, 5939.168516407706, 5944.256967879015, 9529.142377186086, 9863.901360986441, 9995.400275983464, 9995.650152244782, 10001.399916005063, 9603.183729382941, 9702.90297097034, 9836.557354918903, 9851.50742462874, 9855.655052073143, 7557.697692092254, 7787.766367008999, 7790.9220907790195, 7792.181820908723, 7798.766037018899, 7372.225916278928, 7379.963100184679, 7452.0, 7463.701451941862, 7464.552126872405, 8586.22723954847, 8741.650333986569, 8806.603702833516, 8899.288056955298, 8932.106789321017, 9009.864852027356, 9156.404833685789, 9181.908180918106, 9191.586378612845, 9225.815483690154, 6818.795436136924, 6913.688884000333, 6915.965420173068, 6925.89611155823, 6925.995730618932, 6871.828204294932, 7419.258074192538, 7613.124490683642, 7634.427417943565, 7639.579823109782, 6996.860062798817, 7025.332593403618, 7170.103737032871, 7242.348188663045, 7245.38414234796, 7114.430845532242, 7118.644067796693, 7119.82200444993, 7147.070880785673, 7227.385672217921, 7115.67979440916, 7116.146062472537, 7171.318724721144, 7176.461765367722, 7372.852542949004, 6589.769358072636, 6613.900791488228, 6618.404343609098, 6621.867562648624, 6628.204615445984, 6818.8636227276165, 6876.415504682158, 6913.792586222421, 6927.3419025192525, 6929.480288978448], "unit": "score", "name": "mootools.html", "value": 4612.419550211312}, {"lowerIsBetter": false, "replicates": [334.9447341188704, 345.08724423898786, 347.35392170562756, 348.1748256631783, 348.41640252576946, 5709.286339207599, 5895.705214739262, 5958.106284057388, 5966.731497082631, 5989.131575921489, 5768.509676677488, 5851.444112809277, 5886.735096920638, 5900.3214630317525, 5913.822585322448, 4559.293309537011, 4589.678722489427, 4606.355110284546, 4613.884652883671, 4624.907501849961, 4380.408644832939, 4464.0, 4557.225271703802, 4607.861764147065, 4636.397268355109, 4567.08658268346, 4573.93139102912, 4574.79413426395, 4581.931271030937, 4588.380568623244, 4578.404807375036, 4581.015081757439, 4593.402857628487, 4596.816127354902, 4596.908061838778, 4043.1105156865738, 4046.0491784430637, 4047.433359329696, 4048.0, 4048.67610591152, 5515.669059856381, 5546.27898373213, 5576.721163941827, 5600.0759874620635, 5604.2714447122025, 5349.090654588729, 5358.571314294847, 5361.195820626898, 5364.22218778275, 5366.409694933554, 5959.582829201958, 6282.246130464374, 6293.0, 6295.590786598902, 6302.873942521124, 4385.320275357293, 4477.619402350804, 4502.684812063157, 4509.233430316854, 4510.25580779171, 6529.183852018497, 6554.639494827783, 6554.770583029619, 6561.376669216417, 6563.212414510242, 4617.0, 4617.307403889444, 4619.030003699194, 4621.514740952219, 4621.537846215351, 4362.236608593547, 4516.593506584423, 4534.36518887356, 4677.438707355139, 4686.906261874743, 5240.187770895517, 5244.580433565306, 5249.947500525022, 5253.13323301651, 5255.185446255837, 6253.218347706536, 6325.5255855811, 6328.778492752732, 6329.556931014877, 6332.0, 1555.9611009724622, 1564.9921750391175, 1565.3503795924792, 1566.749320108777, 1567.6629524652255, 1052.3633201912885, 1053.2416660004785, 1056.0020780362638, 1056.0495554001461, 1086.875009373932, 5928.407159284124, 5931.4958228550195, 5939.821805345847, 5943.405659434022, 5945.048792193228, 6471.352864713585, 6473.0, 6486.67566621667, 6491.935080649133, 6492.805215843532, 5934.020886553671, 5938.2280303560265, 5938.465538101592, 5944.078667806497, 5945.910811337833, 3420.2817408344526, 3496.056064862473, 3515.4199557072798, 3518.4194607889413, 3520.436730123168, 6810.523263371517, 6925.515213934977, 6929.064576282238, 6931.34152255545, 6933.1333583302085, 6732.427743641747, 6738.696758645872, 6739.528233023641, 6748.190217173872, 6748.966255168692, 6655.367740064686, 6849.1780986281965, 6898.310168983062, 6914.377706006484, 6919.619420931796, 6250.749970001149, 6389.137466442156, 6551.4103730664465, 6554.016897465418, 6572.539922205399, 6428.228612566522, 6482.546221764431, 6498.447631951337, 6498.707558159799, 6515.185601799775, 6818.897716534355, 6819.659017049227, 6820.693068812015, 6822.249552549315, 6833.89749153773, 4412.448443944507, 4461.531539188469, 4501.572350626816, 4508.346289787897, 4520.4575450944785, 6547.574407663486, 6549.838553277502, 6556.0493728410065, 6570.868582628225, 6574.539782215199, 6367.490600751836, 6372.299047104908, 6375.266844312778, 6382.0, 6387.457066149429, 6210.782622608187, 6354.586951848115, 6373.458256048288, 6374.458171055512, 6376.52176086786, 6215.564910456224, 6217.440430361108, 6222.315545290105, 6228.159198508143, 6233.252009758858, 6360.681965901779, 6405.2313722351755, 6411.903821442589, 6416.486681065597, 6422.775202867877, 6067.0, 6223.37766223374, 6224.128621992834, 6267.122602835516, 6279.058141278845], "unit": "score", "name": "prototype.html", "value": 4779.29992468015}, {"lowerIsBetter": false, "replicates": [725.673446948873, 747.2228881962759, 820.3560205238889, 832.9208725171109, 838.8028813228894, 12596.0, 13846.58460246193, 14026.859731402683, 14033.368498417583, 14033.859661403383, 13028.869711302885, 13060.477580896753, 13090.607281781538, 13112.868871311284, 13119.868801311984, 660.7357057177144, 686.6738299307839, 830.3647709502236, 834.42007804576, 855.9529225892574, 835.603088532948, 842.2756429470651, 844.67902197165, 844.9915500844975, 852.4970267542149, 689.3623398356525, 888.2627419242014, 890.3856339125982, 890.4256754393413, 891.0999890111002, 840.1850205300848, 881.088073843572, 884.2307192742355, 884.4472204871955, 884.5754038061702, 654.9214094308713, 655.4821690864212, 655.7016557466342, 656.3305428462941, 656.6125985668431, 13614.795778063337, 13663.043586948917, 13672.0, 13678.110922789987, 13690.315484225748, 12995.220286782824, 13264.0, 13345.13256638325, 13949.302534873317, 13968.790468142986, 10674.679759607225, 10800.5679772809, 10911.727206819814, 11153.553857845676, 11226.214165008452, 3648.981755091234, 3662.7069834413182, 3683.521142251517, 3697.8335974881193, 3701.2782507411066, 46760.2985955211, 46951.765241173576, 47368.763156184345, 47402.52597474016, 48026.5197348029, 9794.608215671293, 9801.950990245146, 9827.557759900821, 10381.948090259652, 10455.895441045492, 18544.536386590175, 18788.906055469633, 18817.623647526972, 18832.24671013144, 18840.528986775167, 7407.296306850841, 7642.19756925526, 7811.882821757678, 7831.490953088031, 7843.843123137505, 4422.09347083847, 4454.443194600675, 4487.326900964816, 4554.567316104964, 4577.313402989578, 3130.8591113399953, 3149.0710240479116, 3155.763317751132, 3156.352947645727, 3159.699828516287, 555.7249161665002, 561.0490219078704, 564.7494733487051, 566.9177969194444, 587.3011116771029, 629.1374247175333, 643.5655932245716, 644.6583310845259, 649.1204418013524, 670.4669787518836, 8819.867701984474, 8848.46909185451, 8889.0, 9004.59479323432, 9015.2787776979, 591.2432086928738, 674.1438373265925, 693.968771405288, 703.5602748282323, 747.2639450141714, 3978.76127432355, 4334.718243314238, 4353.847615333448, 4449.265871131227, 4464.43229475007, 54453.72773136109, 55394.0, 55423.44576554183, 55738.44261557414, 56045.0, 51519.0, 51580.48419515832, 52004.739976299876, 52355.0, 52694.73652631712, 43993.34009989853, 44987.550124498994, 45511.089778204914, 45865.312020319725, 45880.541194588965, 8304.750857474286, 8586.098459661645, 8609.225169734755, 8615.655373784979, 8719.38964272495, 31889.362212756077, 33430.83284583561, 34016.0, 34139.14652133716, 34522.48216276808, 39351.80324098361, 44013.11973760571, 44280.335794962455, 44497.332540012576, 45370.0, 10624.415657138932, 11006.889931100586, 11115.055220306365, 11139.777204456028, 11609.941950290195, 11605.419729013347, 11685.123615728684, 11876.881231187577, 12065.698357541132, 12474.18917770342, 10485.68542943713, 10790.813010568989, 10837.45812709377, 11154.051905588116, 11451.312921224753, 10918.454077295944, 11310.717232068935, 11371.43142842871, 11736.88263117358, 11774.116941229271, 11228.55085796559, 11506.597269095542, 11529.077673786245, 11549.717755136233, 11715.707107322385, 9421.576029078571, 9572.712818615453, 9733.805323893625, 9918.206543476648, 10099.899001009895, 8674.38610501083, 9405.811883762422, 9674.24677367021, 9687.128158465772, 9689.12797848197], "unit": "score", "name": "yui.html", "value": 6374.775435121321}], "name": "dromaeo_css", "value": 6971.526609624725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 112.0, 113.0, 100.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [159.0, 124.0, 161.0, 173.0, 125.0, 151.0, 150.0, 127.0, 164.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 161.0, 162.0, 160.0, 160.0, 161.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 93.0, 97.0, 73.0, 72.0, 74.0, 119.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 139.0, 95.0, 95.0, 96.0, 140.0, 96.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 63.0, 57.0, 58.0, 57.0, 57.0, 66.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 83.0, 83.0, 82.0, 82.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 123.0, 127.0, 116.0, 134.0, 116.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [149.0, 143.0, 155.0, 155.0, 155.0, 144.0, 156.0, 154.0, 153.0, 164.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 71.0, 68.0, 70.0, 71.0, 69.0, 71.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1518.9999999999998}]} 23:42:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6971.53"}}} 23:42:45 INFO - Return code: 0 23:42:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:42:45 INFO - # TBPL SUCCESS # 23:42:45 INFO - Running post-action listener: _resource_record_post_action 23:42:45 INFO - Running post-run listener: _resource_record_post_run 23:42:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548532224; Read time: 8; Write time: 450336 23:42:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249110528; Read time: 0; Write time: 238916 23:42:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299421696; Read time: 8; Write time: 211420 23:42:47 INFO - Running post-run listener: _upload_blobber_files 23:42:47 INFO - Blob upload gear active. 23:42:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:42:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:42:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:42:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:42:47 INFO - (blobuploader) - INFO - Open directory for files ... 23:42:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:42:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:48 INFO - (blobuploader) - INFO - Done attempting. 23:42:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:42:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:42:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:42:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:42:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:42:48 INFO - (blobuploader) - INFO - Done attempting. 23:42:48 INFO - (blobuploader) - INFO - Iteration through files over. 23:42:48 INFO - Return code: 0 23:42:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:42:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:42:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d526272e4af8b41fe742aff1bd3e38e353159b21f57e6fe37da21060f388b37fdb61d11f9fd640432de063703b9766e5bc2c7b3517dc51b611bd3ce8fcc00e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e83bfe80045b7ed50b3caa7938c1cd57c5385708bc9ea41224c42e1694a9db28b0e6bb17e902a74de80895281184eb3d8e367479dd13bd6cfd91b25e8451f97"} 23:42:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:42:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:42:48 INFO - Contents: 23:42:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d526272e4af8b41fe742aff1bd3e38e353159b21f57e6fe37da21060f388b37fdb61d11f9fd640432de063703b9766e5bc2c7b3517dc51b611bd3ce8fcc00e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e83bfe80045b7ed50b3caa7938c1cd57c5385708bc9ea41224c42e1694a9db28b0e6bb17e902a74de80895281184eb3d8e367479dd13bd6cfd91b25e8451f97"} 23:42:48 INFO - Running post-run listener: copy_logs_to_upload_dir 23:42:48 INFO - Copying logs to upload dir... 23:42:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:42:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.188850 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-17 23:42:48.795628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 23:42:48.799504) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d526272e4af8b41fe742aff1bd3e38e353159b21f57e6fe37da21060f388b37fdb61d11f9fd640432de063703b9766e5bc2c7b3517dc51b611bd3ce8fcc00e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e83bfe80045b7ed50b3caa7938c1cd57c5385708bc9ea41224c42e1694a9db28b0e6bb17e902a74de80895281184eb3d8e367479dd13bd6cfd91b25e8451f97"} build_url:https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/dl2iMRGrTCaEn_ugWP5MGw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d526272e4af8b41fe742aff1bd3e38e353159b21f57e6fe37da21060f388b37fdb61d11f9fd640432de063703b9766e5bc2c7b3517dc51b611bd3ce8fcc00e38", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5e83bfe80045b7ed50b3caa7938c1cd57c5385708bc9ea41224c42e1694a9db28b0e6bb17e902a74de80895281184eb3d8e367479dd13bd6cfd91b25e8451f97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 23:42:48.823654) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:42:48.823931) ========= 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=82e07478c745e68b1fe4678a000001bc-1455779589.818393-1774158720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 23:42:48.905634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 23:42:48.905947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 23:42:48.906240) ========= ========= Total master_lag: 0.26 =========