builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1456276250.56 results: success (0) buildid: 20160223143047 builduid: 6b79d8f1a4a44c1a9ceacf017ef58787 revision: 745ce98cba7d5fb201996762527bfe868d58b345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.562176) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.562736) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.563091) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006759 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.585483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.585833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.605132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.605440) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.654276) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.654636) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.655407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.655742) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 17:10:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-02-23 17:10:51 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096276 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.764825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.765219) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022184 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.816640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:50.817102) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 745ce98cba7d5fb201996762527bfe868d58b345 --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 745ce98cba7d5fb201996762527bfe868d58b345 --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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 17:10:51,739 truncating revision to first 12 chars 2016-02-23 17:10:51,740 Setting DEBUG logging. 2016-02-23 17:10:51,740 attempt 1/10 2016-02-23 17:10:51,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/745ce98cba7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 17:10:52,015 unpacking tar archive at: fx-team-745ce98cba7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:51.444336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:51.444730) ========= echo 745ce98cba7d5fb201996762527bfe868d58b345 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'745ce98cba7d5fb201996762527bfe868d58b345'] 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 745ce98cba7d5fb201996762527bfe868d58b345 program finished with exit code 0 elapsedTime=0.004674 script_repo_revision: '745ce98cba7d5fb201996762527bfe868d58b345' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:51.496647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:51.497002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 17:10:51.508521) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 17:10:51.508981) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:10:52 INFO - MultiFileLogger online at 20160223 17:10:52 in /builds/slave/test-pgo 17:10:52 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 17:10:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:10:52 INFO - {'append_to_log': False, 17:10:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:10:52 INFO - 'blob_upload_branch': 'Fx-Team', 17:10:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:10:52 INFO - 'branch': 'Fx-Team', 17:10:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:52 INFO - 'config_files': ('talos/linux_config.py',), 17:10:52 INFO - 'default_actions': ('clobber', 17:10:52 INFO - 'read-buildbot-config', 17:10:52 INFO - 'download-and-extract', 17:10:52 INFO - 'populate-webroot', 17:10:52 INFO - 'create-virtualenv', 17:10:52 INFO - 'install', 17:10:52 INFO - 'run-tests'), 17:10:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:52 INFO - 'download_minidump_stackwalk': True, 17:10:52 INFO - 'download_symbols': 'ondemand', 17:10:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:52 INFO - 'installer_path': 'installer.exe', 17:10:52 INFO - 'log_level': 'info', 17:10:52 INFO - 'log_name': 'talos', 17:10:52 INFO - 'log_to_console': True, 17:10:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:10:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:10:52 INFO - 'opt_config_files': (), 17:10:52 INFO - 'pip_index': False, 17:10:52 INFO - 'sps_profile': False, 17:10:52 INFO - 'sps_profile_interval': 0, 17:10:52 INFO - 'suite': 'dromaeojs', 17:10:52 INFO - 'system_bits': '32', 17:10:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:52 INFO - 'title': 'talos-linux64-ix-034', 17:10:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:52 INFO - 'use_talos_json': True, 17:10:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:10:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:52 INFO - 'work_dir': 'build'} 17:10:52 INFO - ##### 17:10:52 INFO - ##### Running clobber step. 17:10:52 INFO - ##### 17:10:52 INFO - Running pre-action listener: _resource_record_pre_action 17:10:52 INFO - Running main action method: clobber 17:10:52 INFO - rmtree: /builds/slave/test-pgo/build 17:10:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:10:53 INFO - Running post-action listener: _resource_record_post_action 17:10:53 INFO - ##### 17:10:53 INFO - ##### Running read-buildbot-config step. 17:10:53 INFO - ##### 17:10:53 INFO - Running pre-action listener: _resource_record_pre_action 17:10:53 INFO - Running main action method: read_buildbot_config 17:10:53 INFO - Using buildbot properties: 17:10:53 INFO - { 17:10:53 INFO - "project": "", 17:10:53 INFO - "product": "firefox", 17:10:53 INFO - "script_repo_revision": "production", 17:10:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:10:53 INFO - "repository": "", 17:10:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:10:53 INFO - "buildid": "20160223143047", 17:10:53 INFO - "pgo_build": "True", 17:10:53 INFO - "basedir": "/builds/slave/test-pgo", 17:10:53 INFO - "buildnumber": 515, 17:10:53 INFO - "slavename": "talos-linux64-ix-034", 17:10:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:10:53 INFO - "platform": "ubuntu64_hw", 17:10:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:10:53 INFO - "branch": "fx-team", 17:10:53 INFO - "repo_path": "integration/fx-team", 17:10:53 INFO - "revision": "745ce98cba7d5fb201996762527bfe868d58b345", 17:10:53 INFO - "stage_platform": "linux64-pgo", 17:10:53 INFO - "builduid": "6b79d8f1a4a44c1a9ceacf017ef58787", 17:10:53 INFO - "slavebuilddir": "test" 17:10:53 INFO - } 17:10:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:10:53 INFO - Running post-action listener: _resource_record_post_action 17:10:53 INFO - ##### 17:10:53 INFO - ##### Running download-and-extract step. 17:10:53 INFO - ##### 17:10:53 INFO - Running pre-action listener: _resource_record_pre_action 17:10:53 INFO - Running main action method: download_and_extract 17:10:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:53 INFO - https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:10:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/test_packages.json 17:10:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/test_packages.json 17:10:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:10:54 INFO - Downloaded 1448 bytes. 17:10:54 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:10:54 INFO - Using the following test package requirements: 17:10:54 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:10:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:10:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'jsshell-linux-x86_64.zip'], 17:10:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:10:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:10:54 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:10:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:10:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:10:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:10:54 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:10:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:54 INFO - https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:10:55 INFO - Downloaded 23367240 bytes. 17:10:55 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'] 17:10:55 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 17:10:57 INFO - Return code: 0 17:10:57 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 17:10:57 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')]} 17:10:57 INFO - https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:10:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:10:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:10:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:10:58 INFO - Downloaded 23367240 bytes. 17:10:58 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'] 17:10:58 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 17:10:59 INFO - Return code: 0 17:10:59 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')]} 17:10:59 INFO - https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:11:00 INFO - Downloaded 10707015 bytes. 17:11:00 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'] 17:11:00 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 17:11:01 INFO - Return code: 0 17:11:01 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')]} 17:11:01 INFO - https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZIXp-e86QdSzOET5xvqruw/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 17:11:03 INFO - Downloaded 56632235 bytes. 17:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:11:03 INFO - mkdir: /builds/slave/test-pgo/properties 17:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:11:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:11:03 INFO - Contents: 17:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:11:04 INFO - Running post-action listener: _resource_record_post_action 17:11:04 INFO - Running post-action listener: set_extra_try_arguments 17:11:04 INFO - ##### 17:11:04 INFO - ##### Running populate-webroot step. 17:11:04 INFO - ##### 17:11:04 INFO - Running pre-action listener: _resource_record_pre_action 17:11:04 INFO - Running main action method: populate_webroot 17:11:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:04 INFO - '--tppagecycles', 17:11:04 INFO - '7'], 17:11:04 INFO - 'tests': ['tsvgm']}}, 17:11:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:11:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:11:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'tests': ['damp', 'tps']}, 17:11:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['damp', 'tps']}, 17:11:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:11:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:04 INFO - 'other': {'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'other_l64': {'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'other_nol64': {'tests': ['a11yr', 17:11:04 INFO - 'ts_paint', 17:11:04 INFO - 'tpaint', 17:11:04 INFO - 'sessionrestore', 17:11:04 INFO - 'sessionrestore_no_auto_restore']}, 17:11:04 INFO - 'svgr': {'tests': ['tsvgx', 17:11:04 INFO - 'tsvgr_opacity', 17:11:04 INFO - 'tart', 17:11:04 INFO - 'tscrollx', 17:11:04 INFO - 'cart']}, 17:11:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['tsvgx', 17:11:04 INFO - 'tsvgr_opacity', 17:11:04 INFO - 'tart', 17:11:04 INFO - 'tscrollx', 17:11:04 INFO - 'cart']}, 17:11:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'tests': ['tp5o']}, 17:11:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'talos_options': ['--e10s'], 17:11:04 INFO - 'tests': ['tp5o']}, 17:11:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'talos_options': ['--xperf_path', 17:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:04 INFO - 'tests': ['tp5n']}, 17:11:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:04 INFO - 'talos_options': ['--e10s', 17:11:04 INFO - '--xperf_path', 17:11:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:04 INFO - 'tests': ['tp5n']}}, 17:11:04 INFO - 'talos.zip': {'path': '', 17:11:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:04 INFO - Running post-action listener: _resource_record_post_action 17:11:04 INFO - ##### 17:11:04 INFO - ##### Running create-virtualenv step. 17:11:04 INFO - ##### 17:11:04 INFO - Running pre-action listener: _resource_record_pre_action 17:11:04 INFO - Running main action method: create_virtualenv 17:11:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:11:04 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 17:11:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:11:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:04 INFO - Using real prefix '/usr' 17:11:04 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:11:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:07 INFO - Installing pip.................done. 17:11:07 INFO - Return code: 0 17:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:11:07 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')]} 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 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')]} 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:07 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 17:11:07 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 17:11:07 INFO - Using env: {'DISPLAY': ':0', 17:11:07 INFO - 'HOME': '/home/cltbld', 17:11:07 INFO - 'LANG': 'en_US.UTF-8', 17:11:07 INFO - 'LANGUAGE': 'en_US:en', 17:11:07 INFO - 'LOGNAME': 'cltbld', 17:11:07 INFO - 'MAIL': '/var/mail/cltbld', 17:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:07 INFO - 'MOZ_NO_REMOTE': '1', 17:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:07 INFO - 'NO_EM_RESTART': '1', 17:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:07 INFO - 'SHELL': '/bin/bash', 17:11:07 INFO - 'SHLVL': '1', 17:11:07 INFO - 'TERM': 'linux', 17:11:07 INFO - 'TMOUT': '86400', 17:11:07 INFO - 'USER': 'cltbld', 17:11:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:07 INFO - '_': '/tools/buildbot/bin/python'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 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 17:11:07 INFO - Cleaning up... 17:11:07 INFO - Return code: 0 17:11:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:11:07 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')]} 17:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 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')]} 17:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:07 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:07 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 17:11:07 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 17:11:07 INFO - Using env: {'DISPLAY': ':0', 17:11:07 INFO - 'HOME': '/home/cltbld', 17:11:07 INFO - 'LANG': 'en_US.UTF-8', 17:11:07 INFO - 'LANGUAGE': 'en_US:en', 17:11:07 INFO - 'LOGNAME': 'cltbld', 17:11:07 INFO - 'MAIL': '/var/mail/cltbld', 17:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:07 INFO - 'MOZ_NO_REMOTE': '1', 17:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:07 INFO - 'NO_EM_RESTART': '1', 17:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:07 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:07 INFO - 'SHELL': '/bin/bash', 17:11:07 INFO - 'SHLVL': '1', 17:11:07 INFO - 'TERM': 'linux', 17:11:07 INFO - 'TMOUT': '86400', 17:11:07 INFO - 'USER': 'cltbld', 17:11:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:07 INFO - '_': '/tools/buildbot/bin/python'} 17:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:07 INFO - Downloading/unpacking psutil>=0.7.1 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:07 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 17:11:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:09 INFO - Installing collected packages: psutil 17:11:09 INFO - Running setup.py install for psutil 17:11:09 INFO - building 'psutil._psutil_linux' extension 17:11:09 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 17:11:09 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 17:11:09 INFO - building 'psutil._psutil_posix' extension 17:11:09 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 17:11:09 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 17:11:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:09 INFO - Successfully installed psutil 17:11:09 INFO - Cleaning up... 17:11:10 INFO - Return code: 0 17:11:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:11:10 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')]} 17:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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')]} 17:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:10 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:10 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 17:11:10 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 17:11:10 INFO - Using env: {'DISPLAY': ':0', 17:11:10 INFO - 'HOME': '/home/cltbld', 17:11:10 INFO - 'LANG': 'en_US.UTF-8', 17:11:10 INFO - 'LANGUAGE': 'en_US:en', 17:11:10 INFO - 'LOGNAME': 'cltbld', 17:11:10 INFO - 'MAIL': '/var/mail/cltbld', 17:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:10 INFO - 'MOZ_NO_REMOTE': '1', 17:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:10 INFO - 'NO_EM_RESTART': '1', 17:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:10 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:10 INFO - 'SHELL': '/bin/bash', 17:11:10 INFO - 'SHLVL': '1', 17:11:10 INFO - 'TERM': 'linux', 17:11:10 INFO - 'TMOUT': '86400', 17:11:10 INFO - 'USER': 'cltbld', 17:11:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:10 INFO - '_': '/tools/buildbot/bin/python'} 17:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:11:10 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 17:11:10 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 17:11:10 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 17:11:10 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 17:11:10 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 17:11:10 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 17:11:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:11:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:11:12 INFO - Installing collected packages: mozsystemmonitor 17:11:12 INFO - Running setup.py install for mozsystemmonitor 17:11:12 INFO - Successfully installed mozsystemmonitor 17:11:12 INFO - Cleaning up... 17:11:12 INFO - Return code: 0 17:11:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:11:12 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')]} 17:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:12 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')]} 17:11:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:12 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:12 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 17:11:12 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 17:11:12 INFO - Using env: {'DISPLAY': ':0', 17:11:12 INFO - 'HOME': '/home/cltbld', 17:11:12 INFO - 'LANG': 'en_US.UTF-8', 17:11:12 INFO - 'LANGUAGE': 'en_US:en', 17:11:12 INFO - 'LOGNAME': 'cltbld', 17:11:12 INFO - 'MAIL': '/var/mail/cltbld', 17:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:12 INFO - 'MOZ_NO_REMOTE': '1', 17:11:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:12 INFO - 'NO_EM_RESTART': '1', 17:11:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:12 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:12 INFO - 'SHELL': '/bin/bash', 17:11:12 INFO - 'SHLVL': '1', 17:11:12 INFO - 'TERM': 'linux', 17:11:12 INFO - 'TMOUT': '86400', 17:11:12 INFO - 'USER': 'cltbld', 17:11:12 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:12 INFO - '_': '/tools/buildbot/bin/python'} 17:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:12 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:12 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 17:11:14 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:11:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:14 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 17:11:15 INFO - Downloading docopt-0.6.1.tar.gz 17:11:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:15 INFO - Running setup.py install for blobuploader 17:11:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:11:15 INFO - Running setup.py install for requests 17:11:15 INFO - Running setup.py install for docopt 17:11:15 INFO - Successfully installed blobuploader requests docopt 17:11:15 INFO - Cleaning up... 17:11:15 INFO - Return code: 0 17:11:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:11:15 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')]} 17:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:15 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')]} 17:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:15 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:15 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 17:11:15 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 17:11:15 INFO - Using env: {'DISPLAY': ':0', 17:11:15 INFO - 'HOME': '/home/cltbld', 17:11:15 INFO - 'LANG': 'en_US.UTF-8', 17:11:15 INFO - 'LANGUAGE': 'en_US:en', 17:11:15 INFO - 'LOGNAME': 'cltbld', 17:11:15 INFO - 'MAIL': '/var/mail/cltbld', 17:11:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:15 INFO - 'MOZ_NO_REMOTE': '1', 17:11:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:15 INFO - 'NO_EM_RESTART': '1', 17:11:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:15 INFO - 'SHELL': '/bin/bash', 17:11:15 INFO - 'SHLVL': '1', 17:11:15 INFO - 'TERM': 'linux', 17:11:15 INFO - 'TMOUT': '86400', 17:11:15 INFO - 'USER': 'cltbld', 17:11:15 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:15 INFO - '_': '/tools/buildbot/bin/python'} 17:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:11:16 INFO - Running setup.py (path:/tmp/pip-vvDdvZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:11:16 INFO - Running setup.py (path:/tmp/pip-cM6_LL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:11:16 INFO - Running setup.py (path:/tmp/pip-AgoJty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:11:16 INFO - Running setup.py (path:/tmp/pip-gQ0mMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:11:16 INFO - Running setup.py (path:/tmp/pip-_BUpmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:11:16 INFO - Running setup.py (path:/tmp/pip-l7_42L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:11:16 INFO - Running setup.py (path:/tmp/pip-JLirwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:11:16 INFO - Running setup.py (path:/tmp/pip-kyvVMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:11:16 INFO - Running setup.py (path:/tmp/pip-5hR1Jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:11:16 INFO - Running setup.py (path:/tmp/pip-UzuU_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:11:16 INFO - Running setup.py (path:/tmp/pip-UZCdgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:11:16 INFO - Running setup.py (path:/tmp/pip-556lBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:11:16 INFO - Running setup.py (path:/tmp/pip-bS0SWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:11:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:11:16 INFO - Running setup.py (path:/tmp/pip-KjVAxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:11:17 INFO - Running setup.py (path:/tmp/pip-lA0X_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:11:17 INFO - Running setup.py (path:/tmp/pip-64jIdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:11:17 INFO - Running setup.py (path:/tmp/pip-RScRU2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:11:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:17 INFO - Running setup.py install for manifestparser 17:11:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:11:17 INFO - Running setup.py install for mozcrash 17:11:17 INFO - Running setup.py install for mozdebug 17:11:17 INFO - Running setup.py install for mozdevice 17:11:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:11:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:11:17 INFO - Running setup.py install for mozfile 17:11:17 INFO - Running setup.py install for mozhttpd 17:11:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:11:17 INFO - Running setup.py install for mozinfo 17:11:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:11:17 INFO - Running setup.py install for mozInstall 17:11:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Running setup.py install for mozleak 17:11:18 INFO - Running setup.py install for mozlog 17:11:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Running setup.py install for moznetwork 17:11:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Running setup.py install for mozprocess 17:11:18 INFO - Running setup.py install for mozprofile 17:11:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Running setup.py install for mozrunner 17:11:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:11:18 INFO - Running setup.py install for mozscreenshot 17:11:18 INFO - Running setup.py install for moztest 17:11:18 INFO - Running setup.py install for mozversion 17:11:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:11:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:19 INFO - Cleaning up... 17:11:19 INFO - Return code: 0 17:11:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:19 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 17:11:19 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 17:11:19 INFO - Using env: {'DISPLAY': ':0', 17:11:19 INFO - 'HOME': '/home/cltbld', 17:11:19 INFO - 'LANG': 'en_US.UTF-8', 17:11:19 INFO - 'LANGUAGE': 'en_US:en', 17:11:19 INFO - 'LOGNAME': 'cltbld', 17:11:19 INFO - 'MAIL': '/var/mail/cltbld', 17:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:19 INFO - 'MOZ_NO_REMOTE': '1', 17:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:19 INFO - 'NO_EM_RESTART': '1', 17:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:19 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:19 INFO - 'SHELL': '/bin/bash', 17:11:19 INFO - 'SHLVL': '1', 17:11:19 INFO - 'TERM': 'linux', 17:11:19 INFO - 'TMOUT': '86400', 17:11:19 INFO - 'USER': 'cltbld', 17:11:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:19 INFO - '_': '/tools/buildbot/bin/python'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:11:19 INFO - Running setup.py (path:/tmp/pip-0jjhxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:11:19 INFO - Running setup.py (path:/tmp/pip-7Do23L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:11:19 INFO - Running setup.py (path:/tmp/pip-UrdAcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:11:19 INFO - Running setup.py (path:/tmp/pip-bgA86t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:11:19 INFO - Running setup.py (path:/tmp/pip-_L6QsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:11:19 INFO - Running setup.py (path:/tmp/pip-qaMXoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:11:19 INFO - Running setup.py (path:/tmp/pip-Z9YPF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:11:19 INFO - Running setup.py (path:/tmp/pip-TGl2MI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:11:19 INFO - Running setup.py (path:/tmp/pip-FTXRTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:11:19 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)) 17:11:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:11:19 INFO - Running setup.py (path:/tmp/pip-248Em2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:11:20 INFO - Running setup.py (path:/tmp/pip-7429IR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:11:20 INFO - Running setup.py (path:/tmp/pip-_EOoDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:11:20 INFO - Running setup.py (path:/tmp/pip-lKoiGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:11:20 INFO - Running setup.py (path:/tmp/pip-ulskCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:11:20 INFO - Running setup.py (path:/tmp/pip-zAaBHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:11:20 INFO - Running setup.py (path:/tmp/pip-qtHAAH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:11:20 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)) 17:11:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:11:20 INFO - Running setup.py (path:/tmp/pip-6nPhwH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:11:20 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)) 17:11:20 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)) 17:11:20 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)) 17:11:20 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)) 17:11:20 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)) 17:11:20 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)) 17:11:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:20 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 17:11:20 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 17:11:20 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 17:11:20 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 17:11:20 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 17:11:20 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 17:11:22 INFO - Downloading blessings-1.6.tar.gz 17:11:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:22 INFO - Installing collected packages: blessings 17:11:22 INFO - Running setup.py install for blessings 17:11:22 INFO - Successfully installed blessings 17:11:22 INFO - Cleaning up... 17:11:22 INFO - Return code: 0 17:11:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:11:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:11:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:11:22 INFO - Reading from file tmpfile_stdout 17:11:22 INFO - Current package versions: 17:11:22 INFO - argparse == 1.2.1 17:11:22 INFO - blessings == 1.6 17:11:22 INFO - blobuploader == 1.2.4 17:11:22 INFO - docopt == 0.6.1 17:11:22 INFO - manifestparser == 1.1 17:11:22 INFO - mozInstall == 1.12 17:11:22 INFO - mozcrash == 0.16 17:11:22 INFO - mozdebug == 0.1 17:11:22 INFO - mozdevice == 0.48 17:11:22 INFO - mozfile == 1.2 17:11:22 INFO - mozhttpd == 0.7 17:11:22 INFO - mozinfo == 0.9 17:11:22 INFO - mozleak == 0.1 17:11:22 INFO - mozlog == 3.1 17:11:22 INFO - moznetwork == 0.27 17:11:22 INFO - mozprocess == 0.22 17:11:22 INFO - mozprofile == 0.28 17:11:22 INFO - mozrunner == 6.11 17:11:22 INFO - mozscreenshot == 0.1 17:11:22 INFO - mozsystemmonitor == 0.0 17:11:22 INFO - moztest == 0.7 17:11:22 INFO - mozversion == 1.4 17:11:22 INFO - psutil == 3.1.1 17:11:22 INFO - requests == 1.2.3 17:11:22 INFO - wsgiref == 0.1.2 17:11:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:11: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')]} 17:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:22 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:22 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 17:11:22 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 17:11:22 INFO - Using env: {'DISPLAY': ':0', 17:11:22 INFO - 'HOME': '/home/cltbld', 17:11:22 INFO - 'LANG': 'en_US.UTF-8', 17:11:22 INFO - 'LANGUAGE': 'en_US:en', 17:11:22 INFO - 'LOGNAME': 'cltbld', 17:11:22 INFO - 'MAIL': '/var/mail/cltbld', 17:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:22 INFO - 'MOZ_NO_REMOTE': '1', 17:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:22 INFO - 'NO_EM_RESTART': '1', 17:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:22 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:22 INFO - 'SHELL': '/bin/bash', 17:11:22 INFO - 'SHLVL': '1', 17:11:22 INFO - 'TERM': 'linux', 17:11:22 INFO - 'TMOUT': '86400', 17:11:22 INFO - 'USER': 'cltbld', 17:11:22 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:22 INFO - '_': '/tools/buildbot/bin/python'} 17:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 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)) 17:11:23 INFO - Cleaning up... 17:11:23 INFO - Return code: 0 17:11:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:23 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 17:11:23 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 17:11:23 INFO - Using env: {'DISPLAY': ':0', 17:11:23 INFO - 'HOME': '/home/cltbld', 17:11:23 INFO - 'LANG': 'en_US.UTF-8', 17:11:23 INFO - 'LANGUAGE': 'en_US:en', 17:11:23 INFO - 'LOGNAME': 'cltbld', 17:11:23 INFO - 'MAIL': '/var/mail/cltbld', 17:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:23 INFO - 'MOZ_NO_REMOTE': '1', 17:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:23 INFO - 'NO_EM_RESTART': '1', 17:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:23 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:23 INFO - 'SHELL': '/bin/bash', 17:11:23 INFO - 'SHLVL': '1', 17:11:23 INFO - 'TERM': 'linux', 17:11:23 INFO - 'TMOUT': '86400', 17:11:23 INFO - 'USER': 'cltbld', 17:11:23 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:23 INFO - '_': '/tools/buildbot/bin/python'} 17:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:23 INFO - Downloading/unpacking jsonschema 17:11:23 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 17:11:23 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 17:11:23 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 17:11:23 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 17:11:23 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 17:11:23 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 17:11:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:25 INFO - Downloading/unpacking functools32 (from jsonschema) 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:25 INFO - warning: no files found matching '*.txt' 17:11:25 INFO - no previously-included directories found matching 'build' 17:11:25 INFO - no previously-included directories found matching 'dist' 17:11:25 INFO - no previously-included directories found matching '.git*' 17:11:25 INFO - Installing collected packages: jsonschema, functools32 17:11:25 INFO - Running setup.py install for functools32 17:11:25 INFO - warning: no files found matching '*.txt' 17:11:25 INFO - no previously-included directories found matching 'build' 17:11:25 INFO - no previously-included directories found matching 'dist' 17:11:25 INFO - no previously-included directories found matching '.git*' 17:11:25 INFO - Successfully installed jsonschema functools32 17:11:25 INFO - Cleaning up... 17:11:25 INFO - Return code: 0 17:11:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:25 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 0x7fc24d66ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x233a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', '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 17:11:25 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 17:11:25 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 17:11:25 INFO - Using env: {'DISPLAY': ':0', 17:11:25 INFO - 'HOME': '/home/cltbld', 17:11:25 INFO - 'LANG': 'en_US.UTF-8', 17:11:25 INFO - 'LANGUAGE': 'en_US:en', 17:11:25 INFO - 'LOGNAME': 'cltbld', 17:11:25 INFO - 'MAIL': '/var/mail/cltbld', 17:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:25 INFO - 'MOZ_NO_REMOTE': '1', 17:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:25 INFO - 'NO_EM_RESTART': '1', 17:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:25 INFO - 'SHELL': '/bin/bash', 17:11:25 INFO - 'SHLVL': '1', 17:11:25 INFO - 'TERM': 'linux', 17:11:25 INFO - 'TMOUT': '86400', 17:11:25 INFO - 'USER': 'cltbld', 17:11:25 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:25 INFO - '_': '/tools/buildbot/bin/python'} 17:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:25 INFO - Downloading/unpacking flake8 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:11:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:11:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:27 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 17:11:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:28 INFO - no previously-included directories found matching 'docs/_build' 17:11:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:11:28 INFO - Running setup.py install for pep8 17:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:11:28 INFO - no previously-included directories found matching 'docs/_build' 17:11:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:11:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:11:28 INFO - Cleaning up... 17:11:28 INFO - Return code: 0 17:11:28 INFO - Running post-action listener: _resource_record_post_action 17:11:28 INFO - Running post-action listener: _start_resource_monitoring 17:11:28 INFO - Starting resource monitoring. 17:11:28 INFO - ##### 17:11:28 INFO - ##### Running install step. 17:11:28 INFO - ##### 17:11:28 INFO - Running pre-action listener: _resource_record_pre_action 17:11:28 INFO - Running main action method: install 17:11:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:11:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:11:28 INFO - Reading from file tmpfile_stdout 17:11:28 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:11:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:11:28 INFO - Reading from file tmpfile_stdout 17:11:28 INFO - Output received: 17:11:28 INFO - Usage: mozinstall [options] installer 17:11:28 INFO - Options: 17:11:28 INFO - -h, --help show this help message and exit 17:11:28 INFO - -d DEST, --destination=DEST 17:11:28 INFO - Directory to install application into. [default: 17:11:28 INFO - "/builds/slave/test-pgo"] 17:11:28 INFO - --app=APP Application being installed. [default: firefox] 17:11:28 INFO - mkdir: /builds/slave/test-pgo/build/application 17:11:28 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'] 17:11:28 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 17:11:45 INFO - Reading from file tmpfile_stdout 17:11:45 INFO - Output received: 17:11:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:11:45 INFO - Running post-action listener: _resource_record_post_action 17:11:45 INFO - ##### 17:11:45 INFO - ##### Running run-tests step. 17:11:45 INFO - ##### 17:11:45 INFO - Running pre-action listener: _resource_record_pre_action 17:11:45 INFO - Running main action method: run_tests 17:11:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:11:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:11:45 INFO - Python 2.7.3 17:11:45 INFO - Return code: 0 17:11:45 INFO - grabbing minidump binary from tooltool 17:11: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')]} 17:11:45 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 0x23c98c0>, '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 0x23ca7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:11:45 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 17:11:45 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 17:11:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:11:45 INFO - Return code: 0 17:11:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:11:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:11:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:11:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:11:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:11:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:11:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:11:46 INFO - Return code: 0 17:11:46 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/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 17:11:46 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/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 17:11:46 INFO - Using env: {'DISPLAY': ':0', 17:11:46 INFO - 'HOME': '/home/cltbld', 17:11:46 INFO - 'LANG': 'en_US.UTF-8', 17:11:46 INFO - 'LANGUAGE': 'en_US:en', 17:11:46 INFO - 'LOGNAME': 'cltbld', 17:11:46 INFO - 'MAIL': '/var/mail/cltbld', 17:11:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:11:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:46 INFO - 'MOZ_NO_REMOTE': '1', 17:11:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:11:46 INFO - 'NO_EM_RESTART': '1', 17:11:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:11:46 INFO - 'PWD': '/builds/slave/test-pgo', 17:11:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:11:46 INFO - 'SHELL': '/bin/bash', 17:11:46 INFO - 'SHLVL': '1', 17:11:46 INFO - 'TERM': 'linux', 17:11:46 INFO - 'TMOUT': '86400', 17:11:46 INFO - 'USER': 'cltbld', 17:11:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822', 17:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:46 INFO - '_': '/tools/buildbot/bin/python'} 17:11:46 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/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 17:11:46 INFO - mozversion application_buildid: 20160223143047 17:11:46 INFO - mozversion application_changeset: 745ce98cba7d5fb201996762527bfe868d58b345 17:11:46 INFO - mozversion application_display_name: Nightly 17:11:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:11:46 INFO - mozversion application_name: Firefox 17:11:46 INFO - mozversion application_remotingname: firefox 17:11:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:11:46 INFO - mozversion application_vendor: Mozilla 17:11:46 INFO - mozversion application_version: 47.0a1 17:11:46 INFO - mozversion platform_buildid: 20160223143047 17:11:46 INFO - mozversion platform_changeset: 745ce98cba7d5fb201996762527bfe868d58b345 17:11:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:11:46 INFO - mozversion platform_version: 47.0a1 17:11:46 INFO - using testdate: 1456276306 17:11:46 INFO - actual date: 1456276306 17:11:46 INFO - starting webserver on 'localhost:35170' 17:11:46 INFO - SUITE-START | Running 2 tests 17:11:46 INFO - TEST-START | dromaeo_css 17:11:46 INFO - operating with platform_type : linux_ 17:11:46 INFO - Initialising browser for dromaeo_css test... 17:11:46 INFO - TEST-INFO | started process 7218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcPNw0U/profile http://localhost:35170/getInfo.html) 17:11:50 INFO - PROCESS | 7218 | __metrics Screen width/height:1600/1200 17:11:50 INFO - PROCESS | 7218 | colorDepth:24 17:11:50 INFO - PROCESS | 7218 | Browser inner width/height: 1024/697 17:11:50 INFO - PROCESS | 7218 | __metrics 17:11:51 INFO - PROCESS | 7218 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:11:52 INFO - TEST-INFO | 7218: exit 0 17:11:52 INFO - Browser initialized. 17:11:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:11:52 INFO - TEST-INFO | started process 7316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcPNw0U/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:04 INFO - PROCESS | 7316 | RSS: Main: 148004864 17:12:04 INFO - PROCESS | 7316 | 17:12:55 INFO - PROCESS | 7316 | 1456276375657 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] 17:15:03 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35170/tests/dromaeo/cssquery-ext.html) 17:15:04 INFO - PROCESS | 7316 | RSS: Main: 208031744 17:15:04 INFO - PROCESS | 7316 | 17:18:06 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-ext.html (next: http://localhost:35170/tests/dromaeo/cssquery-jquery.html) 17:18:07 INFO - PROCESS | 7316 | RSS: Main: 243036160 17:18:07 INFO - PROCESS | 7316 | 17:21:09 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35170/tests/dromaeo/cssquery-mootools.html) 17:21:09 INFO - PROCESS | 7316 | RSS: Main: 243486720 17:21:09 INFO - PROCESS | 7316 | 17:24:11 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35170/tests/dromaeo/cssquery-prototype.html) 17:24:12 INFO - PROCESS | 7316 | RSS: Main: 205328384 17:24:12 INFO - PROCESS | 7316 | 17:27:14 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35170/tests/dromaeo/cssquery-yui.html) 17:27:15 INFO - PROCESS | 7316 | RSS: Main: 198508544 17:27:15 INFO - PROCESS | 7316 | 17:30:17 INFO - PROCESS | 7316 | Cycle 1(1): loaded http://localhost:35170/tests/dromaeo/cssquery-yui.html (next: http://localhost:35170/tests/dromaeo/cssquery-dojo.html) 17:30:18 INFO - PROCESS | 7316 | RSS: Main: 253841408 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | __start_tp_report 17:30:18 INFO - PROCESS | 7316 | _x_x_mozilla_page_load 17:30:18 INFO - PROCESS | 7316 | _x_x_mozilla_page_load_details 17:30:18 INFO - PROCESS | 7316 | |i|pagename|runs| 17:30:18 INFO - PROCESS | 7316 | |0;dojo.html;3075.7231849133573;3112.393083348745;3141.3874294512566;3146.5122905949584;3181.5545823584703;4923.261510773385;4983.4269059058215;5002.9749851250735;5042.420121686003;5055.848324550265;5031.144705400082;5054.1913293872985;5060.0385926674;5078.898422031557;5082.364704411949;4544.636429085665;4576.97711511442;4624.606908412772;4666.183417901871;4684.254980871473;4485.686001979862;4516.706414083074;4641.628669706432;4648.604868586174;4757.762111894409;4563.566461186182;4576.313552967048;4608.423947006608;4625.560571745679;4634.050019745944;4581.037982023779;4593.678442509025;4597.448306203277;4600.378948841931;4643.8142474300985;4521.434820647419;4566.10960862632;4600.769961501945;4619.8152073917;4647.047355292157;4816.325714399987;4842.104210721028;4844.442889067767;4854.12625727369;4872.4640289568115;5199.14214154664;5338.199270109476;5349.14413693811;5353.9196912046355;5357.919631205535;5243.10867152585;5264.605154613381;5269.55208807248;5274.314339135926;5292.550133238641;5040.42035165957;5073.797048118071;5074.441811400743;5077.543021128116;5079.238114282887;5390.838274851761;5490.56075513958;5518.889622207534;5523.337199536081;5617.578681598897;5267.736613169326;5278.524932755993;5288.2596436498925;5292.285541451854;5298.576113910878;5363.222332761806;5378.1932710093015;5383.16560933056;5392.137258038695;5439.809606663748;5281.630285880028;5296.576273898079;5316.521513063843;5352.6253162279045;5410.729463526808;5324.893502129936;5368.651037682538;5386.973065134727;5390.865228369244;5425.9186112208345;4123.793810309473;4220.324748040299;4224.218519573888;4225.176090662291;4234.470691163605;3792.3363411402893;3793.7344385893275;3796.032011836964;3807.952812976398;3817.179306449071;5052.646314758005;5053.545180933734;5057.69653820772;5059.367579052619;5070.366204224472;5236.607254455931;5246.081935661244;5300.072487314705;5320.201969704575;5365.980463711882;4896.853094407174;4972.825951091694;4972.925406118911;4986.476419975923;5019.322391477177;4588.587027167571;4589.380433641482;4590.059037897223;4602.815887364535;4637.489876113625;5484.808031718871;5600.775968961278;5612.961602103624;5639.069553523623;5731;5329.067413202596;5352.4915133062295;5359.705216212989;5369.27514785499;5370.62405631602;5393.51458368733;5610.7755689773585;5622.24099746529;5627.21219029328;5670.262865827416;5268.025415298182;5288.259643649815;5290.418054013979;5294.629375943647;5323.973380133075;5336.866578335573;5348.064088784525;5380.677159370451;5383;5420.891582168256;5012.498750124958;5191.870203244949;5192.45479224676;5251.369835619597;5254.422013578427;5189.974050129726;5215.400228973716;5220.686758794484;5221.582273418041;5269.71016594091;5009.448960614257;5160.974195129001;5164.302819119521;5164.870878228075;5167.793288268577;5240.868978275574;5247.89504209906;5263.973680131575;5273.8681532960445;5382.650127741685;5091.949080509147;5154.8969020620125;5197.0905091609575;5226.320578324793;5273.971575542732 17:30:18 INFO - PROCESS | 7316 | |1;ext.html;512.0705918757455;515.9045576568333;517.4592550784431;520.5705293133163;536.8672101865067;28780.85609571952;37223.441648375265;37394.252114957686;37420.62579374209;37519.06202344936;40602.7969860151;41593;41634;41645.375319370236;41784.791076044654;8510.914890851089;8732.12678732128;8740.388172827905;8759.124087591254;8761.51811650359;8564.929383827022;8700.782480437976;8706.608202630865;8709.825803483958;8916.375853690244;8728.869066964;8938.821223575525;8985.775355616097;8986.14631609996;8991.055939126396;8861.158189971942;8861.468311901242;8932.196102350787;8937.955310223408;8946.86579701305;8773.868391974125;8858.778530536723;8884.067172946812;8897.911020889838;8898.911010889939;40551.797241013905;40907.18185636271;41125.79437102795;41268.1746365074;41300.38049429261;3234.579504664402;3354.899353019389;3356.7314614831;3406.829658517064;3750.587435382106;30549;30670.53994190089;30805.845970770228;31525.369492610247;32345.35309293801;3929.0819567979647;3948.9012774680577;3996.3805610130476;4047.5750046245307;4149;260726;262646;262879;263016;263476;42155;42766.14467710691;42833;42910.35634465423;42914;40537.79731101385;40699;40809.59190408058;40835.591644083775;40853.18293634111;14980.400783968737;15141.772873406908;15178.468753593572;15180.620484487976;15189.240537973057;11298.209125361145;11324.490397932113;11379.43102844871;11395.943020284845;11498.080153587693;14300.284985750879;14313.78529322061;14334.856651433352;14366.784498232535;14420.278986050656;5693.914591281134;5804.825855224266;5847.502962248256;5880.852978675567;5925.911111333334;1016.1768967136643;1031.7781676939494;1132.4111462039857;1145.8109411946934;1167.3229526874393;28361;28683.56974645382;28977.85511072431;29171.249725016565;31581.368372632878;895.230102112183;975.2441857560306;989.8663680403054;1003.7641154328727;1097.8517900083386;13432;13524.32378381077;13712.725745485035;13762.587122386345;13807.240601767;295716;297390;300624;301939;303280;45919.31121033187;46288;46296;46368.07263854704;46396.376126836076;1355.329112089522;1369.3906211735882;1379.889608831291;1380.5168191133023;1389.8818600419077;24579.508409832062;32995.83502082474;33117.337653246315;33214;33338.33323333568;49089.754551227015;49239.7538012322;49525;50016;50027;291172;292428;292661;293819;293906;32153.839230803696;32445;32715.34569308553;32814.83592582117;32844;42830;43220.78389608032;43918.780406097765;43988;44090.11819763522;37101.805747195955;37536.249275014896;39587;39796.602033980445;40709.38935916023;33830.830845845616;34567;34689.13277168091;34829.65170348366;34885.47671784976;35353;39047.80476097601;39150.2169956605;39910;40393;31438.214044649067;33195.66804331926;33298.667013329556;33601.66398335985;35772;24459.87770061138;25464.49071018532;25469;25572;25798 17:30:18 INFO - PROCESS | 7316 | |2;jquery.html;368.91146124930026;370.11911650272356;372.48224967295465;377.9792111433872;378.341685467287;13872.722545549082;16655.916720416397;17056.403025894095;17347.566310842234;18647.06764661768;16244.106574138417;16382.75425868613;16536.917315413437;16593.41923032694;16617.335306587724;5212;5415.620906536544;5452.291202143716;5452.700101494416;5488.313960754906;3988.8404463821557;5153.2785410042625;5741.45456181662;5942.286925568917;5960;5848.766049358021;5887.793927212549;5893.174955506232;5917.526597872182;5918.201042859202;5176.145935920568;5357.705326207096;5359.758810853501;5364.275822763916;5865.8826823463505;5013.248012798073;5119.692818430906;5132.923006154911;5133.435322114565;5422.349318081816;12570;12700;12742;12779.552715655;12867.871321286855;2292.5071109711325;2413.879306034691;2472.295395812203;2579.5356835769553;2848.8148270362362;9318.440893546409;9336;9456.905430945671;9475.620975160986;9597.808043839153;1838.6322735452964;1855.434092601756;1856.8087964575407;1909.5417099896065;1934.4003358958769;63107;65824;66593.33406665968;67601.66199169021;67675;9177.128172823572;9382.624695012122;9579.952100239594;9605.903940960501;9615.375000624937;12348.073894457952;12426.62720118398;12437;12449.875501245053;12455.875441245471;7304.379127774198;7441.702331906663;7503.924960750432;7586.886196707053;7637.847243055107;7546.622668866535;7563.978862853554;7604.239576042462;7608.923910760932;7668.65798485274;4005.5193376794973;4011.097503061846;4041.535223449282;4045.1505183911117;4060.39094135882;1673.1968655045403;1699.8980061196369;1750.492357216393;1768.4429404737466;1817.5456135966008;874.2699845628844;912.9087091290951;980.7008862297068;1039.6621098143135;1042.9478526073817;15620;16000;16408.6718265634;16491;16622.75065874013;806.7418426103591;873.2620935309653;882.4793371910475;896.7713233125511;941.6610020392653;8818.206361427503;8962.14859588338;9080.828363352928;9361.812763744687;9433.292503062297;439508;441129;442478;458768;460124;49059;70943;76433.88528917673;77064;77193.61403192948;1042.7758032023;1045.6183493025144;1048.9475526223657;1072.099436473366;1089.803835309636;14443.205623690797;14488.041331710985;14580.92709536488;14834.62913427173;14957.551273461813;32614;32701;33008.83495582507;33568.16079598029;33666.49500257449;43648.34527482027;46918.76540617275;47219.52780472151;47393.28910066283;47506.76246618745;7512.774616761506;7660.5403675779635;7730.84469587563;7873.25204105609;7918.485298455582;11069.5572177112;12479.438425271066;12639;12690.809637855624;12821.102522823687;11035.558577656804;11050.613228536962;11086.667399978014;11126.888731112585;11230.494627741607;10183.898161018295;10807.72980675458;10854.457277135954;10862.782744345226;10959.452027398438;7555.526672298849;10074.94962525212;10734.570617175226;10735.838962415413;10905.073068789241;7554.357879580297;7902.170272121574;7948.8807667886185;8148.266656000988;8197;10316.226283028653;10469.842952355873;10855.728606784893;10935.617253396093;10993.780124397626 17:30:18 INFO - PROCESS | 7316 | |3;mootools.html;1347.016677825187;1450.282110355374;1466.2595389328387;1612.435647523367;1775.4318618042223;7224.6026468544205;7381.077365329334;7413;7420.4805663603565;7421.960925470425;7394.5193562418535;7402.740904068359;7463;7467.850642987137;7472.887906681404;1915.7605299337583;2187.8140358069545;2211.281333566589;2212.3694746997107;2228.264672658027;2250.696156018933;2259.344790010895;2261.604219261631;2262.072550254396;2264.750877403484;2182.443476913385;2231.4421394651336;2242.7532971373134;2247.550489902026;2250.6173950428465;2194.7476040255337;2208.6907832903325;2223.755386907447;2292.426893276681;2292.4612716011725;2147.6563749799957;2150.838687098458;2175.445261458334;2176.5538064696857;2221.2669818959703;7289.198188199294;7352.595607241599;7368.594727289997;7369.22623124575;7374.410047196211;4561.1789877821975;4657.580817726421;4704.200285951397;4704.976475117637;4709.599684026827;2952.2914500519937;3047.1467988963127;3096.14855914623;3097.519884417919;3104;1064.2231171245035;1069.7379142110155;1098.9285696429706;1104.3318792130806;1121.62600814003;9791.510424478747;9849.803003939953;9851.950740246253;9863.408195508293;9871.90128098717;3993.600639935983;4030.717849750548;4126.298529250034;4150.335946248586;4163.542010378856;7980.521168729895;8069.233422824822;8104.756857294291;8106.797330066795;8124.715634952749;3997.2405243003736;4591.95408045922;4628.699134556243;4645.767711614406;4670.065986802653;4151.418801367811;4193.287141186006;4207.957920420757;4219.683523735732;4223.873283801491;3402.4045791986305;3403.9489407658907;3412.5051867479574;3437.553118094682;3453.8791142309897;1013.9036791504795;1018.3126389686931;1028.7222449938624;1037.5538518437145;1071.6356438810685;1023.2376879225025;1031.4327120083924;1047.7223535763028;1178.587494376961;1344.5025340624031;6892.207396149407;6996.930030699627;7049;7061.364477197077;7072.646367681596;485.60665860652983;490.60506292434934;502.12880652068634;505.1160469178937;505.99241011384856;5600.523955463831;5629.7185140742795;5648.802291919846;5700.9429905701245;5717.456841600041;8454.915450845412;8576.44253123545;8616.439931404439;8628.784280392914;8870.112988701207;8539.06070332263;8544.572771361407;8563;8641.962964444307;8651.351148663749;7025.051618031501;7094.290570942968;7148.356647901818;7148.428125749928;7172.641367931687;7036.683349249399;7069.257727938492;7070.36366726997;7078.221395646372;7114.075170227838;8087.110417854149;8179.345652347917;8316.37627177952;8353.457025293337;8385.077641459313;8115.066767321598;8376.32989360862;8558.57207139628;8566.057733649419;8578.613962371834;5901.409859014064;6354.809355719336;6524.119243902012;6621.1392518972225;6682.532222744361;7088.397486213524;7097.112860892388;7114;7132;7133.892991605234;6388.75419293252;6540.215174179129;6564.934350656432;6652.168478940132;6656.866862662817;6395;6452.35476452351;6465.0948867157695;6468.676566171578;6483.805485835433;6811.523193376416;6859.211190713132;6872.278410766998;6872.450203983769;6878.8624227514165;6234.064890266315;6236.438720515175;6296.874062518816;6330.746770129143;6333.145025421509;6169.321374648695;6226.782062627786;6246.843828904313;6255.718492667932;6256.249250090018 17:30:18 INFO - PROCESS | 7316 | |4;prototype.html;325.9934801303974;341.3582464965864;341.60032761668845;345.86338396333457;348.05503059194285;5851.561132915032;5895.528357731377;5906.734196961136;5908;5908.320543137541;5828.300603927524;5829.271341082364;5830.708464576775;5837.445442682949;5837.941620583793;4581.358609794632;4582;4585.449746030481;4588.885277868063;4589.265717485203;4596.471405788327;4597.172508948388;4606.815727370901;4610.492845786961;4610.538946105379;4252.766097864632;4253.8723838284905;4548.340490628857;4564.132814765184;4568.885777855547;4509.729416235036;4546.659000574954;4552.704074235164;4553.225951588205;4555.635549156076;4020.8793736187963;4026.71812973092;4032.1734044520804;4034.677225821927;4034.979825100885;5352.518273355417;5438.401775804658;5511.118221084607;5524.1989911463015;5578.693171875545;5156.278121063054;5167.224916262553;5168.844934651929;5172.715500647463;5202.817901373472;6243.75024999004;6247.843803904893;6248.062790581449;6249.375062493714;6249.625022498664;4366.366876802877;4376.978115109404;4377.6935614507;4378.058717375748;4378.190034843564;6176.258848938156;6269.279032911182;6425.1647285853005;6518.706658200345;6575.93424065758;4538.432695913011;4557.680962332671;4563.018950925501;4565.429321334833;4569.634429245652;4619.491855895849;4623.306504024423;4627.444706635158;4631.814727410933;4634.513376095461;5276.604254680914;5282.207668849704;5282.656627319212;5284.497972692588;5294.470552944752;6257.843553911098;6263.467605253513;6268.529860260499;6269.0909818076125;6271;1585.7462805951222;1606.1407147176205;1633.0446688687014;1634.2319110018273;1634.9754753678703;1098.3464838421287;1099.8570185875785;1115.3865374044244;1127.7406196574834;1134.6142311614092;5792.420757924174;5811.099279611667;5811.186433899257;5812.38969908162;5827.88344233113;6280.089387038854;6284.717187726472;6290.559660823698;6291.182146320949;6297.779577714758;5801.622894511843;5807.274090738658;5807.883842323215;5816.592838501264;5817.88364232713;3371.157210697326;3399.6430374810784;3404.3191361727754;3406.1825161961447;3408.1309266137473;6368.904466433008;6547.770828020996;6554.115194448784;6561.0814485972005;6565;6414.583052101599;6442.162518872517;6446.097546343516;6454.32229615893;6455.160829092282;6530.477561795045;6538.771143010067;6541.574797638138;6544.181977252748;6551.21385433751;6237.532185086227;6263.6241825490615;6264.655443950626;6267.623942563278;6274.686265686606;6056.848578785565;6179.443850053517;6204.844878878064;6209.751609935552;6223.564350495421;6448.871022579616;6485.416312531895;6486.4486518646445;6486.837829054311;6550.279469258282;4272.700910936204;4529.116822219636;4539.72761634303;4540.818367265272;4542.727436353829;6303.275123360689;6460.806175814733;6464.709088090953;6480;6480.481561475165;6264;6267.341929097379;6272;6273.654948977667;6283.120363149254;6235.657038862906;6273.65494897785;6276.529260305587;6278.246610406781;6285.2457705075685;6115.082737589397;6145.893739127;6153.13856060143;6162.691865406801;6164.8767024658355;6105.45050945417;6288.213973253343;6295.622262664255;6305.4009869062365;6314.305426403;6138.785142519991;6147.815565533041;6151.538634602333;6153.2000839890525;6157.415045570664 17:30:18 INFO - PROCESS | 7316 | |5;yui.html;726.6148941061238;749.295662077647;752.920943300953;763.1605234242334;770.5684816502762;13694.383752731126;13860.099093558913;13979;14017.36921838517;14036.087654302475;12949.964002879771;12969.805452918214;12977.870221297784;12989.610311690642;13016.804747928789;667.1527160506155;792.813688783137;807.4549678966704;808.8422757562278;828.349745449822;804.903411590607;810.8216192437654;811.817341098254;812.3379445751723;814.7515007922581;851.5614458553849;857.7169534053778;861.2378045429778;863.365426411587;866.6923242249005;703.103542982696;826.3678286111129;834.3992325525642;837.5226121110969;838.4214891724752;618.5917294585552;619.464163498575;619.8667286533417;619.8853212155766;621.0156901311382;13176.341182940814;13678.863211367958;13798.724025519534;13806.93096534511;13814.963877709111;13009.54466593674;13428.530001449903;13513.189208647414;13541.568602191057;13896.652583685387;9756.365836220693;10080.445575493344;11704.707382315424;11864.22882512634;11981.161318707695;3608.368535506302;3673.963260367389;3690.2619476104887;3690.704743620504;3762.7930463824478;47518;49837;49985.00029999416;50080.49919500795;50085.74957125227;10029;10480.633177838892;10664.733381665365;10778.784424311627;10836.674899752863;18998.525036874187;19171.712424313646;19184.61630767377;19202.90398548026;19211.711824322647;7585.355244804143;7714.961425192838;7880.960595196987;7968.7609371718945;8078.515289082557;4240.703150779477;4424.867253982321;4427.335899615084;4430.889227769267;4597.218472859622;3153.684631536874;3181.7772755907326;3181.9363612727616;3184.8726050957703;3208.679132086773;542.1488263426382;560.5011539729644;563.2818156849967;574.1531241418958;575.3929604267538;502.73606356663043;567.3078843810545;633.2243002322118;637.200313606421;645.1161908185816;8261.586920653943;8460.411137956946;8540.487570745776;8607.870881936777;8869.512176830207;647.6535053746223;651.6090345792582;678.9796306110825;693.9479539034593;695.290803380549;3900.6294402031763;3902.434147048662;4031.254217969685;4309.07354918694;4486.371907932892;48880.511194888306;49188.50811491911;49506;49736.25395619069;49840.50159498359;48384.03231935341;48551;48777.51222487801;48937;49228.753856231204;42482.57517424848;43375.34936975948;43394.78302608467;43885.78057109758;44358.55641443673;8731.476111433334;8983.640654373752;8988.775280618036;9005.279577633642;9081.228095611947;32875.342493149525;33349.49975750414;33885.66114338825;33921.830390847885;34161.14597135092;41568;43123.353149703406;43128.35307470328;43219.56780432155;43442.56557434511;10968.451577420938;11014.229003969966;11225.550977960791;11368.886311137114;11503.76992460163;11923.403829808649;12080.577179798665;12170.208936419105;12175.878241217828;12361.320127393079;11525.308481491138;11630.592929247436;11808.291502509877;12078.33569153705;12147.145420825922;11436.485358159069;11483.942580287045;11573.942130289295;11752.823707644564;11956.46195921203;10835.241533092609;10998.780024399628;11041.116710662967;11046.33721976684;11458.656240312805;9733.270004749813;9825.754356141153;10041.246906481896;10131.341462804894;10293.639722609672;9449.196818270524;9480.288978326515;9999.008821488807;10045.625709788828;10251.486099218397 17:30:18 INFO - PROCESS | 7316 | __end_tp_report 17:30:18 INFO - PROCESS | 7316 | __start_cc_report 17:30:18 INFO - PROCESS | 7316 | _x_x_mozilla_cycle_collect,841 17:30:18 INFO - PROCESS | 7316 | __end_cc_report 17:30:18 INFO - PROCESS | 7316 | __startTimestamp1456277418207__endTimestamp 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | ------- Summary: start ------- 17:30:18 INFO - PROCESS | 7316 | Number of tests: 6 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#0] dojo.html Cycles:165 Average:4993.32 Median:5167.79 stddev:520.98 (10.1%) stddev-sans-first:500.38 17:30:18 INFO - PROCESS | 7316 | Values: 3075.7 3112.4 3141.4 3146.5 3181.6 4923.3 4983.4 5003.0 5042.4 5055.8 5031.1 5054.2 5060.0 5078.9 5082.4 4544.6 4577.0 4624.6 4666.2 4684.3 4485.7 4516.7 4641.6 4648.6 4757.8 4563.6 4576.3 4608.4 4625.6 4634.1 4581.0 4593.7 4597.4 4600.4 4643.8 4521.4 4566.1 4600.8 4619.8 4647.0 4816.3 4842.1 4844.4 4854.1 4872.5 5199.1 5338.2 5349.1 5353.9 5357.9 5243.1 5264.6 5269.6 5274.3 5292.6 5040.4 5073.8 5074.4 5077.5 5079.2 5390.8 5490.6 5518.9 5523.3 5617.6 5267.7 5278.5 5288.3 5292.3 5298.6 5363.2 5378.2 5383.2 5392.1 5439.8 5281.6 5296.6 5316.5 5352.6 5410.7 5324.9 5368.7 5387.0 5390.9 5425.9 4123.8 4220.3 4224.2 4225.2 4234.5 3792.3 3793.7 3796.0 3808.0 3817.2 5052.6 5053.5 5057.7 5059.4 5070.4 5236.6 5246.1 5300.1 5320.2 5366.0 4896.9 4972.8 4972.9 4986.5 5019.3 4588.6 4589.4 4590.1 4602.8 4637.5 5484.8 5600.8 5613.0 5639.1 5731.0 5329.1 5352.5 5359.7 5369.3 5370.6 5393.5 5610.8 5622.2 5627.2 5670.3 5268.0 5288.3 5290.4 5294.6 5324.0 5336.9 5348.1 5380.7 5383.0 5420.9 5012.5 5191.9 5192.5 5251.4 5254.4 5190.0 5215.4 5220.7 5221.6 5269.7 5009.4 5161.0 5164.3 5164.9 5167.8 5240.9 5247.9 5264.0 5273.9 5382.7 5091.9 5154.9 5197.1 5226.3 5274.0 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#1] ext.html Cycles:180 Average:44659.39 Median:37407.44 stddev:74463.71 (199.1%) stddev-sans-first:74598.82 17:30:18 INFO - PROCESS | 7316 | Values: 512.1 515.9 517.5 520.6 536.9 28780.9 37223.4 37394.3 37420.6 37519.1 40602.8 41593.0 41634.0 41645.4 41784.8 8510.9 8732.1 8740.4 8759.1 8761.5 8564.9 8700.8 8706.6 8709.8 8916.4 8728.9 8938.8 8985.8 8986.1 8991.1 8861.2 8861.5 8932.2 8938.0 8946.9 8773.9 8858.8 8884.1 8897.9 8898.9 40551.8 40907.2 41125.8 41268.2 41300.4 3234.6 3354.9 3356.7 3406.8 3750.6 30549.0 30670.5 30805.8 31525.4 32345.4 3929.1 3948.9 3996.4 4047.6 4149.0 260726.0 262646.0 262879.0 263016.0 263476.0 42155.0 42766.1 42833.0 42910.4 42914.0 40537.8 40699.0 40809.6 40835.6 40853.2 14980.4 15141.8 15178.5 15180.6 15189.2 11298.2 11324.5 11379.4 11395.9 11498.1 14300.3 14313.8 14334.9 14366.8 14420.3 5693.9 5804.8 5847.5 5880.9 5925.9 1016.2 1031.8 1132.4 1145.8 1167.3 28361.0 28683.6 28977.9 29171.2 31581.4 895.2 975.2 989.9 1003.8 1097.9 13432.0 13524.3 13712.7 13762.6 13807.2 295716.0 297390.0 300624.0 301939.0 303280.0 45919.3 46288.0 46296.0 46368.1 46396.4 1355.3 1369.4 1379.9 1380.5 1389.9 24579.5 32995.8 33117.3 33214.0 33338.3 49089.8 49239.8 49525.0 50016.0 50027.0 291172.0 292428.0 292661.0 293819.0 293906.0 32153.8 32445.0 32715.3 32814.8 32844.0 42830.0 43220.8 43918.8 43988.0 44090.1 37101.8 37536.2 39587.0 39796.6 40709.4 33830.8 34567.0 34689.1 34829.7 34885.5 35353.0 39047.8 39150.2 39910.0 40393.0 31438.2 33195.7 33298.7 33601.7 35772.0 24459.9 25464.5 25469.0 25572.0 25798.0 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#2] jquery.html Cycles:180 Average:25222.37 Median:4052.77 stddev:73530.57 (1814.3%) stddev-sans-first:73713.16 17:30:18 INFO - PROCESS | 7316 | Values: 368.9 370.1 372.5 378.0 378.3 13872.7 16655.9 17056.4 17347.6 18647.1 16244.1 16382.8 16536.9 16593.4 16617.3 5212.0 5415.6 5452.3 5452.7 5488.3 3988.8 5153.3 5741.5 5942.3 5960.0 5848.8 5887.8 5893.2 5917.5 5918.2 5176.1 5357.7 5359.8 5364.3 5865.9 5013.2 5119.7 5132.9 5133.4 5422.3 12570.0 12700.0 12742.0 12779.6 12867.9 2292.5 2413.9 2472.3 2579.5 2848.8 9318.4 9336.0 9456.9 9475.6 9597.8 1838.6 1855.4 1856.8 1909.5 1934.4 63107.0 65824.0 66593.3 67601.7 67675.0 9177.1 9382.6 9580.0 9605.9 9615.4 12348.1 12426.6 12437.0 12449.9 12455.9 7304.4 7441.7 7503.9 7586.9 7637.8 7546.6 7564.0 7604.2 7608.9 7668.7 4005.5 4011.1 4041.5 4045.2 4060.4 1673.2 1699.9 1750.5 1768.4 1817.5 874.3 912.9 980.7 1039.7 1042.9 15620.0 16000.0 16408.7 16491.0 16622.8 806.7 873.3 882.5 896.8 941.7 8818.2 8962.1 9080.8 9361.8 9433.3 439508.0 441129.0 442478.0 458768.0 460124.0 49059.0 70943.0 76433.9 77064.0 77193.6 1042.8 1045.6 1048.9 1072.1 1089.8 14443.2 14488.0 14580.9 14834.6 14957.6 32614.0 32701.0 33008.8 33568.2 33666.5 43648.3 46918.8 47219.5 47393.3 47506.8 7512.8 7660.5 7730.8 7873.3 7918.5 11069.6 12479.4 12639.0 12690.8 12821.1 11035.6 11050.6 11086.7 11126.9 11230.5 10183.9 10807.7 10854.5 10862.8 10959.5 7555.5 10074.9 10734.6 10735.8 10905.1 7554.4 7902.2 7948.9 8148.3 8197.0 10316.2 10469.8 10855.7 10935.6 10993.8 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#3] mootools.html Cycles:180 Average:5196.59 Median:6251.28 stddev:2662.12 (42.6%) stddev-sans-first:2653.86 17:30:18 INFO - PROCESS | 7316 | Values: 1347.0 1450.3 1466.3 1612.4 1775.4 7224.6 7381.1 7413.0 7420.5 7422.0 7394.5 7402.7 7463.0 7467.9 7472.9 1915.8 2187.8 2211.3 2212.4 2228.3 2250.7 2259.3 2261.6 2262.1 2264.8 2182.4 2231.4 2242.8 2247.6 2250.6 2194.7 2208.7 2223.8 2292.4 2292.5 2147.7 2150.8 2175.4 2176.6 2221.3 7289.2 7352.6 7368.6 7369.2 7374.4 4561.2 4657.6 4704.2 4705.0 4709.6 2952.3 3047.1 3096.1 3097.5 3104.0 1064.2 1069.7 1098.9 1104.3 1121.6 9791.5 9849.8 9852.0 9863.4 9871.9 3993.6 4030.7 4126.3 4150.3 4163.5 7980.5 8069.2 8104.8 8106.8 8124.7 3997.2 4592.0 4628.7 4645.8 4670.1 4151.4 4193.3 4208.0 4219.7 4223.9 3402.4 3403.9 3412.5 3437.6 3453.9 1013.9 1018.3 1028.7 1037.6 1071.6 1023.2 1031.4 1047.7 1178.6 1344.5 6892.2 6996.9 7049.0 7061.4 7072.6 485.6 490.6 502.1 505.1 506.0 5600.5 5629.7 5648.8 5700.9 5717.5 8454.9 8576.4 8616.4 8628.8 8870.1 8539.1 8544.6 8563.0 8642.0 8651.4 7025.1 7094.3 7148.4 7148.4 7172.6 7036.7 7069.3 7070.4 7078.2 7114.1 8087.1 8179.3 8316.4 8353.5 8385.1 8115.1 8376.3 8558.6 8566.1 8578.6 5901.4 6354.8 6524.1 6621.1 6682.5 7088.4 7097.1 7114.0 7132.0 7133.9 6388.8 6540.2 6564.9 6652.2 6656.9 6395.0 6452.4 6465.1 6468.7 6483.8 6811.5 6859.2 6872.3 6872.5 6878.9 6234.1 6236.4 6296.9 6330.7 6333.1 6169.3 6226.8 6246.8 6255.7 6256.2 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#4] prototype.html Cycles:180 Average:5199.25 Median:5828.79 stddev:1528.55 (26.2%) stddev-sans-first:1488.43 17:30:18 INFO - PROCESS | 7316 | Values: 326.0 341.4 341.6 345.9 348.1 5851.6 5895.5 5906.7 5908.0 5908.3 5828.3 5829.3 5830.7 5837.4 5837.9 4581.4 4582.0 4585.4 4588.9 4589.3 4596.5 4597.2 4606.8 4610.5 4610.5 4252.8 4253.9 4548.3 4564.1 4568.9 4509.7 4546.7 4552.7 4553.2 4555.6 4020.9 4026.7 4032.2 4034.7 4035.0 5352.5 5438.4 5511.1 5524.2 5578.7 5156.3 5167.2 5168.8 5172.7 5202.8 6243.8 6247.8 6248.1 6249.4 6249.6 4366.4 4377.0 4377.7 4378.1 4378.2 6176.3 6269.3 6425.2 6518.7 6575.9 4538.4 4557.7 4563.0 4565.4 4569.6 4619.5 4623.3 4627.4 4631.8 4634.5 5276.6 5282.2 5282.7 5284.5 5294.5 6257.8 6263.5 6268.5 6269.1 6271.0 1585.7 1606.1 1633.0 1634.2 1635.0 1098.3 1099.9 1115.4 1127.7 1134.6 5792.4 5811.1 5811.2 5812.4 5827.9 6280.1 6284.7 6290.6 6291.2 6297.8 5801.6 5807.3 5807.9 5816.6 5817.9 3371.2 3399.6 3404.3 3406.2 3408.1 6368.9 6547.8 6554.1 6561.1 6565.0 6414.6 6442.2 6446.1 6454.3 6455.2 6530.5 6538.8 6541.6 6544.2 6551.2 6237.5 6263.6 6264.7 6267.6 6274.7 6056.8 6179.4 6204.8 6209.8 6223.6 6448.9 6485.4 6486.4 6486.8 6550.3 4272.7 4529.1 4539.7 4540.8 4542.7 6303.3 6460.8 6464.7 6480.0 6480.5 6264.0 6267.3 6272.0 6273.7 6283.1 6235.7 6273.7 6276.5 6278.2 6285.2 6115.1 6145.9 6153.1 6162.7 6164.9 6105.5 6288.2 6295.6 6305.4 6314.3 6138.8 6147.8 6151.5 6153.2 6157.4 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - PROCESS | 7316 | [#5] yui.html Cycles:180 Average:13543.36 Median:43418.67 stddev:14964.81 (34.5%) stddev-sans-first:14975.83 17:30:18 INFO - PROCESS | 7316 | Values: 726.6 749.3 752.9 763.2 770.6 13694.4 13860.1 13979.0 14017.4 14036.1 12950.0 12969.8 12977.9 12989.6 13016.8 667.2 792.8 807.5 808.8 828.3 804.9 810.8 811.8 812.3 814.8 851.6 857.7 861.2 863.4 866.7 703.1 826.4 834.4 837.5 838.4 618.6 619.5 619.9 619.9 621.0 13176.3 13678.9 13798.7 13806.9 13815.0 13009.5 13428.5 13513.2 13541.6 13896.7 9756.4 10080.4 11704.7 11864.2 11981.2 3608.4 3674.0 3690.3 3690.7 3762.8 47518.0 49837.0 49985.0 50080.5 50085.7 10029.0 10480.6 10664.7 10778.8 10836.7 18998.5 19171.7 19184.6 19202.9 19211.7 7585.4 7715.0 7881.0 7968.8 8078.5 4240.7 4424.9 4427.3 4430.9 4597.2 3153.7 3181.8 3181.9 3184.9 3208.7 542.1 560.5 563.3 574.2 575.4 502.7 567.3 633.2 637.2 645.1 8261.6 8460.4 8540.5 8607.9 8869.5 647.7 651.6 679.0 693.9 695.3 3900.6 3902.4 4031.3 4309.1 4486.4 48880.5 49188.5 49506.0 49736.3 49840.5 48384.0 48551.0 48777.5 48937.0 49228.8 42482.6 43375.3 43394.8 43885.8 44358.6 8731.5 8983.6 8988.8 9005.3 9081.2 32875.3 33349.5 33885.7 33921.8 34161.1 41568.0 43123.4 43128.4 43219.6 43442.6 10968.5 11014.2 11225.6 11368.9 11503.8 11923.4 12080.6 12170.2 12175.9 12361.3 11525.3 11630.6 11808.3 12078.3 12147.1 11436.5 11483.9 11573.9 11752.8 11956.5 10835.2 10998.8 11041.1 11046.3 11458.7 9733.3 9825.8 10041.2 10131.3 10293.6 9449.2 9480.3 9999.0 10045.6 10251.5 17:30:18 INFO - PROCESS | 7316 | -------- Summary: end -------- 17:30:18 INFO - PROCESS | 7316 | 17:30:18 INFO - TEST-INFO | 7316: exit 0 17:30:18 INFO - TEST-OK | dromaeo_css | took 1112378ms 17:30:18 INFO - TEST-START | kraken 17:30:18 INFO - operating with platform_type : linux_ 17:30:18 INFO - Initialising browser for kraken test... 17:30:18 INFO - TEST-INFO | started process 7507 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3z6Srv/profile http://localhost:35170/getInfo.html) 17:30:23 INFO - PROCESS | 7507 | __metrics Screen width/height:1600/1200 17:30:23 INFO - PROCESS | 7507 | colorDepth:24 17:30:23 INFO - PROCESS | 7507 | Browser inner width/height: 1024/697 17:30:23 INFO - PROCESS | 7507 | __metrics 17:30:24 INFO - PROCESS | 7507 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:30:24 INFO - TEST-INFO | 7507: exit 0 17:30:24 INFO - Browser initialized. 17:30:24 INFO - Running cycle 1/1 for kraken test... 17:30:24 INFO - TEST-INFO | started process 7593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3z6Srv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:36 INFO - PROCESS | 7593 | RSS: Main: 148398080 17:30:36 INFO - PROCESS | 7593 | 17:30:39 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35170/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:39 INFO - PROCESS | 7593 | RSS: Main: 191590400 17:30:39 INFO - PROCESS | 7593 | 17:30:42 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35170/tests/kraken/driver.html?testName=audio-dft) 17:30:43 INFO - PROCESS | 7593 | RSS: Main: 181702656 17:30:43 INFO - PROCESS | 7593 | 17:30:46 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35170/tests/kraken/driver.html?testName=audio-fft) 17:30:46 INFO - PROCESS | 7593 | RSS: Main: 167313408 17:30:46 INFO - PROCESS | 7593 | 17:30:48 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35170/tests/kraken/driver.html?testName=audio-oscillator) 17:30:49 INFO - PROCESS | 7593 | RSS: Main: 168734720 17:30:49 INFO - PROCESS | 7593 | 17:30:51 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:30:51 INFO - PROCESS | 7593 | RSS: Main: 171356160 17:30:51 INFO - PROCESS | 7593 | 17:30:54 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35170/tests/kraken/driver.html?testName=imaging-darkroom) 17:30:55 INFO - PROCESS | 7593 | RSS: Main: 171556864 17:30:55 INFO - PROCESS | 7593 | 17:30:58 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35170/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:59 INFO - PROCESS | 7593 | RSS: Main: 170696704 17:30:59 INFO - PROCESS | 7593 | 17:31:02 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35170/tests/kraken/driver.html?testName=json-parse-financial) 17:31:02 INFO - PROCESS | 7593 | RSS: Main: 172355584 17:31:02 INFO - PROCESS | 7593 | 17:31:04 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:04 INFO - PROCESS | 7593 | RSS: Main: 183365632 17:31:04 INFO - PROCESS | 7593 | 17:31:06 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:07 INFO - PROCESS | 7593 | RSS: Main: 181325824 17:31:07 INFO - PROCESS | 7593 | 17:31:09 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:09 INFO - PROCESS | 7593 | RSS: Main: 190345216 17:31:09 INFO - PROCESS | 7593 | 17:31:12 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:12 INFO - PROCESS | 7593 | RSS: Main: 198729728 17:31:12 INFO - PROCESS | 7593 | 17:31:15 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:16 INFO - PROCESS | 7593 | RSS: Main: 200044544 17:31:16 INFO - PROCESS | 7593 | 17:31:17 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:35170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35170/tests/kraken/driver.html?testName=ai-astar) 17:31:18 INFO - PROCESS | 7593 | RSS: Main: 258469888 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | __start_tp_report 17:31:18 INFO - PROCESS | 7593 | _x_x_mozilla_page_load 17:31:18 INFO - PROCESS | 7593 | _x_x_mozilla_page_load_details 17:31:18 INFO - PROCESS | 7593 | |i|pagename|runs| 17:31:18 INFO - PROCESS | 7593 | |0;ai-astar;111;112;107;111;111;112;100;110;110;110 17:31:18 INFO - PROCESS | 7593 | |1;audio-beat-detection;152;124;163;176;126;159;149;134;168;124 17:31:18 INFO - PROCESS | 7593 | |2;audio-dft;162;171;163;163;162;161;161;164;163;161 17:31:18 INFO - PROCESS | 7593 | |3;audio-fft;73;73;116;99;74;74;73;117;96;76 17:31:18 INFO - PROCESS | 7593 | |4;audio-oscillator;96;95;151;94;96;97;150;95;96;139 17:31:18 INFO - PROCESS | 7593 | |5;imaging-gaussian-blur;120;116;116;115;115;115;115;115;115;115 17:31:18 INFO - PROCESS | 7593 | |6;imaging-darkroom;146;145;146;146;146;145;146;146;146;145 17:31:18 INFO - PROCESS | 7593 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;97;96 17:31:18 INFO - PROCESS | 7593 | |8;json-parse-financial;59;57;58;57;57;57;57;65;55;55 17:31:18 INFO - PROCESS | 7593 | |9;json-stringify-tinderbox;66;67;68;68;76;68;70;67;67;72 17:31:18 INFO - PROCESS | 7593 | |10;stanford-crypto-aes;80;90;82;82;82;83;83;83;84;83 17:31:18 INFO - PROCESS | 7593 | |11;stanford-crypto-ccm;119;116;119;114;117;126;120;118;123;117 17:31:18 INFO - PROCESS | 7593 | |12;stanford-crypto-pbkdf2;152;151;152;162;151;140;150;150;148;154 17:31:18 INFO - PROCESS | 7593 | |13;stanford-crypto-sha256-iterative;72;68;68;67;69;69;70;69;67;68 17:31:18 INFO - PROCESS | 7593 | __end_tp_report 17:31:18 INFO - PROCESS | 7593 | __start_cc_report 17:31:18 INFO - PROCESS | 7593 | _x_x_mozilla_cycle_collect,965 17:31:18 INFO - PROCESS | 7593 | __end_cc_report 17:31:18 INFO - PROCESS | 7593 | __startTimestamp1456277478047__endTimestamp 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | ------- Summary: start ------- 17:31:18 INFO - PROCESS | 7593 | Number of tests: 14 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.60 (3.2%) stddev-sans-first:3.77 17:31:18 INFO - PROCESS | 7593 | Values: 111.0 112.0 107.0 111.0 111.0 112.0 100.0 110.0 110.0 110.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.50 stddev:19.37 (12.5%) stddev-sans-first:20.48 17:31:18 INFO - PROCESS | 7593 | Values: 152.0 124.0 163.0 176.0 126.0 159.0 149.0 134.0 168.0 124.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.96 (1.8%) stddev-sans-first:3.11 17:31:18 INFO - PROCESS | 7593 | Values: 162.0 171.0 163.0 163.0 162.0 161.0 161.0 164.0 163.0 161.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#3] audio-fft Cycles:10 Average:87.10 Median:74.00 stddev:18.30 (24.7%) stddev-sans-first:18.68 17:31:18 INFO - PROCESS | 7593 | Values: 73.0 73.0 116.0 99.0 74.0 74.0 73.0 117.0 96.0 76.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:95.50 stddev:24.89 (26.1%) stddev-sans-first:25.81 17:31:18 INFO - PROCESS | 7593 | Values: 96.0 95.0 151.0 94.0 96.0 97.0 150.0 95.0 96.0 139.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:1.57 (1.4%) stddev-sans-first:0.44 17:31:18 INFO - PROCESS | 7593 | Values: 120.0 116.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:31:18 INFO - PROCESS | 7593 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:31:18 INFO - PROCESS | 7593 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:2.83 (5.0%) stddev-sans-first:2.96 17:31:18 INFO - PROCESS | 7593 | Values: 59.0 57.0 58.0 57.0 57.0 57.0 57.0 65.0 55.0 55.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:3.03 (4.5%) stddev-sans-first:3.03 17:31:18 INFO - PROCESS | 7593 | Values: 66.0 67.0 68.0 68.0 76.0 68.0 70.0 67.0 67.0 72.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.62 (3.2%) stddev-sans-first:2.51 17:31:18 INFO - PROCESS | 7593 | Values: 80.0 90.0 82.0 82.0 82.0 83.0 83.0 83.0 84.0 83.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:119.00 stddev:3.48 (2.9%) stddev-sans-first:3.69 17:31:18 INFO - PROCESS | 7593 | Values: 119.0 116.0 119.0 114.0 117.0 126.0 120.0 118.0 123.0 117.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.50 stddev:5.42 (3.6%) stddev-sans-first:5.73 17:31:18 INFO - PROCESS | 7593 | Values: 152.0 151.0 152.0 162.0 151.0 140.0 150.0 150.0 148.0 154.0 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - PROCESS | 7593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.00 17:31:18 INFO - PROCESS | 7593 | Values: 72.0 68.0 68.0 67.0 69.0 69.0 70.0 69.0 67.0 68.0 17:31:18 INFO - PROCESS | 7593 | -------- Summary: end -------- 17:31:18 INFO - PROCESS | 7593 | 17:31:18 INFO - TEST-INFO | 7593: exit 0 17:31:18 INFO - TEST-OK | kraken | took 60157ms 17:31:18 INFO - SUITE-END | took 1172s 17:31:19 INFO - Completed test suite (00:19:32) 17:31:19 INFO - Working with test: dromaeo_css 17:31:19 INFO - Generating results file: dromaeo_css 17:31:19 INFO - Working with test: kraken 17:31:19 INFO - Generating results file: kraken 17:31:19 INFO - javascript benchmark 17:31:19 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:31:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:31:19 INFO - process_Request line: dromaeo_css 6712.11 graph.html#tests=[[72,64,35]] 17:31:19 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:31:19 INFO - process_Request line: kraken 1524.00 graph.html#tests=[[232,64,35]] 17:31:19 INFO - RETURN: dromaeo_css: 6712.11 17:31:19 INFO - RETURN: kraken: 1524.00 17:31:19 INFO - javascript benchmark 17:31:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3075.7231849133573, 3112.393083348745, 3141.3874294512566, 3146.5122905949584, 3181.5545823584703, 4923.261510773385, 4983.4269059058215, 5002.9749851250735, 5042.420121686003, 5055.848324550265, 5031.144705400082, 5054.1913293872985, 5060.0385926674, 5078.898422031557, 5082.364704411949, 4544.636429085665, 4576.97711511442, 4624.606908412772, 4666.183417901871, 4684.254980871473, 4485.686001979862, 4516.706414083074, 4641.628669706432, 4648.604868586174, 4757.762111894409, 4563.566461186182, 4576.313552967048, 4608.423947006608, 4625.560571745679, 4634.050019745944, 4581.037982023779, 4593.678442509025, 4597.448306203277, 4600.378948841931, 4643.8142474300985, 4521.434820647419, 4566.10960862632, 4600.769961501945, 4619.8152073917, 4647.047355292157, 4816.325714399987, 4842.104210721028, 4844.442889067767, 4854.12625727369, 4872.4640289568115, 5199.14214154664, 5338.199270109476, 5349.14413693811, 5353.9196912046355, 5357.919631205535, 5243.10867152585, 5264.605154613381, 5269.55208807248, 5274.314339135926, 5292.550133238641, 5040.42035165957, 5073.797048118071, 5074.441811400743, 5077.543021128116, 5079.238114282887, 5390.838274851761, 5490.56075513958, 5518.889622207534, 5523.337199536081, 5617.578681598897, 5267.736613169326, 5278.524932755993, 5288.2596436498925, 5292.285541451854, 5298.576113910878, 5363.222332761806, 5378.1932710093015, 5383.16560933056, 5392.137258038695, 5439.809606663748, 5281.630285880028, 5296.576273898079, 5316.521513063843, 5352.6253162279045, 5410.729463526808, 5324.893502129936, 5368.651037682538, 5386.973065134727, 5390.865228369244, 5425.9186112208345, 4123.793810309473, 4220.324748040299, 4224.218519573888, 4225.176090662291, 4234.470691163605, 3792.3363411402893, 3793.7344385893275, 3796.032011836964, 3807.952812976398, 3817.179306449071, 5052.646314758005, 5053.545180933734, 5057.69653820772, 5059.367579052619, 5070.366204224472, 5236.607254455931, 5246.081935661244, 5300.072487314705, 5320.201969704575, 5365.980463711882, 4896.853094407174, 4972.825951091694, 4972.925406118911, 4986.476419975923, 5019.322391477177, 4588.587027167571, 4589.380433641482, 4590.059037897223, 4602.815887364535, 4637.489876113625, 5484.808031718871, 5600.775968961278, 5612.961602103624, 5639.069553523623, 5731.0, 5329.067413202596, 5352.4915133062295, 5359.705216212989, 5369.27514785499, 5370.62405631602, 5393.51458368733, 5610.7755689773585, 5622.24099746529, 5627.21219029328, 5670.262865827416, 5268.025415298182, 5288.259643649815, 5290.418054013979, 5294.629375943647, 5323.973380133075, 5336.866578335573, 5348.064088784525, 5380.677159370451, 5383.0, 5420.891582168256, 5012.498750124958, 5191.870203244949, 5192.45479224676, 5251.369835619597, 5254.422013578427, 5189.974050129726, 5215.400228973716, 5220.686758794484, 5221.582273418041, 5269.71016594091, 5009.448960614257, 5160.974195129001, 5164.302819119521, 5164.870878228075, 5167.793288268577, 5240.868978275574, 5247.89504209906, 5263.973680131575, 5273.8681532960445, 5382.650127741685, 5091.949080509147, 5154.8969020620125, 5197.0905091609575, 5226.320578324793, 5273.971575542732], "unit": "score", "name": "dojo.html", "value": 4962.155213804553}, {"lowerIsBetter": false, "replicates": [512.0705918757455, 515.9045576568333, 517.4592550784431, 520.5705293133163, 536.8672101865067, 28780.85609571952, 37223.441648375265, 37394.252114957686, 37420.62579374209, 37519.06202344936, 40602.7969860151, 41593.0, 41634.0, 41645.375319370236, 41784.791076044654, 8510.914890851089, 8732.12678732128, 8740.388172827905, 8759.124087591254, 8761.51811650359, 8564.929383827022, 8700.782480437976, 8706.608202630865, 8709.825803483958, 8916.375853690244, 8728.869066964, 8938.821223575525, 8985.775355616097, 8986.14631609996, 8991.055939126396, 8861.158189971942, 8861.468311901242, 8932.196102350787, 8937.955310223408, 8946.86579701305, 8773.868391974125, 8858.778530536723, 8884.067172946812, 8897.911020889838, 8898.911010889939, 40551.797241013905, 40907.18185636271, 41125.79437102795, 41268.1746365074, 41300.38049429261, 3234.579504664402, 3354.899353019389, 3356.7314614831, 3406.829658517064, 3750.587435382106, 30549.0, 30670.53994190089, 30805.845970770228, 31525.369492610247, 32345.35309293801, 3929.0819567979647, 3948.9012774680577, 3996.3805610130476, 4047.5750046245307, 4149.0, 260726.0, 262646.0, 262879.0, 263016.0, 263476.0, 42155.0, 42766.14467710691, 42833.0, 42910.35634465423, 42914.0, 40537.79731101385, 40699.0, 40809.59190408058, 40835.591644083775, 40853.18293634111, 14980.400783968737, 15141.772873406908, 15178.468753593572, 15180.620484487976, 15189.240537973057, 11298.209125361145, 11324.490397932113, 11379.43102844871, 11395.943020284845, 11498.080153587693, 14300.284985750879, 14313.78529322061, 14334.856651433352, 14366.784498232535, 14420.278986050656, 5693.914591281134, 5804.825855224266, 5847.502962248256, 5880.852978675567, 5925.911111333334, 1016.1768967136643, 1031.7781676939494, 1132.4111462039857, 1145.8109411946934, 1167.3229526874393, 28361.0, 28683.56974645382, 28977.85511072431, 29171.249725016565, 31581.368372632878, 895.230102112183, 975.2441857560306, 989.8663680403054, 1003.7641154328727, 1097.8517900083386, 13432.0, 13524.32378381077, 13712.725745485035, 13762.587122386345, 13807.240601767, 295716.0, 297390.0, 300624.0, 301939.0, 303280.0, 45919.31121033187, 46288.0, 46296.0, 46368.07263854704, 46396.376126836076, 1355.329112089522, 1369.3906211735882, 1379.889608831291, 1380.5168191133023, 1389.8818600419077, 24579.508409832062, 32995.83502082474, 33117.337653246315, 33214.0, 33338.33323333568, 49089.754551227015, 49239.7538012322, 49525.0, 50016.0, 50027.0, 291172.0, 292428.0, 292661.0, 293819.0, 293906.0, 32153.839230803696, 32445.0, 32715.34569308553, 32814.83592582117, 32844.0, 42830.0, 43220.78389608032, 43918.780406097765, 43988.0, 44090.11819763522, 37101.805747195955, 37536.249275014896, 39587.0, 39796.602033980445, 40709.38935916023, 33830.830845845616, 34567.0, 34689.13277168091, 34829.65170348366, 34885.47671784976, 35353.0, 39047.80476097601, 39150.2169956605, 39910.0, 40393.0, 31438.214044649067, 33195.66804331926, 33298.667013329556, 33601.66398335985, 35772.0, 24459.87770061138, 25464.49071018532, 25469.0, 25572.0, 25798.0], "unit": "score", "name": "ext.html", "value": 17849.33244356286}, {"lowerIsBetter": false, "replicates": [368.91146124930026, 370.11911650272356, 372.48224967295465, 377.9792111433872, 378.341685467287, 13872.722545549082, 16655.916720416397, 17056.403025894095, 17347.566310842234, 18647.06764661768, 16244.106574138417, 16382.75425868613, 16536.917315413437, 16593.41923032694, 16617.335306587724, 5212.0, 5415.620906536544, 5452.291202143716, 5452.700101494416, 5488.313960754906, 3988.8404463821557, 5153.2785410042625, 5741.45456181662, 5942.286925568917, 5960.0, 5848.766049358021, 5887.793927212549, 5893.174955506232, 5917.526597872182, 5918.201042859202, 5176.145935920568, 5357.705326207096, 5359.758810853501, 5364.275822763916, 5865.8826823463505, 5013.248012798073, 5119.692818430906, 5132.923006154911, 5133.435322114565, 5422.349318081816, 12570.0, 12700.0, 12742.0, 12779.552715655, 12867.871321286855, 2292.5071109711325, 2413.879306034691, 2472.295395812203, 2579.5356835769553, 2848.8148270362362, 9318.440893546409, 9336.0, 9456.905430945671, 9475.620975160986, 9597.808043839153, 1838.6322735452964, 1855.434092601756, 1856.8087964575407, 1909.5417099896065, 1934.4003358958769, 63107.0, 65824.0, 66593.33406665968, 67601.66199169021, 67675.0, 9177.128172823572, 9382.624695012122, 9579.952100239594, 9605.903940960501, 9615.375000624937, 12348.073894457952, 12426.62720118398, 12437.0, 12449.875501245053, 12455.875441245471, 7304.379127774198, 7441.702331906663, 7503.924960750432, 7586.886196707053, 7637.847243055107, 7546.622668866535, 7563.978862853554, 7604.239576042462, 7608.923910760932, 7668.65798485274, 4005.5193376794973, 4011.097503061846, 4041.535223449282, 4045.1505183911117, 4060.39094135882, 1673.1968655045403, 1699.8980061196369, 1750.492357216393, 1768.4429404737466, 1817.5456135966008, 874.2699845628844, 912.9087091290951, 980.7008862297068, 1039.6621098143135, 1042.9478526073817, 15620.0, 16000.0, 16408.6718265634, 16491.0, 16622.75065874013, 806.7418426103591, 873.2620935309653, 882.4793371910475, 896.7713233125511, 941.6610020392653, 8818.206361427503, 8962.14859588338, 9080.828363352928, 9361.812763744687, 9433.292503062297, 439508.0, 441129.0, 442478.0, 458768.0, 460124.0, 49059.0, 70943.0, 76433.88528917673, 77064.0, 77193.61403192948, 1042.7758032023, 1045.6183493025144, 1048.9475526223657, 1072.099436473366, 1089.803835309636, 14443.205623690797, 14488.041331710985, 14580.92709536488, 14834.62913427173, 14957.551273461813, 32614.0, 32701.0, 33008.83495582507, 33568.16079598029, 33666.49500257449, 43648.34527482027, 46918.76540617275, 47219.52780472151, 47393.28910066283, 47506.76246618745, 7512.774616761506, 7660.5403675779635, 7730.84469587563, 7873.25204105609, 7918.485298455582, 11069.5572177112, 12479.438425271066, 12639.0, 12690.809637855624, 12821.102522823687, 11035.558577656804, 11050.613228536962, 11086.667399978014, 11126.888731112585, 11230.494627741607, 10183.898161018295, 10807.72980675458, 10854.457277135954, 10862.782744345226, 10959.452027398438, 7555.526672298849, 10074.94962525212, 10734.570617175226, 10735.838962415413, 10905.073068789241, 7554.357879580297, 7902.170272121574, 7948.8807667886185, 8148.266656000988, 8197.0, 10316.226283028653, 10469.842952355873, 10855.728606784893, 10935.617253396093, 10993.780124397626], "unit": "score", "name": "jquery.html", "value": 8205.971915142896}, {"lowerIsBetter": false, "replicates": [1347.016677825187, 1450.282110355374, 1466.2595389328387, 1612.435647523367, 1775.4318618042223, 7224.6026468544205, 7381.077365329334, 7413.0, 7420.4805663603565, 7421.960925470425, 7394.5193562418535, 7402.740904068359, 7463.0, 7467.850642987137, 7472.887906681404, 1915.7605299337583, 2187.8140358069545, 2211.281333566589, 2212.3694746997107, 2228.264672658027, 2250.696156018933, 2259.344790010895, 2261.604219261631, 2262.072550254396, 2264.750877403484, 2182.443476913385, 2231.4421394651336, 2242.7532971373134, 2247.550489902026, 2250.6173950428465, 2194.7476040255337, 2208.6907832903325, 2223.755386907447, 2292.426893276681, 2292.4612716011725, 2147.6563749799957, 2150.838687098458, 2175.445261458334, 2176.5538064696857, 2221.2669818959703, 7289.198188199294, 7352.595607241599, 7368.594727289997, 7369.22623124575, 7374.410047196211, 4561.1789877821975, 4657.580817726421, 4704.200285951397, 4704.976475117637, 4709.599684026827, 2952.2914500519937, 3047.1467988963127, 3096.14855914623, 3097.519884417919, 3104.0, 1064.2231171245035, 1069.7379142110155, 1098.9285696429706, 1104.3318792130806, 1121.62600814003, 9791.510424478747, 9849.803003939953, 9851.950740246253, 9863.408195508293, 9871.90128098717, 3993.600639935983, 4030.717849750548, 4126.298529250034, 4150.335946248586, 4163.542010378856, 7980.521168729895, 8069.233422824822, 8104.756857294291, 8106.797330066795, 8124.715634952749, 3997.2405243003736, 4591.95408045922, 4628.699134556243, 4645.767711614406, 4670.065986802653, 4151.418801367811, 4193.287141186006, 4207.957920420757, 4219.683523735732, 4223.873283801491, 3402.4045791986305, 3403.9489407658907, 3412.5051867479574, 3437.553118094682, 3453.8791142309897, 1013.9036791504795, 1018.3126389686931, 1028.7222449938624, 1037.5538518437145, 1071.6356438810685, 1023.2376879225025, 1031.4327120083924, 1047.7223535763028, 1178.587494376961, 1344.5025340624031, 6892.207396149407, 6996.930030699627, 7049.0, 7061.364477197077, 7072.646367681596, 485.60665860652983, 490.60506292434934, 502.12880652068634, 505.1160469178937, 505.99241011384856, 5600.523955463831, 5629.7185140742795, 5648.802291919846, 5700.9429905701245, 5717.456841600041, 8454.915450845412, 8576.44253123545, 8616.439931404439, 8628.784280392914, 8870.112988701207, 8539.06070332263, 8544.572771361407, 8563.0, 8641.962964444307, 8651.351148663749, 7025.051618031501, 7094.290570942968, 7148.356647901818, 7148.428125749928, 7172.641367931687, 7036.683349249399, 7069.257727938492, 7070.36366726997, 7078.221395646372, 7114.075170227838, 8087.110417854149, 8179.345652347917, 8316.37627177952, 8353.457025293337, 8385.077641459313, 8115.066767321598, 8376.32989360862, 8558.57207139628, 8566.057733649419, 8578.613962371834, 5901.409859014064, 6354.809355719336, 6524.119243902012, 6621.1392518972225, 6682.532222744361, 7088.397486213524, 7097.112860892388, 7114.0, 7132.0, 7133.892991605234, 6388.75419293252, 6540.215174179129, 6564.934350656432, 6652.168478940132, 6656.866862662817, 6395.0, 6452.35476452351, 6465.0948867157695, 6468.676566171578, 6483.805485835433, 6811.523193376416, 6859.211190713132, 6872.278410766998, 6872.450203983769, 6878.8624227514165, 6234.064890266315, 6236.438720515175, 6296.874062518816, 6330.746770129143, 6333.145025421509, 6169.321374648695, 6226.782062627786, 6246.843828904313, 6255.718492667932, 6256.249250090018], "unit": "score", "name": "mootools.html", "value": 4223.449216912311}, {"lowerIsBetter": false, "replicates": [325.9934801303974, 341.3582464965864, 341.60032761668845, 345.86338396333457, 348.05503059194285, 5851.561132915032, 5895.528357731377, 5906.734196961136, 5908.0, 5908.320543137541, 5828.300603927524, 5829.271341082364, 5830.708464576775, 5837.445442682949, 5837.941620583793, 4581.358609794632, 4582.0, 4585.449746030481, 4588.885277868063, 4589.265717485203, 4596.471405788327, 4597.172508948388, 4606.815727370901, 4610.492845786961, 4610.538946105379, 4252.766097864632, 4253.8723838284905, 4548.340490628857, 4564.132814765184, 4568.885777855547, 4509.729416235036, 4546.659000574954, 4552.704074235164, 4553.225951588205, 4555.635549156076, 4020.8793736187963, 4026.71812973092, 4032.1734044520804, 4034.677225821927, 4034.979825100885, 5352.518273355417, 5438.401775804658, 5511.118221084607, 5524.1989911463015, 5578.693171875545, 5156.278121063054, 5167.224916262553, 5168.844934651929, 5172.715500647463, 5202.817901373472, 6243.75024999004, 6247.843803904893, 6248.062790581449, 6249.375062493714, 6249.625022498664, 4366.366876802877, 4376.978115109404, 4377.6935614507, 4378.058717375748, 4378.190034843564, 6176.258848938156, 6269.279032911182, 6425.1647285853005, 6518.706658200345, 6575.93424065758, 4538.432695913011, 4557.680962332671, 4563.018950925501, 4565.429321334833, 4569.634429245652, 4619.491855895849, 4623.306504024423, 4627.444706635158, 4631.814727410933, 4634.513376095461, 5276.604254680914, 5282.207668849704, 5282.656627319212, 5284.497972692588, 5294.470552944752, 6257.843553911098, 6263.467605253513, 6268.529860260499, 6269.0909818076125, 6271.0, 1585.7462805951222, 1606.1407147176205, 1633.0446688687014, 1634.2319110018273, 1634.9754753678703, 1098.3464838421287, 1099.8570185875785, 1115.3865374044244, 1127.7406196574834, 1134.6142311614092, 5792.420757924174, 5811.099279611667, 5811.186433899257, 5812.38969908162, 5827.88344233113, 6280.089387038854, 6284.717187726472, 6290.559660823698, 6291.182146320949, 6297.779577714758, 5801.622894511843, 5807.274090738658, 5807.883842323215, 5816.592838501264, 5817.88364232713, 3371.157210697326, 3399.6430374810784, 3404.3191361727754, 3406.1825161961447, 3408.1309266137473, 6368.904466433008, 6547.770828020996, 6554.115194448784, 6561.0814485972005, 6565.0, 6414.583052101599, 6442.162518872517, 6446.097546343516, 6454.32229615893, 6455.160829092282, 6530.477561795045, 6538.771143010067, 6541.574797638138, 6544.181977252748, 6551.21385433751, 6237.532185086227, 6263.6241825490615, 6264.655443950626, 6267.623942563278, 6274.686265686606, 6056.848578785565, 6179.443850053517, 6204.844878878064, 6209.751609935552, 6223.564350495421, 6448.871022579616, 6485.416312531895, 6486.4486518646445, 6486.837829054311, 6550.279469258282, 4272.700910936204, 4529.116822219636, 4539.72761634303, 4540.818367265272, 4542.727436353829, 6303.275123360689, 6460.806175814733, 6464.709088090953, 6480.0, 6480.481561475165, 6264.0, 6267.341929097379, 6272.0, 6273.654948977667, 6283.120363149254, 6235.657038862906, 6273.65494897785, 6276.529260305587, 6278.246610406781, 6285.2457705075685, 6115.082737589397, 6145.893739127, 6153.13856060143, 6162.691865406801, 6164.8767024658355, 6105.45050945417, 6288.213973253343, 6295.622262664255, 6305.4009869062365, 6314.305426403, 6138.785142519991, 6147.815565533041, 6151.538634602333, 6153.2000839890525, 6157.415045570664], "unit": "score", "name": "prototype.html", "value": 4709.238836000578}, {"lowerIsBetter": false, "replicates": [726.6148941061238, 749.295662077647, 752.920943300953, 763.1605234242334, 770.5684816502762, 13694.383752731126, 13860.099093558913, 13979.0, 14017.36921838517, 14036.087654302475, 12949.964002879771, 12969.805452918214, 12977.870221297784, 12989.610311690642, 13016.804747928789, 667.1527160506155, 792.813688783137, 807.4549678966704, 808.8422757562278, 828.349745449822, 804.903411590607, 810.8216192437654, 811.817341098254, 812.3379445751723, 814.7515007922581, 851.5614458553849, 857.7169534053778, 861.2378045429778, 863.365426411587, 866.6923242249005, 703.103542982696, 826.3678286111129, 834.3992325525642, 837.5226121110969, 838.4214891724752, 618.5917294585552, 619.464163498575, 619.8667286533417, 619.8853212155766, 621.0156901311382, 13176.341182940814, 13678.863211367958, 13798.724025519534, 13806.93096534511, 13814.963877709111, 13009.54466593674, 13428.530001449903, 13513.189208647414, 13541.568602191057, 13896.652583685387, 9756.365836220693, 10080.445575493344, 11704.707382315424, 11864.22882512634, 11981.161318707695, 3608.368535506302, 3673.963260367389, 3690.2619476104887, 3690.704743620504, 3762.7930463824478, 47518.0, 49837.0, 49985.00029999416, 50080.49919500795, 50085.74957125227, 10029.0, 10480.633177838892, 10664.733381665365, 10778.784424311627, 10836.674899752863, 18998.525036874187, 19171.712424313646, 19184.61630767377, 19202.90398548026, 19211.711824322647, 7585.355244804143, 7714.961425192838, 7880.960595196987, 7968.7609371718945, 8078.515289082557, 4240.703150779477, 4424.867253982321, 4427.335899615084, 4430.889227769267, 4597.218472859622, 3153.684631536874, 3181.7772755907326, 3181.9363612727616, 3184.8726050957703, 3208.679132086773, 542.1488263426382, 560.5011539729644, 563.2818156849967, 574.1531241418958, 575.3929604267538, 502.73606356663043, 567.3078843810545, 633.2243002322118, 637.200313606421, 645.1161908185816, 8261.586920653943, 8460.411137956946, 8540.487570745776, 8607.870881936777, 8869.512176830207, 647.6535053746223, 651.6090345792582, 678.9796306110825, 693.9479539034593, 695.290803380549, 3900.6294402031763, 3902.434147048662, 4031.254217969685, 4309.07354918694, 4486.371907932892, 48880.511194888306, 49188.50811491911, 49506.0, 49736.25395619069, 49840.50159498359, 48384.03231935341, 48551.0, 48777.51222487801, 48937.0, 49228.753856231204, 42482.57517424848, 43375.34936975948, 43394.78302608467, 43885.78057109758, 44358.55641443673, 8731.476111433334, 8983.640654373752, 8988.775280618036, 9005.279577633642, 9081.228095611947, 32875.342493149525, 33349.49975750414, 33885.66114338825, 33921.830390847885, 34161.14597135092, 41568.0, 43123.353149703406, 43128.35307470328, 43219.56780432155, 43442.56557434511, 10968.451577420938, 11014.229003969966, 11225.550977960791, 11368.886311137114, 11503.76992460163, 11923.403829808649, 12080.577179798665, 12170.208936419105, 12175.878241217828, 12361.320127393079, 11525.308481491138, 11630.592929247436, 11808.291502509877, 12078.33569153705, 12147.145420825922, 11436.485358159069, 11483.942580287045, 11573.942130289295, 11752.823707644564, 11956.46195921203, 10835.241533092609, 10998.780024399628, 11041.116710662967, 11046.33721976684, 11458.656240312805, 9733.270004749813, 9825.754356141153, 10041.246906481896, 10131.341462804894, 10293.639722609672, 9449.196818270524, 9480.288978326515, 9999.008821488807, 10045.625709788828, 10251.486099218397], "unit": "score", "name": "yui.html", "value": 6325.172909801344}], "name": "dromaeo_css", "value": 6712.106426136595}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 111.0, 111.0, 112.0, 100.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 163.0, 176.0, 126.0, 159.0, 149.0, 134.0, 168.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [162.0, 171.0, 163.0, 163.0, 162.0, 161.0, 161.0, 164.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 116.0, 99.0, 74.0, 74.0, 73.0, 117.0, 96.0, 76.0], "unit": "score", "name": "audio-fft", "value": 87.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 151.0, 94.0, 96.0, 97.0, 150.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 68.0, 68.0, 76.0, 68.0, 70.0, 67.0, 67.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [80.0, 90.0, 82.0, 82.0, 82.0, 83.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 119.0, 114.0, 117.0, 126.0, 120.0, 118.0, 123.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [152.0, 151.0, 152.0, 162.0, 151.0, 140.0, 150.0, 150.0, 148.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 68.0, 67.0, 69.0, 69.0, 70.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1524.0000000000005}]} 17:31:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6712.11"}}} 17:31:19 INFO - Return code: 0 17:31:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:31:19 INFO - # TBPL SUCCESS # 17:31:19 INFO - Running post-action listener: _resource_record_post_action 17:31:19 INFO - Running post-run listener: _resource_record_post_run 17:31:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 550264832; Read time: 0; Write time: 945144 17:31:20 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 258232320; Read time: 0; Write time: 644908 17:31:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292032512; Read time: 0; Write time: 300236 17:31:20 INFO - Running post-run listener: _upload_blobber_files 17:31:20 INFO - Blob upload gear active. 17:31:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:31:20 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 17:31:20 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'] 17:31:20 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 17:31:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:21 INFO - (blobuploader) - INFO - Done attempting. 17:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:31:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:22 INFO - (blobuploader) - INFO - Done attempting. 17:31:22 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:22 INFO - Return code: 0 17:31:22 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:31:22 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65ded2fbb5450052eb1e61d01efd78b09fb7c27c417b61c5f38b9735fd7bc64555685f4f03952df9d2af2c3cf1c903d58ad85e91e6516f11abe8b5eadd1c9a24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ba2e2ea67dbea82ca957a7613d31712d8282b5c19818da2869abc20afa414a1d12d470f95497fe6cd0bf5677f5917426a0c579ad0fd05418613f73228003be"} 17:31:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:31:22 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:31:22 INFO - Contents: 17:31:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65ded2fbb5450052eb1e61d01efd78b09fb7c27c417b61c5f38b9735fd7bc64555685f4f03952df9d2af2c3cf1c903d58ad85e91e6516f11abe8b5eadd1c9a24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ba2e2ea67dbea82ca957a7613d31712d8282b5c19818da2869abc20afa414a1d12d470f95497fe6cd0bf5677f5917426a0c579ad0fd05418613f73228003be"} 17:31:22 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:22 INFO - Copying logs to upload dir... 17:31:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:31:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.394028 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-02-23 17:31:21.914791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 17:31:21.918084) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 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/65ded2fbb5450052eb1e61d01efd78b09fb7c27c417b61c5f38b9735fd7bc64555685f4f03952df9d2af2c3cf1c903d58ad85e91e6516f11abe8b5eadd1c9a24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ba2e2ea67dbea82ca957a7613d31712d8282b5c19818da2869abc20afa414a1d12d470f95497fe6cd0bf5677f5917426a0c579ad0fd05418613f73228003be"} build_url:https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011435 build_url: 'https://queue.taskcluster.net/v1/task/ZIXp-e86QdSzOET5xvqruw/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/65ded2fbb5450052eb1e61d01efd78b09fb7c27c417b61c5f38b9735fd7bc64555685f4f03952df9d2af2c3cf1c903d58ad85e91e6516f11abe8b5eadd1c9a24", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0ba2e2ea67dbea82ca957a7613d31712d8282b5c19818da2869abc20afa414a1d12d470f95497fe6cd0bf5677f5917426a0c579ad0fd05418613f73228003be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 17:31:21.943013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:31:21.943342) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1456275247.773760-1938603822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 17:31:22.029707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 17:31:22.030031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 17:31:22.030354) ========= ========= Total master_lag: 0.27 =========