builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1456395317.01 results: success (0) buildid: 20160224233027 builduid: 79a7908071e54b2db1aa94ab2138b0c5 revision: 8661318f11a994191eccd1ee8c1210db53ca9b58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.009447) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.009835) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.010117) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004933 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.028216) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.028492) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.073472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.073830) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.025105 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.122802) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.123089) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.123454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.123726) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-25 02:15:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-02-25 02:15:17 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.297212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.297505) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.107717 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.416224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:17.416586) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8661318f11a994191eccd1ee8c1210db53ca9b58 --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 8661318f11a994191eccd1ee8c1210db53ca9b58 --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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-25 02:15:17,552 truncating revision to first 12 chars 2016-02-25 02:15:17,552 Setting DEBUG logging. 2016-02-25 02:15:17,552 attempt 1/10 2016-02-25 02:15:17,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8661318f11a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 02:15:17,816 unpacking tar archive at: fx-team-8661318f11a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575171 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:18.004246) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:18.004547) ========= echo 8661318f11a994191eccd1ee8c1210db53ca9b58 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8661318f11a994191eccd1ee8c1210db53ca9b58'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8661318f11a994191eccd1ee8c1210db53ca9b58 program finished with exit code 0 elapsedTime=0.003417 script_repo_revision: '8661318f11a994191eccd1ee8c1210db53ca9b58' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:18.053070) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:18.053419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 02:15:18.065647) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-25 02:15:18.066025) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:15:18 INFO - MultiFileLogger online at 20160225 02:15:18 in /builds/slave/test-pgo 02:15:18 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 02:15:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:15:18 INFO - {'append_to_log': False, 02:15:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:15:18 INFO - 'blob_upload_branch': 'Fx-Team', 02:15:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:15:18 INFO - 'branch': 'Fx-Team', 02:15:18 INFO - 'buildbot_json_path': 'buildprops.json', 02:15:18 INFO - 'config_files': ('talos/linux_config.py',), 02:15:18 INFO - 'default_actions': ('clobber', 02:15:18 INFO - 'read-buildbot-config', 02:15:18 INFO - 'download-and-extract', 02:15:18 INFO - 'populate-webroot', 02:15:18 INFO - 'create-virtualenv', 02:15:18 INFO - 'install', 02:15:18 INFO - 'run-tests'), 02:15:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:15:18 INFO - 'download_minidump_stackwalk': True, 02:15:18 INFO - 'download_symbols': 'ondemand', 02:15:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:15:18 INFO - 'tooltool.py': '/tools/tooltool.py', 02:15:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:15:18 INFO - '/tools/misc-python/virtualenv.py')}, 02:15:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:15:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:15:18 INFO - 'installer_path': 'installer.exe', 02:15:18 INFO - 'log_level': 'info', 02:15:18 INFO - 'log_name': 'talos', 02:15:18 INFO - 'log_to_console': True, 02:15:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:15:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:15:18 INFO - 'opt_config_files': (), 02:15:18 INFO - 'pip_index': False, 02:15:18 INFO - 'sps_profile': False, 02:15:18 INFO - 'sps_profile_interval': 0, 02:15:18 INFO - 'suite': 'dromaeojs', 02:15:18 INFO - 'system_bits': '32', 02:15:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:15:18 INFO - 'title': 'talos-linux64-ix-022', 02:15:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:15:18 INFO - 'use_talos_json': True, 02:15:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:15:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:15:18 INFO - 'work_dir': 'build'} 02:15:18 INFO - ##### 02:15:18 INFO - ##### Running clobber step. 02:15:18 INFO - ##### 02:15:18 INFO - Running pre-action listener: _resource_record_pre_action 02:15:18 INFO - Running main action method: clobber 02:15:18 INFO - rmtree: /builds/slave/test-pgo/build 02:15:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:15:19 INFO - Running post-action listener: _resource_record_post_action 02:15:19 INFO - ##### 02:15:19 INFO - ##### Running read-buildbot-config step. 02:15:19 INFO - ##### 02:15:19 INFO - Running pre-action listener: _resource_record_pre_action 02:15:19 INFO - Running main action method: read_buildbot_config 02:15:19 INFO - Using buildbot properties: 02:15:19 INFO - { 02:15:19 INFO - "project": "", 02:15:19 INFO - "product": "firefox", 02:15:19 INFO - "script_repo_revision": "production", 02:15:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:15:19 INFO - "repository": "", 02:15:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:15:19 INFO - "buildid": "20160224233027", 02:15:19 INFO - "pgo_build": "True", 02:15:19 INFO - "basedir": "/builds/slave/test-pgo", 02:15:19 INFO - "buildnumber": 667, 02:15:19 INFO - "slavename": "talos-linux64-ix-022", 02:15:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:15:19 INFO - "platform": "ubuntu64_hw", 02:15:19 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:15:19 INFO - "branch": "fx-team", 02:15:19 INFO - "repo_path": "integration/fx-team", 02:15:19 INFO - "revision": "8661318f11a994191eccd1ee8c1210db53ca9b58", 02:15:19 INFO - "stage_platform": "linux64-pgo", 02:15:19 INFO - "builduid": "79a7908071e54b2db1aa94ab2138b0c5", 02:15:19 INFO - "slavebuilddir": "test" 02:15:19 INFO - } 02:15:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 02:15:19 INFO - Running post-action listener: _resource_record_post_action 02:15:19 INFO - ##### 02:15:19 INFO - ##### Running download-and-extract step. 02:15:19 INFO - ##### 02:15:19 INFO - Running pre-action listener: _resource_record_pre_action 02:15:19 INFO - Running main action method: download_and_extract 02:15:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:15: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')]} 02:15:19 INFO - https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:15:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/test_packages.json 02:15:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/test_packages.json 02:15:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:15:21 INFO - Downloaded 1448 bytes. 02:15:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:15:21 INFO - Using the following test package requirements: 02:15:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:15:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:15:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:15:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'jsshell-linux-x86_64.zip'], 02:15:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:15:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:15:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:15:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:15:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:15:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 02:15:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 02:15:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:15:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:15:21 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')]} 02:15:21 INFO - https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:15:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:15:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:15:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:24 INFO - Downloaded 23369730 bytes. 02:15:24 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'] 02:15:24 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 02:15:25 INFO - Return code: 0 02:15:25 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 02:15: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')]} 02:15:25 INFO - https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:15:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:15:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 02:15:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:37 INFO - Downloaded 23369730 bytes. 02:15:37 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'] 02:15:37 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 02:15:38 INFO - Return code: 0 02:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:38 INFO - https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 02:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:39 INFO - Downloaded 10707015 bytes. 02:15:39 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'] 02:15:39 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 02:15:40 INFO - Return code: 0 02:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:40 INFO - https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fSLiV4zCTraEl_7SxLStpw/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 02:15:41 INFO - Downloaded 56659048 bytes. 02:15:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:15:41 INFO - mkdir: /builds/slave/test-pgo/properties 02:15:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:15:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:15:41 INFO - Contents: 02:15:41 INFO - build_url:https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 02:15:42 INFO - Running post-action listener: _resource_record_post_action 02:15:42 INFO - Running post-action listener: set_extra_try_arguments 02:15:42 INFO - ##### 02:15:42 INFO - ##### Running populate-webroot step. 02:15:42 INFO - ##### 02:15:42 INFO - Running pre-action listener: _resource_record_pre_action 02:15:42 INFO - Running main action method: populate_webroot 02:15:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:42 INFO - '--tppagecycles', 02:15:42 INFO - '7'], 02:15:42 INFO - 'tests': ['tsvgm']}}, 02:15:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:15:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:15:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'tests': ['damp', 'tps']}, 02:15:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['damp', 'tps']}, 02:15:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:15:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:15:42 INFO - 'other': {'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'other_l64': {'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'other_nol64': {'tests': ['a11yr', 02:15:42 INFO - 'ts_paint', 02:15:42 INFO - 'tpaint', 02:15:42 INFO - 'sessionrestore', 02:15:42 INFO - 'sessionrestore_no_auto_restore']}, 02:15:42 INFO - 'svgr': {'tests': ['tsvgx', 02:15:42 INFO - 'tsvgr_opacity', 02:15:42 INFO - 'tart', 02:15:42 INFO - 'tscrollx', 02:15:42 INFO - 'cart']}, 02:15:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['tsvgx', 02:15:42 INFO - 'tsvgr_opacity', 02:15:42 INFO - 'tart', 02:15:42 INFO - 'tscrollx', 02:15:42 INFO - 'cart']}, 02:15:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'tests': ['tp5o']}, 02:15:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'talos_options': ['--e10s'], 02:15:42 INFO - 'tests': ['tp5o']}, 02:15:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'talos_options': ['--xperf_path', 02:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:42 INFO - 'tests': ['tp5n']}, 02:15:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:42 INFO - 'talos_options': ['--e10s', 02:15:42 INFO - '--xperf_path', 02:15:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:42 INFO - 'tests': ['tp5n']}}, 02:15:42 INFO - 'talos.zip': {'path': '', 02:15:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:42 INFO - Running post-action listener: _resource_record_post_action 02:15:42 INFO - ##### 02:15:42 INFO - ##### Running create-virtualenv step. 02:15:42 INFO - ##### 02:15:42 INFO - Running pre-action listener: _resource_record_pre_action 02:15:42 INFO - Running main action method: create_virtualenv 02:15:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:15:42 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 02:15:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:15:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:42 INFO - Using real prefix '/usr' 02:15:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:15:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:45 INFO - Installing pip.................done. 02:15:45 INFO - Return code: 0 02:15:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:15: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')]} 02:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:15:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:15:45 INFO - Using env: {'DISPLAY': ':0', 02:15:45 INFO - 'HOME': '/home/cltbld', 02:15:45 INFO - 'LANG': 'en_US.UTF-8', 02:15:45 INFO - 'LANGUAGE': 'en_US:en', 02:15:45 INFO - 'LOGNAME': 'cltbld', 02:15:45 INFO - 'MAIL': '/var/mail/cltbld', 02:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:45 INFO - 'MOZ_NO_REMOTE': '1', 02:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:45 INFO - 'NO_EM_RESTART': '1', 02:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:45 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:45 INFO - 'SHELL': '/bin/bash', 02:15:45 INFO - 'SHLVL': '1', 02:15:45 INFO - 'TERM': 'linux', 02:15:45 INFO - 'TMOUT': '86400', 02:15:45 INFO - 'USER': 'cltbld', 02:15:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:45 INFO - '_': '/tools/buildbot/bin/python'} 02:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:45 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 02:15:45 INFO - Cleaning up... 02:15:45 INFO - Return code: 0 02:15:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:15: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')]} 02:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:15:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:15:45 INFO - Using env: {'DISPLAY': ':0', 02:15:45 INFO - 'HOME': '/home/cltbld', 02:15:45 INFO - 'LANG': 'en_US.UTF-8', 02:15:45 INFO - 'LANGUAGE': 'en_US:en', 02:15:45 INFO - 'LOGNAME': 'cltbld', 02:15:45 INFO - 'MAIL': '/var/mail/cltbld', 02:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:45 INFO - 'MOZ_NO_REMOTE': '1', 02:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:45 INFO - 'NO_EM_RESTART': '1', 02:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:45 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:45 INFO - 'SHELL': '/bin/bash', 02:15:45 INFO - 'SHLVL': '1', 02:15:45 INFO - 'TERM': 'linux', 02:15:45 INFO - 'TMOUT': '86400', 02:15:45 INFO - 'USER': 'cltbld', 02:15:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:45 INFO - '_': '/tools/buildbot/bin/python'} 02:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:45 INFO - Downloading/unpacking psutil>=0.7.1 02:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:47 INFO - Installing collected packages: psutil 02:15:47 INFO - Running setup.py install for psutil 02:15:47 INFO - building 'psutil._psutil_linux' extension 02:15:47 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 02:15:47 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 02:15:47 INFO - building 'psutil._psutil_posix' extension 02:15:47 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 02:15:48 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 02:15:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:48 INFO - Successfully installed psutil 02:15:48 INFO - Cleaning up... 02:15:48 INFO - Return code: 0 02:15:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:15:48 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')]} 02:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:48 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')]} 02:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:48 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:48 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 02:15:48 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 02:15:48 INFO - Using env: {'DISPLAY': ':0', 02:15:48 INFO - 'HOME': '/home/cltbld', 02:15:48 INFO - 'LANG': 'en_US.UTF-8', 02:15:48 INFO - 'LANGUAGE': 'en_US:en', 02:15:48 INFO - 'LOGNAME': 'cltbld', 02:15:48 INFO - 'MAIL': '/var/mail/cltbld', 02:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:48 INFO - 'MOZ_NO_REMOTE': '1', 02:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:48 INFO - 'NO_EM_RESTART': '1', 02:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:48 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:48 INFO - 'SHELL': '/bin/bash', 02:15:48 INFO - 'SHLVL': '1', 02:15:48 INFO - 'TERM': 'linux', 02:15:48 INFO - 'TMOUT': '86400', 02:15:48 INFO - 'USER': 'cltbld', 02:15:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:48 INFO - '_': '/tools/buildbot/bin/python'} 02:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:15:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:15:50 INFO - Installing collected packages: mozsystemmonitor 02:15:50 INFO - Running setup.py install for mozsystemmonitor 02:15:50 INFO - Successfully installed mozsystemmonitor 02:15:50 INFO - Cleaning up... 02:15:50 INFO - Return code: 0 02:15:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:15:50 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')]} 02:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:50 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')]} 02:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:50 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:50 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 02:15:50 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 02:15:50 INFO - Using env: {'DISPLAY': ':0', 02:15:50 INFO - 'HOME': '/home/cltbld', 02:15:50 INFO - 'LANG': 'en_US.UTF-8', 02:15:50 INFO - 'LANGUAGE': 'en_US:en', 02:15:50 INFO - 'LOGNAME': 'cltbld', 02:15:50 INFO - 'MAIL': '/var/mail/cltbld', 02:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:50 INFO - 'MOZ_NO_REMOTE': '1', 02:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:50 INFO - 'NO_EM_RESTART': '1', 02:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:50 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:50 INFO - 'SHELL': '/bin/bash', 02:15:50 INFO - 'SHLVL': '1', 02:15:50 INFO - 'TERM': 'linux', 02:15:50 INFO - 'TMOUT': '86400', 02:15:50 INFO - 'USER': 'cltbld', 02:15:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:50 INFO - '_': '/tools/buildbot/bin/python'} 02:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15:52 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 02:15:52 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 02:15:52 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 02:15:52 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 02:15:52 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 02:15:52 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 02:15:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:15:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:53 INFO - Downloading docopt-0.6.1.tar.gz 02:15:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:53 INFO - Running setup.py install for blobuploader 02:15:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:15:53 INFO - Running setup.py install for requests 02:15:53 INFO - Running setup.py install for docopt 02:15:53 INFO - Successfully installed blobuploader requests docopt 02:15:53 INFO - Cleaning up... 02:15:53 INFO - Return code: 0 02:15:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:15: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')]} 02:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:53 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:53 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 02:15:53 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 02:15:53 INFO - Using env: {'DISPLAY': ':0', 02:15:53 INFO - 'HOME': '/home/cltbld', 02:15:53 INFO - 'LANG': 'en_US.UTF-8', 02:15:53 INFO - 'LANGUAGE': 'en_US:en', 02:15:53 INFO - 'LOGNAME': 'cltbld', 02:15:53 INFO - 'MAIL': '/var/mail/cltbld', 02:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:53 INFO - 'MOZ_NO_REMOTE': '1', 02:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:53 INFO - 'NO_EM_RESTART': '1', 02:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:53 INFO - 'SHELL': '/bin/bash', 02:15:53 INFO - 'SHLVL': '1', 02:15:53 INFO - 'TERM': 'linux', 02:15:53 INFO - 'TMOUT': '86400', 02:15:53 INFO - 'USER': 'cltbld', 02:15:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:53 INFO - '_': '/tools/buildbot/bin/python'} 02:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:15:54 INFO - Running setup.py (path:/tmp/pip-7BPxCY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:15:54 INFO - Running setup.py (path:/tmp/pip-tvJyLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:15:54 INFO - Running setup.py (path:/tmp/pip-WUSjdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:15:54 INFO - Running setup.py (path:/tmp/pip-oRIo58-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:15:54 INFO - Running setup.py (path:/tmp/pip-iELFUm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:15:54 INFO - Running setup.py (path:/tmp/pip-NWVNGG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:15:54 INFO - Running setup.py (path:/tmp/pip-jk7V6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:15:54 INFO - Running setup.py (path:/tmp/pip-Z0JFXI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:15:54 INFO - Running setup.py (path:/tmp/pip-1OOntd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:15:54 INFO - Running setup.py (path:/tmp/pip-FEpPGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:15:54 INFO - Running setup.py (path:/tmp/pip-fhgoKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:15:54 INFO - Running setup.py (path:/tmp/pip-7yYdxU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:15:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:15:54 INFO - Running setup.py (path:/tmp/pip-TTblDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:15:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:15:55 INFO - Running setup.py (path:/tmp/pip-b2cKx4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:15:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:15:55 INFO - Running setup.py (path:/tmp/pip-p0tb4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:15:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:15:55 INFO - Running setup.py (path:/tmp/pip-PsoFW9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:15:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:15:55 INFO - Running setup.py (path:/tmp/pip-dWtmhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:15:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:15:55 INFO - Running setup.py install for manifestparser 02:15:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:15:55 INFO - Running setup.py install for mozcrash 02:15:55 INFO - Running setup.py install for mozdebug 02:15:55 INFO - Running setup.py install for mozdevice 02:15:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:15:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:15:55 INFO - Running setup.py install for mozfile 02:15:55 INFO - Running setup.py install for mozhttpd 02:15:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:15:55 INFO - Running setup.py install for mozinfo 02:15:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for mozInstall 02:15:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for mozleak 02:15:56 INFO - Running setup.py install for mozlog 02:15:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for moznetwork 02:15:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for mozprocess 02:15:56 INFO - Running setup.py install for mozprofile 02:15:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for mozrunner 02:15:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:15:56 INFO - Running setup.py install for mozscreenshot 02:15:56 INFO - Running setup.py install for moztest 02:15:57 INFO - Running setup.py install for mozversion 02:15:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:15:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:15:57 INFO - Cleaning up... 02:15:57 INFO - Return code: 0 02:15:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:15: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')]} 02:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15: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')]} 02:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:57 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:15:57 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 02:15:57 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 02:15:57 INFO - Using env: {'DISPLAY': ':0', 02:15:57 INFO - 'HOME': '/home/cltbld', 02:15:57 INFO - 'LANG': 'en_US.UTF-8', 02:15:57 INFO - 'LANGUAGE': 'en_US:en', 02:15:57 INFO - 'LOGNAME': 'cltbld', 02:15:57 INFO - 'MAIL': '/var/mail/cltbld', 02:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:57 INFO - 'MOZ_NO_REMOTE': '1', 02:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:15:57 INFO - 'NO_EM_RESTART': '1', 02:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:15:57 INFO - 'PWD': '/builds/slave/test-pgo', 02:15:57 INFO - 'SHELL': '/bin/bash', 02:15:57 INFO - 'SHLVL': '1', 02:15:57 INFO - 'TERM': 'linux', 02:15:57 INFO - 'TMOUT': '86400', 02:15:57 INFO - 'USER': 'cltbld', 02:15:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:57 INFO - '_': '/tools/buildbot/bin/python'} 02:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:15:57 INFO - Running setup.py (path:/tmp/pip-w8kjS5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:15:57 INFO - Running setup.py (path:/tmp/pip-f3pjgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:15:57 INFO - Running setup.py (path:/tmp/pip-znCopi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:15:57 INFO - Running setup.py (path:/tmp/pip-xaOot5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:15:57 INFO - Running setup.py (path:/tmp/pip-LD0pdv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:15:57 INFO - Running setup.py (path:/tmp/pip-b_xkCc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:15:57 INFO - Running setup.py (path:/tmp/pip-4oyGji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:15:57 INFO - Running setup.py (path:/tmp/pip-T5tZhK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:15:57 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)) 02:15:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:15:57 INFO - Running setup.py (path:/tmp/pip-KcAnYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:15:58 INFO - Running setup.py (path:/tmp/pip-5enhYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:15:58 INFO - Running setup.py (path:/tmp/pip-qxgnMD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:15:58 INFO - Running setup.py (path:/tmp/pip-y7Mb2N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:15:58 INFO - Running setup.py (path:/tmp/pip-VH3l1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:15:58 INFO - Running setup.py (path:/tmp/pip-G_q47X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:15:58 INFO - Running setup.py (path:/tmp/pip-87q6zu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:15:58 INFO - Running setup.py (path:/tmp/pip-MnD3j1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:15:58 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)) 02:15:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:15:58 INFO - Running setup.py (path:/tmp/pip-xYbVUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:15:58 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)) 02:15:58 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)) 02:15:58 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)) 02:15:58 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)) 02:15:58 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)) 02:15:58 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)) 02:15:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:00 INFO - Downloading blessings-1.6.tar.gz 02:16:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:16:00 INFO - Installing collected packages: blessings 02:16:00 INFO - Running setup.py install for blessings 02:16:00 INFO - Successfully installed blessings 02:16:00 INFO - Cleaning up... 02:16:00 INFO - Return code: 0 02:16:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:16:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:16:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:16:00 INFO - Reading from file tmpfile_stdout 02:16:00 INFO - Current package versions: 02:16:00 INFO - argparse == 1.2.1 02:16:00 INFO - blessings == 1.6 02:16:00 INFO - blobuploader == 1.2.4 02:16:00 INFO - docopt == 0.6.1 02:16:00 INFO - manifestparser == 1.1 02:16:00 INFO - mozInstall == 1.12 02:16:00 INFO - mozcrash == 0.16 02:16:00 INFO - mozdebug == 0.1 02:16:00 INFO - mozdevice == 0.48 02:16:00 INFO - mozfile == 1.2 02:16:00 INFO - mozhttpd == 0.7 02:16:00 INFO - mozinfo == 0.9 02:16:00 INFO - mozleak == 0.1 02:16:00 INFO - mozlog == 3.1 02:16:00 INFO - moznetwork == 0.27 02:16:00 INFO - mozprocess == 0.22 02:16:00 INFO - mozprofile == 0.28 02:16:00 INFO - mozrunner == 6.11 02:16:00 INFO - mozscreenshot == 0.1 02:16:00 INFO - mozsystemmonitor == 0.0 02:16:00 INFO - moztest == 0.7 02:16:00 INFO - mozversion == 1.4 02:16:00 INFO - psutil == 3.1.1 02:16:00 INFO - requests == 1.2.3 02:16:00 INFO - wsgiref == 0.1.2 02:16:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:16:00 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')]} 02:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:00 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')]} 02:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:00 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:16:00 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 02:16:00 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 02:16:00 INFO - Using env: {'DISPLAY': ':0', 02:16:00 INFO - 'HOME': '/home/cltbld', 02:16:00 INFO - 'LANG': 'en_US.UTF-8', 02:16:00 INFO - 'LANGUAGE': 'en_US:en', 02:16:00 INFO - 'LOGNAME': 'cltbld', 02:16:00 INFO - 'MAIL': '/var/mail/cltbld', 02:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:00 INFO - 'MOZ_NO_REMOTE': '1', 02:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:00 INFO - 'NO_EM_RESTART': '1', 02:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:16:00 INFO - 'PWD': '/builds/slave/test-pgo', 02:16:00 INFO - 'SHELL': '/bin/bash', 02:16:00 INFO - 'SHLVL': '1', 02:16:00 INFO - 'TERM': 'linux', 02:16:00 INFO - 'TMOUT': '86400', 02:16:00 INFO - 'USER': 'cltbld', 02:16:00 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:00 INFO - '_': '/tools/buildbot/bin/python'} 02:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 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)) 02:16:01 INFO - Cleaning up... 02:16:01 INFO - Return code: 0 02:16:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:16: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')]} 02:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16: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')]} 02:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:01 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:16:01 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 02:16:01 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 02:16:01 INFO - Using env: {'DISPLAY': ':0', 02:16:01 INFO - 'HOME': '/home/cltbld', 02:16:01 INFO - 'LANG': 'en_US.UTF-8', 02:16:01 INFO - 'LANGUAGE': 'en_US:en', 02:16:01 INFO - 'LOGNAME': 'cltbld', 02:16:01 INFO - 'MAIL': '/var/mail/cltbld', 02:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:01 INFO - 'MOZ_NO_REMOTE': '1', 02:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:01 INFO - 'NO_EM_RESTART': '1', 02:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:16:01 INFO - 'PWD': '/builds/slave/test-pgo', 02:16:01 INFO - 'SHELL': '/bin/bash', 02:16:01 INFO - 'SHLVL': '1', 02:16:01 INFO - 'TERM': 'linux', 02:16:01 INFO - 'TMOUT': '86400', 02:16:01 INFO - 'USER': 'cltbld', 02:16:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:01 INFO - '_': '/tools/buildbot/bin/python'} 02:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:01 INFO - Downloading/unpacking jsonschema 02:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:16:03 INFO - Downloading/unpacking functools32 (from jsonschema) 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:16:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:16:03 INFO - warning: no files found matching '*.txt' 02:16:03 INFO - no previously-included directories found matching 'build' 02:16:03 INFO - no previously-included directories found matching 'dist' 02:16:03 INFO - no previously-included directories found matching '.git*' 02:16:03 INFO - Installing collected packages: jsonschema, functools32 02:16:03 INFO - Running setup.py install for functools32 02:16:03 INFO - warning: no files found matching '*.txt' 02:16:03 INFO - no previously-included directories found matching 'build' 02:16:03 INFO - no previously-included directories found matching 'dist' 02:16:03 INFO - no previously-included directories found matching '.git*' 02:16:03 INFO - Successfully installed jsonschema functools32 02:16:03 INFO - Cleaning up... 02:16:03 INFO - Return code: 0 02:16:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:16:03 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')]} 02:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:03 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')]} 02:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:03 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 0x7f42d72e3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', '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 02:16:03 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 02:16:03 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 02:16:03 INFO - Using env: {'DISPLAY': ':0', 02:16:03 INFO - 'HOME': '/home/cltbld', 02:16:03 INFO - 'LANG': 'en_US.UTF-8', 02:16:03 INFO - 'LANGUAGE': 'en_US:en', 02:16:03 INFO - 'LOGNAME': 'cltbld', 02:16:03 INFO - 'MAIL': '/var/mail/cltbld', 02:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:03 INFO - 'MOZ_NO_REMOTE': '1', 02:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:03 INFO - 'NO_EM_RESTART': '1', 02:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:16:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:16:03 INFO - 'SHELL': '/bin/bash', 02:16:03 INFO - 'SHLVL': '1', 02:16:03 INFO - 'TERM': 'linux', 02:16:03 INFO - 'TMOUT': '86400', 02:16:03 INFO - 'USER': 'cltbld', 02:16:03 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:03 INFO - '_': '/tools/buildbot/bin/python'} 02:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:03 INFO - Downloading/unpacking flake8 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:03 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 02:16:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:16:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:16:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:05 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 02:16:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:16:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:16:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:16:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:16:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:16:06 INFO - no previously-included directories found matching 'docs/_build' 02:16:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:16:06 INFO - Running setup.py install for pep8 02:16:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:16:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:16:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:16:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:16:06 INFO - no previously-included directories found matching 'docs/_build' 02:16:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:16:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:16:06 INFO - Cleaning up... 02:16:06 INFO - Return code: 0 02:16:06 INFO - Running post-action listener: _resource_record_post_action 02:16:06 INFO - Running post-action listener: _start_resource_monitoring 02:16:06 INFO - Starting resource monitoring. 02:16:06 INFO - ##### 02:16:06 INFO - ##### Running install step. 02:16:06 INFO - ##### 02:16:06 INFO - Running pre-action listener: _resource_record_pre_action 02:16:06 INFO - Running main action method: install 02:16:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:16:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:16:06 INFO - Reading from file tmpfile_stdout 02:16:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:16:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:16:06 INFO - Reading from file tmpfile_stdout 02:16:06 INFO - Output received: 02:16:06 INFO - Usage: mozinstall [options] installer 02:16:06 INFO - Options: 02:16:06 INFO - -h, --help show this help message and exit 02:16:06 INFO - -d DEST, --destination=DEST 02:16:06 INFO - Directory to install application into. [default: 02:16:06 INFO - "/builds/slave/test-pgo"] 02:16:06 INFO - --app=APP Application being installed. [default: firefox] 02:16:06 INFO - mkdir: /builds/slave/test-pgo/build/application 02:16:06 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'] 02:16:06 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 02:16:23 INFO - Reading from file tmpfile_stdout 02:16:23 INFO - Output received: 02:16:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:16:23 INFO - Running post-action listener: _resource_record_post_action 02:16:23 INFO - ##### 02:16:23 INFO - ##### Running run-tests step. 02:16:23 INFO - ##### 02:16:23 INFO - Running pre-action listener: _resource_record_pre_action 02:16:23 INFO - Running main action method: run_tests 02:16:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:16:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:16:23 INFO - Python 2.7.3 02:16:23 INFO - Return code: 0 02:16:23 INFO - grabbing minidump binary from tooltool 02:16: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')]} 02:16:23 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 0x29d78c0>, '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 0x29d87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d8c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:16:23 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 02:16:23 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 02:16:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:16:23 INFO - Return code: 0 02:16:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:16:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:16:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:16:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:16:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:16:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:16:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:16:24 INFO - Return code: 0 02:16:24 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/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:16:24 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/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 02:16:24 INFO - Using env: {'DISPLAY': ':0', 02:16:24 INFO - 'HOME': '/home/cltbld', 02:16:24 INFO - 'LANG': 'en_US.UTF-8', 02:16:24 INFO - 'LANGUAGE': 'en_US:en', 02:16:24 INFO - 'LOGNAME': 'cltbld', 02:16:24 INFO - 'MAIL': '/var/mail/cltbld', 02:16:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:16:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:24 INFO - 'MOZ_NO_REMOTE': '1', 02:16:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:24 INFO - 'NO_EM_RESTART': '1', 02:16:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:16:24 INFO - 'PWD': '/builds/slave/test-pgo', 02:16:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:16:24 INFO - 'SHELL': '/bin/bash', 02:16:24 INFO - 'SHLVL': '1', 02:16:24 INFO - 'TERM': 'linux', 02:16:24 INFO - 'TMOUT': '86400', 02:16:24 INFO - 'USER': 'cltbld', 02:16:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957', 02:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:24 INFO - '_': '/tools/buildbot/bin/python'} 02:16:24 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/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:16:24 INFO - mozversion application_buildid: 20160224233027 02:16:24 INFO - mozversion application_changeset: 8661318f11a994191eccd1ee8c1210db53ca9b58 02:16:24 INFO - mozversion application_display_name: Nightly 02:16:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:16:24 INFO - mozversion application_name: Firefox 02:16:24 INFO - mozversion application_remotingname: firefox 02:16:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:16:24 INFO - mozversion application_vendor: Mozilla 02:16:24 INFO - mozversion application_version: 47.0a1 02:16:24 INFO - mozversion platform_buildid: 20160224233027 02:16:24 INFO - mozversion platform_changeset: 8661318f11a994191eccd1ee8c1210db53ca9b58 02:16:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:16:24 INFO - mozversion platform_version: 47.0a1 02:16:24 INFO - using testdate: 1456395384 02:16:24 INFO - actual date: 1456395384 02:16:24 INFO - starting webserver on 'localhost:34790' 02:16:24 INFO - SUITE-START | Running 2 tests 02:16:24 INFO - TEST-START | dromaeo_css 02:16:24 INFO - operating with platform_type : linux_ 02:16:24 INFO - Initialising browser for dromaeo_css test... 02:16:24 INFO - TEST-INFO | started process 23651 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEC9Zv0/profile http://localhost:34790/getInfo.html) 02:16:28 INFO - PROCESS | 23651 | __metrics Screen width/height:1600/1200 02:16:28 INFO - PROCESS | 23651 | colorDepth:24 02:16:28 INFO - PROCESS | 23651 | Browser inner width/height: 1024/697 02:16:28 INFO - PROCESS | 23651 | __metrics 02:16:30 INFO - PROCESS | 23651 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:30 INFO - TEST-INFO | 23651: exit 0 02:16:30 INFO - Browser initialized. 02:16:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:30 INFO - TEST-INFO | started process 23747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEC9Zv0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:42 INFO - PROCESS | 23747 | RSS: Main: 147832832 02:16:42 INFO - PROCESS | 23747 | 02:17:34 INFO - PROCESS | 23747 | 1456395454012 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] 02:19:42 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34790/tests/dromaeo/cssquery-ext.html) 02:19:43 INFO - PROCESS | 23747 | RSS: Main: 207773696 02:19:43 INFO - PROCESS | 23747 | 02:22:45 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-ext.html (next: http://localhost:34790/tests/dromaeo/cssquery-jquery.html) 02:22:46 INFO - PROCESS | 23747 | RSS: Main: 243490816 02:22:46 INFO - PROCESS | 23747 | 02:25:48 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34790/tests/dromaeo/cssquery-mootools.html) 02:25:48 INFO - PROCESS | 23747 | RSS: Main: 241430528 02:25:48 INFO - PROCESS | 23747 | 02:28:50 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34790/tests/dromaeo/cssquery-prototype.html) 02:28:51 INFO - PROCESS | 23747 | RSS: Main: 216657920 02:28:51 INFO - PROCESS | 23747 | 02:31:53 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34790/tests/dromaeo/cssquery-yui.html) 02:31:54 INFO - PROCESS | 23747 | RSS: Main: 192438272 02:31:54 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | Cycle 1(1): loaded http://localhost:34790/tests/dromaeo/cssquery-yui.html (next: http://localhost:34790/tests/dromaeo/cssquery-dojo.html) 02:34:56 INFO - PROCESS | 23747 | RSS: Main: 281903104 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | __start_tp_report 02:34:56 INFO - PROCESS | 23747 | _x_x_mozilla_page_load 02:34:56 INFO - PROCESS | 23747 | _x_x_mozilla_page_load_details 02:34:56 INFO - PROCESS | 23747 | |i|pagename|runs| 02:34:56 INFO - PROCESS | 23747 | |0;dojo.html;3108.4870996285613;3135.3259049304424;3168.508881123427;3169.7464202863757;3197.5843140391753;5019;5145.459726728695;5154.123798954182;5161.354830646169;5196.844094677156;5132.28148059272;5165.81919632813;5169.3279873616375;5174.275601415805;5257.290265814114;4656.5343465653505;4727.90544189116;4778.54603812639;4793.90412191756;4795.472498025214;4653.953460465403;4676.3920690310215;4740.739259340735;4742.288656701505;4852.708837469763;4749.382580264578;4757.0723708876785;4767.189577771787;4790.257510085942;4806.399200099988;4747.240441529373;4757.0248099139935;4760.428748550196;4770.7376094314795;4787.688800228009;4560.77196140195;4667.766611669403;4740.383750112498;4749.501302363271;4754.762261886926;4995.600351971833;5020.196768517057;5027.4469808321055;5032.295478632957;5080.872978175576;5420.620556561003;5532.197831314437;5540.473655002808;5544.584156188262;5544.77820887164;5525.834224973257;5548.889022219533;5565.1095824667855;5581.05122129239;5630.634008789457;5178.508041736029;5185.662931909414;5187.144121219994;5189.221616757516;5200.947990520122;5618.43815618443;5620.494155526022;5620.634658747168;5631.267935168402;5709.314882214161;5446.2375267462585;5456.427075157131;5458.727063646881;5465.836024919259;5471.316085489314;5520.558355331564;5534.280543529316;5538.695371754511;5545.9722701387045;5596;5393.406725260218;5512.862178445491;5529.778808847682;5552.972700050504;5600.243967064475;5473.972630136904;5501.477359650827;5506.421825708243;5509.752061157257;5511.311086114236;4255.6169944705125;4302.65578753699;4306.440162778818;4310.094880075219;4327.350897365421;3863.3239183142837;3866.7873266970587;3880.495535580413;3897.7271590988357;3908.9609103909165;5109.156989096758;5130.743462826844;5153.510416510426;5160.148575485003;5192.974035129876;5454.53636440899;5508.724563771795;5542.944570554243;5546.168074788733;5547.667139971614;5157.381114266237;5165.509276618715;5185.144451165515;5185.688858668416;5186.974065129651;4754.572088512051;4755.5719985201495;4757.072370887644;4763.976180119146;4779.617630589544;5658.886822263614;5708.429157084258;5709.857253568694;5710.371859095496;5715.8856822864145;5482.698451585042;5516.503514683698;5522.834314970557;5522.9447705524035;5549.805756798654;5635.182898479779;5750.137479378127;5750.856228594319;5775.306963164448;5780.884382312414;5483.259759932358;5492.972535137458;5504.724763761876;5517.834464966058;5522.944770552243;5539.501444869981;5549.556035517068;5551.583631227755;5562.316700915631;5572.749226284745;5330.733463326896;5394.433584473731;5412.945870541244;5447.155690867922;5469.42571030052;5325.041492531227;5387.111126664056;5388.730563471732;5398.1902714593125;5399.730013499231;5243.973780131075;5280.1815718563685;5308.230306605444;5326.09456392422;5375.59683023767;5477.260569823023;5477.780888764564;5496.422875598005;5498.037843377313;5537.972310138423;5163.715995620277;5237.423883372902;5305.31030965972;5312.601554883322;5401.945980540144 02:34:56 INFO - PROCESS | 23747 | |1;ext.html;515.5076901559011;515.6983164848562;521.3795583255925;538.7844862055179;552.3620218647463;28995.27511812206;37331;37630.8118459408;37643.247135057354;37676.24647507048;41384.17231655365;41722.7913860431;41874;41898.37152442716;41913.790431047804;8500.872486912702;8682.088380720028;8712.956435217846;8713.390062695615;8714.694985675502;8463.915360846406;8613.956930215372;8618.396712230146;8620.224179823814;8817.95591022044;8751.824963500727;8820.073892241318;8835.337349698766;8853.5573221339;8858.689945851896;8757.737267881941;8819.867701984474;8825.867611985825;8840.425372350808;8843.292536597057;8551.871721924175;8638.697645582375;8639.827203455958;8651.6971905983;8894.822103557957;40205.597944020476;40501;40544.391834122514;40593.18813623711;40631.39052914209;3443.4490481522835;3489.3719130556487;3539.699125574329;3883.203943191639;3973.5033120859894;30625;30703.846480767676;30706.38587228265;30720.69279307201;32265.51601725976;3353.195233144052;3356.865725370982;3361.0757041813454;3362.69735723786;3616.150204701893;260401;261250;261466.9999999981;262023;262918;41786;42228.78885605552;42417.57582424198;57948.710256448445;58502.70748646229;41134;41325.79337103295;41355;41366.79316603458;41389.586104139176;15194.164320962233;15348.155851428279;15350.846491535165;15351.539453816404;15370;12370.13409061357;12415.44130514129;12421.627351179479;12424.503019879103;12446.937765311115;14433.855661443462;14543.418263269563;14545.34545945435;14560.41758329655;14626.853731462763;5840.88318233633;5929.881402372014;5942.376050514634;5947.672877991752;5969.253843269591;975.3124047546463;989.9803202701229;1111.4831603304501;1139.8689150747605;1148.1675785055768;29176.85411572971;29328.560071598942;29382.706172938426;29574;29729.405411892072;824.5423789796721;1010.6715317521835;1054.9736256593494;1084.3764835219622;1090.8472813806075;13001.219926804422;13717.45130194801;13957.371918263703;15667;15952.76070858938;295567;300037.49793761555;300760;301080;301397;45809.31286030712;51376.48623513717;52522.94954100973;52626.73686631619;52721;1334.873187047229;1373.8351397832323;1384.6884450998446;1394.5816255123423;1405.213080674805;26060.739392605832;26731.33171670724;27044.729552704222;27496.450070998868;27621.585676214472;40606.79696601498;40889.38665919954;43127.35308970431;48846.75576622236;49760;200424;201218;202336;202512;203553;32676.83661581677;33083.834580826944;33175.50236746499;33261.833690831394;33374.66625333716;42404.94734288309;43890.341644874716;44121.55878441175;44203.778981104886;44411.55588444074;37199.62800371962;37788.81105594454;37842.43236351402;38896.22207555889;39049.6095039046;37619.81190094032;38001.42997854979;38956;38979.610203897595;39055.21889562136;36717.816410917774;37487.81256093702;37921.4311785329;37991.81004094962;38015.239695206496;31735.682643174197;33727.325453491285;34098;34368;35851.82074089613;24591.631125532775;25264.621030684186;25587.488250235263;25751.356216094748;26055.218343449727 02:34:56 INFO - PROCESS | 23747 | |2;jquery.html;363.1538515259444;365.1346309247083;366.1121779684266;367.27279985628456;369.5620689482965;13938.257717785276;16968.91515542422;17264.654706905887;17437.47687569372;18822.62354752906;17772.911135444305;17793;17800.82199178011;17820.554486137822;18181.818181818177;5341.4658534146665;5389.757460914248;5512.228288039678;5543.417941116185;5579.38626751057;4048.9797551012202;5531.115021596545;5964.821055368346;6195.380461953813;6216.844578885519;6143.508519318466;6144.139820425144;6148.108524263979;6176.814695559118;6177.5057995360485;5898.203742494751;6267.905981410283;6275.623462592236;6285.025820997753;6287.937120628827;5494.835154945358;5495.065838807413;5506.64206826555;5512.889742205133;5516.7517461713915;20919.163233470645;21174.576508469898;21272.255471058437;21286;21420.678689819666;2248.6964259824877;2317.2237300504353;2942.779291553121;2973.2742179179027;3033.4994725870206;12930.676733081655;13008.86991130086;13607.31963401826;13772.931135344359;13840.238786866717;1833.8532917366579;1855.443366989911;1859.1169194632575;1912.8660993730443;1955.3742802303268;61086.69456652688;63586;64821;65916.67041664809;66039.33960660428;10189.796204075878;10363.844542331872;10425;10497.580096796195;10500.737481563023;13965.860341396456;14021.228832414316;14077;14088.929555352157;14096.929515352358;7846.5292082475235;7926.920730792618;7981.760547183594;8006.639701213459;8039.799005024921;7770.611469426506;7797.181295963842;7838.294553490213;7922.247386498273;7925.088614809255;4538.818447262072;4563.680542362003;4576.519465456146;4642.837500687459;4677.579017888406;1718.4415065103642;1756.1394916490829;1787.1511032259573;1808.7919889212646;1817.681905666503;817.1828171828172;837.5560952695081;918.7886786039248;962.100436092256;978.0854900667898;15932.681346373007;15965.680686386208;17091.401800936907;17458.825411745973;17550;839.9798484644318;872.7163671806561;919.2783664823082;934.6541779541614;940.5626383731598;6180.02239283425;6398.29618741938;6659.067730517731;6667.566608170453;6686.431653309426;222743;223748;442148;451799;453187;75218;77258.22741772623;77718;78293.60853195812;81765.18234817576;487.9609631229493;503.1572116704505;503.4990184766181;504.6719632239074;506.1496685568281;10277.229207809294;10399.688009359732;10646.8402973957;10695.304805187638;10812.135029197489;28102;33235.83382083171;33368.33263334768;33999;34624.307513850086;46805;48689.75655121702;48785.75607121942;49119.508804912926;49366;7879.356661551927;7903.249191326815;8017.238362355567;8159.347252219927;8284.25441710249;8463.280621147025;10496.737581560523;12017.399130043637;12147.210431321935;12632.6841828955;8486.533240671823;9884.901150988686;9966.053224943618;10468.371897686164;10648;10179.338343007681;10378.35584210625;10545.314554554236;10634.14926805869;10943.56225750993;10780.892191077988;11036.227464077758;11099.223054386115;11128.38793866345;11201.43992800373;8053.275205231557;8221.095679475133;8247.257746802816;8300.252977232078;8341.374396920133;9296.349255552046;10751.086157676686;10855.945720271347;10879.456027198767;10932.289401188897 02:34:56 INFO - PROCESS | 23747 | |3;mootools.html;1271.9682007949793;1467.2150399536247;1482.3625840888417;1636.2718590227346;1792.48914059493;7769.261920117587;7958.76123716288;7962.800929976754;7966.2830345268985;7970.481918675282;7784.610769461533;7946.562939038351;7948.483348582338;7967.960160199205;7968.96015519923;2006.408109607662;2307.0541078157958;2337.275444612171;2345.9530809383887;2359.6224604063354;2318.8840557972035;2342.1919437793936;2360.9409764755846;2363.302825666424;2365.31405892291;2301.8503797253125;2302.930912072632;2303.9654405183937;2310.9653355199684;2311.52613714189;2251.133313674239;2319.2694301295123;2320.2575175943703;2322.1640209524558;2323.8605683659034;2267.580497607948;2278.5442911417617;2294.162630639821;2329.7087864017;2329.871857047862;8069;8143.75568732939;8152.103268640445;8155.062167850714;8165.469244499089;4819.08437396897;4993.7503124843615;4995.300657907896;4995.450500444985;4999.3000979862845;3116.06518044588;3144.4497212987635;3173.873045078194;3232.402005628943;3248.6264079630673;961.365498770815;964.5948701545298;967.6129548180784;1897.2411035585876;1953.45303315072;10861.945690271497;10971.067459265973;11022.669319920495;11039.503222354933;11056.668299951014;4036.3138266494766;4071.42999980003;4085.101277718897;4338.132373525307;4346.130773845181;8811.955940220387;8825.249853762374;8846.823063538694;8874.112588741074;8886.955565222133;4301.741895486281;4647.953520464752;4818.71087734737;4874.341963834908;4901.3383193268455;4303.225419424533;4309.978450107792;4319.460067491564;4347.152305300499;4349.826006959686;3558.1104723819044;3572.91067723309;3597.352476554193;3620.4569314602495;3638.599754027055;1028.141501845952;1055.2454994678842;1071.4482041748506;1074.0731506644331;1079.0558261521169;1291.3026965438746;1294.2299331897507;1311.3115614302376;1311.4557458654742;1323.8345206849144;7674.731384401519;7701.268379503938;7828.765137045898;7844.764657060297;7845.686172553034;489.67926008464514;500.1322705106637;502.58787794009294;503.70029832249753;504.60892808073305;5657.915131273035;5662.065759149777;5700.087985922232;5724.599278050497;5794.50746686528;9328.860067098998;9941.502924853872;9974.501274936225;10054.095131438205;10099;9831.508424578742;9894.06006429388;9954.601815927283;9971.40171589707;10002.299839011199;7448.217937116633;7649.655765490677;7661.042369703787;7662;7740.071191457061;7344.632768361667;7376.299251571092;7413.703451861865;7414.258574142758;7414.443916706161;8756.649734010569;8831.958531662076;8848.823023539622;8941.92696876379;8957.955210224169;8868.290536757173;8999.685011024583;9095.135962083592;9149.215902898872;9151.039140890376;6004.249468816398;6437.5171862111465;6624.503162262946;6647.4682025438815;6797.116374871235;7671.846563068819;7681.116671582839;7692.230776922263;7728.961355193188;7731.458797884094;6773.288804675438;7012.754553590804;7018.473614478832;7111.182214045451;7153.105861767279;6772.11962444879;6776.254611992776;6859.1083159190985;6885.036094946611;6901.516893817385;7064.540804847668;7089.326513981164;7136.643167841691;7349.448791340564;7366.815829604303;6675.397904502982;6694.4644428444635;6703.798886033427;6710.899336510054;6738.494612903954;6707.865842683216;6781.254062053269;6829.6585170742255;6829.795106146824;6856.451483881177 02:34:56 INFO - PROCESS | 23747 | |4;prototype.html;334.6904113694832;335.7448339262161;339.8029143097004;345.3576347992733;348.0741228332634;5819.068948968166;5839.9708001459985;5846.152307915355;5858.619189752663;5870;5746.540276777858;5753.568482363829;5767.711614419283;5771.192033115367;5832.475077243047;4569.291759777231;4573.588377046065;4575.428071491064;4576.039031803325;4578.862634120982;4572.291294849287;4581.954180458203;4586.7018643788215;4588.793504292298;4591.035882464686;4362.389265502832;4449.421575195236;4540.06928579642;4546.590806827385;4547.931781023287;4456.509783923766;4462.776861156962;4468.843590474334;4473.2395492766145;4474.1499115168335;3885.203533275672;3886.6696330811915;3890.961090389088;3892.630200130983;3896.181801821621;5572.219889215513;5587.1339942309005;5599.636023658449;5613.607047506676;5617.185508101344;5194.532492075694;5203.505666961632;5205.453427390107;5207.583393328525;5208.8958220835375;6193.5045196384635;6216.751329946796;6241.843953901143;6249.0626406039;6276.905846412307;4159.480064991876;4247.660187185049;4248.08666136779;4269.231538323101;4334.5882141196535;6255.655938923357;6335.5565110442285;6461.547691661585;6486.935130648681;6506.707198176094;4100.7334523255895;4392.582704643054;4397.274449715761;4398.670099742532;4408.845690400821;4350.760708161019;4453.599176074104;4454.086912182995;4455.108978204372;4459.576340247671;5139.897202055938;5143.897122057538;5156.226566015128;5157.922631160535;5169.9741501293;6216.036514340284;6225.128482012522;6228.968855155786;6230.501559875199;6231.875362492816;1537.7923980262744;1556.4630202580092;1556.6186284360178;1557.7196104701036;1557.8052743407075;1003.1122456625939;1020.7754294055296;1040.6201736366172;1044.0759927464096;1054.383185836279;5912.467877890925;5927.022041363213;5943.940560594338;5948.196993405922;5948.553858460633;6429.324920883333;6429.38920802523;6434.292227854932;6443.48452123829;6446.290908000116;5929.762809487658;5933.080372542263;5933.821985340447;5936.28764548257;5937.732802023919;3447.207142357272;3447.517347571342;3477.913052173716;3478.7912725236565;3479.0432631026165;6654;6678.398944094957;6746.392824645805;6872;6877.724891004404;6651.135352404156;6675.632840193836;6681.1314529110905;6682.398584127452;6695.933040669531;6820.31796820324;6835.726570937107;6841.521093523505;6845;6845.726170953106;6199.16311297969;6316.8313861935685;6545.116409284876;6585.176852893388;6585.934140658724;6383.138276332821;6404.423601875854;6407.583507072025;6422.486201103807;6450.548461607643;6799.966000169968;6802.523823332319;6811.182658081062;6815.284395138638;6829.146356705412;4401.163778882003;4456.019675671347;4456.487503936959;4457.197704413107;4457.465104187519;6327.462165715781;6507.349265073644;6508;6511.446527045254;6512.641804700787;6206.937930620636;6299.716512757029;6299.960506516373;6305.842353941188;6311.084892690443;6304.275008374096;6312.495000399865;6313.779017734358;6323.620582765049;6329.588576742497;6213.068039793886;6214.533909956862;6219.284782250099;6222.626642401289;6232.5325600581045;6142.9078563820685;6343.429091381798;6352.301246862934;6359.109724638647;6367.554271200971;6183.628982261079;6189.257289125334;6225.719842607003;6227.252729672468;6237.4698150657705 02:34:56 INFO - PROCESS | 23747 | |5;yui.html;680.9761658341959;698.3819319901888;723.4574069447914;743.6579173580153;763.7174245529155;13329;13469.59591212264;13494.190348579092;13507.864921350783;13531.797023044637;12532.686682832933;12913.870861291385;12914.677133071678;12924;12924.224546527215;671.1576970901524;681.2880539835859;817.5830326533481;838.1325328285226;843.2073850580465;837.2255663511258;841.3185319890878;841.5161282262724;843.4981186194204;844.6030365728128;705.1538154214937;885.8538341173698;888.2849306308419;888.6223355074068;889.0620395482763;862.8921384826897;878.2885862451403;878.9692360767374;879.3097418526426;879.4151888993812;642.0209180998967;646.2568046746233;646.524804268862;647.3623480871385;647.5078940005583;13239.470421183141;13297.335133243396;13338.133021353678;13344;13357.198568085945;12244;12771.361431928459;12854.949543130559;12907.483700651963;13177.341132943411;9782.364146330467;10037.749056273651;10182.643607473703;10308.381497110122;10719.410432426213;3598.604153543108;3606.9098272543397;3632.54593175853;3665.505156803824;3673.779573225615;48542.514574854154;48621.75689121567;48715;48790.26814597784;48853.75573122147;9609;10260.179185665129;10344.896551034544;10451.692725222796;10472.583566606309;18952.62094758097;18972.14625341863;18993.525161871064;19000.144993475325;19028.904855475634;7578;7829.882551761728;7933.722319718782;8025.759227223076;8044.637991290406;4149.730267532601;4218.409422680827;4259.190753756776;4273.487181538236;4277.486701595828;3151.7636177286795;3158.3525377297597;3177.6186857576777;3179.3164469639137;3181.618205815317;524.3288590604033;631.3497097989078;634.3814780588889;647.5564238496645;654.0548906829681;567.843842943194;594.881023795234;604.6644112517595;606.5753972219464;624.1511544299749;8191.139930307351;8290.295324897452;8652.54798806331;8799;8904.688335908342;532.8428113706466;587.665030932373;634.3054355480833;635.1235295292466;637.7480895046431;3745.176061266517;4149.771762553089;4308.138372325548;4366.388705581221;4372.256716358163;58421;60302.49243768941;60355;60403.69798151069;60565.57737690443;50121;53139.46860531423;53177.202341964905;53177.73411132997;53335.19997200045;45968.54031459709;46297.07405851864;46485.76757116193;46637.766811165726;46812;8852.911470885208;9002;9042.457452552868;9053.864192037256;9151.405158664666;32532.34935301328;32789.83605081959;33179.83410083031;33228.33543329168;33828;43684.344734828366;44881.775591121834;45790.542094578625;45919.54080459286;46071.76964115158;10904.890951090387;10940.617078402218;10984.395858227874;11093.889061109285;11343.943280283545;8225.653018351868;11168.385738784445;11823.940880295544;12117.15179937396;12138.575149869712;11034.282771620141;11103.611373602209;11194.384308863091;11310.60412885545;11357.09143268553;10153.340032897839;10634.574617015232;10694.304870183412;10709.946450268011;10745.623903163352;11008.669739907815;11048.558057677603;11170.832437513607;11340.716482087684;11453.828192576952;9975.850362244428;10131.341462804894;10337.328073675488;10601.787964240517;10861.40262285582;9451.905480945103;9660.855087173839;9830.164436023018;10261.302115588087;10335 02:34:56 INFO - PROCESS | 23747 | __end_tp_report 02:34:56 INFO - PROCESS | 23747 | __start_cc_report 02:34:56 INFO - PROCESS | 23747 | _x_x_mozilla_cycle_collect,904 02:34:56 INFO - PROCESS | 23747 | __end_cc_report 02:34:56 INFO - PROCESS | 23747 | __startTimestamp1456396496812__endTimestamp 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | ------- Summary: start ------- 02:34:56 INFO - PROCESS | 23747 | Number of tests: 6 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#0] dojo.html Cycles:165 Average:5146.91 Median:5325.04 stddev:549.67 (10.3%) stddev-sans-first:527.58 02:34:56 INFO - PROCESS | 23747 | Values: 3108.5 3135.3 3168.5 3169.7 3197.6 5019.0 5145.5 5154.1 5161.4 5196.8 5132.3 5165.8 5169.3 5174.3 5257.3 4656.5 4727.9 4778.5 4793.9 4795.5 4654.0 4676.4 4740.7 4742.3 4852.7 4749.4 4757.1 4767.2 4790.3 4806.4 4747.2 4757.0 4760.4 4770.7 4787.7 4560.8 4667.8 4740.4 4749.5 4754.8 4995.6 5020.2 5027.4 5032.3 5080.9 5420.6 5532.2 5540.5 5544.6 5544.8 5525.8 5548.9 5565.1 5581.1 5630.6 5178.5 5185.7 5187.1 5189.2 5200.9 5618.4 5620.5 5620.6 5631.3 5709.3 5446.2 5456.4 5458.7 5465.8 5471.3 5520.6 5534.3 5538.7 5546.0 5596.0 5393.4 5512.9 5529.8 5553.0 5600.2 5474.0 5501.5 5506.4 5509.8 5511.3 4255.6 4302.7 4306.4 4310.1 4327.4 3863.3 3866.8 3880.5 3897.7 3909.0 5109.2 5130.7 5153.5 5160.1 5193.0 5454.5 5508.7 5542.9 5546.2 5547.7 5157.4 5165.5 5185.1 5185.7 5187.0 4754.6 4755.6 4757.1 4764.0 4779.6 5658.9 5708.4 5709.9 5710.4 5715.9 5482.7 5516.5 5522.8 5522.9 5549.8 5635.2 5750.1 5750.9 5775.3 5780.9 5483.3 5493.0 5504.7 5517.8 5522.9 5539.5 5549.6 5551.6 5562.3 5572.7 5330.7 5394.4 5412.9 5447.2 5469.4 5325.0 5387.1 5388.7 5398.2 5399.7 5244.0 5280.2 5308.2 5326.1 5375.6 5477.3 5477.8 5496.4 5498.0 5538.0 5163.7 5237.4 5305.3 5312.6 5401.9 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#1] ext.html Cycles:180 Average:42290.42 Median:37625.31 stddev:67091.73 (178.3%) stddev-sans-first:67206.62 02:34:56 INFO - PROCESS | 23747 | Values: 515.5 515.7 521.4 538.8 552.4 28995.3 37331.0 37630.8 37643.2 37676.2 41384.2 41722.8 41874.0 41898.4 41913.8 8500.9 8682.1 8713.0 8713.4 8714.7 8463.9 8614.0 8618.4 8620.2 8818.0 8751.8 8820.1 8835.3 8853.6 8858.7 8757.7 8819.9 8825.9 8840.4 8843.3 8551.9 8638.7 8639.8 8651.7 8894.8 40205.6 40501.0 40544.4 40593.2 40631.4 3443.4 3489.4 3539.7 3883.2 3973.5 30625.0 30703.8 30706.4 30720.7 32265.5 3353.2 3356.9 3361.1 3362.7 3616.2 260401.0 261250.0 261467.0 262023.0 262918.0 41786.0 42228.8 42417.6 57948.7 58502.7 41134.0 41325.8 41355.0 41366.8 41389.6 15194.2 15348.2 15350.8 15351.5 15370.0 12370.1 12415.4 12421.6 12424.5 12446.9 14433.9 14543.4 14545.3 14560.4 14626.9 5840.9 5929.9 5942.4 5947.7 5969.3 975.3 990.0 1111.5 1139.9 1148.2 29176.9 29328.6 29382.7 29574.0 29729.4 824.5 1010.7 1055.0 1084.4 1090.8 13001.2 13717.5 13957.4 15667.0 15952.8 295567.0 300037.5 300760.0 301080.0 301397.0 45809.3 51376.5 52522.9 52626.7 52721.0 1334.9 1373.8 1384.7 1394.6 1405.2 26060.7 26731.3 27044.7 27496.5 27621.6 40606.8 40889.4 43127.4 48846.8 49760.0 200424.0 201218.0 202336.0 202512.0 203553.0 32676.8 33083.8 33175.5 33261.8 33374.7 42404.9 43890.3 44121.6 44203.8 44411.6 37199.6 37788.8 37842.4 38896.2 39049.6 37619.8 38001.4 38956.0 38979.6 39055.2 36717.8 37487.8 37921.4 37991.8 38015.2 31735.7 33727.3 34098.0 34368.0 35851.8 24591.6 25264.6 25587.5 25751.4 26055.2 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#2] jquery.html Cycles:180 Average:23273.62 Median:228862.91 stddev:62111.86 (27.1%) stddev-sans-first:62262.28 02:34:56 INFO - PROCESS | 23747 | Values: 363.2 365.1 366.1 367.3 369.6 13938.3 16968.9 17264.7 17437.5 18822.6 17772.9 17793.0 17800.8 17820.6 18181.8 5341.5 5389.8 5512.2 5543.4 5579.4 4049.0 5531.1 5964.8 6195.4 6216.8 6143.5 6144.1 6148.1 6176.8 6177.5 5898.2 6267.9 6275.6 6285.0 6287.9 5494.8 5495.1 5506.6 5512.9 5516.8 20919.2 21174.6 21272.3 21286.0 21420.7 2248.7 2317.2 2942.8 2973.3 3033.5 12930.7 13008.9 13607.3 13772.9 13840.2 1833.9 1855.4 1859.1 1912.9 1955.4 61086.7 63586.0 64821.0 65916.7 66039.3 10189.8 10363.8 10425.0 10497.6 10500.7 13965.9 14021.2 14077.0 14088.9 14096.9 7846.5 7926.9 7981.8 8006.6 8039.8 7770.6 7797.2 7838.3 7922.2 7925.1 4538.8 4563.7 4576.5 4642.8 4677.6 1718.4 1756.1 1787.2 1808.8 1817.7 817.2 837.6 918.8 962.1 978.1 15932.7 15965.7 17091.4 17458.8 17550.0 840.0 872.7 919.3 934.7 940.6 6180.0 6398.3 6659.1 6667.6 6686.4 222743.0 223748.0 442148.0 451799.0 453187.0 75218.0 77258.2 77718.0 78293.6 81765.2 488.0 503.2 503.5 504.7 506.1 10277.2 10399.7 10646.8 10695.3 10812.1 28102.0 33235.8 33368.3 33999.0 34624.3 46805.0 48689.8 48785.8 49119.5 49366.0 7879.4 7903.2 8017.2 8159.3 8284.3 8463.3 10496.7 12017.4 12147.2 12632.7 8486.5 9884.9 9966.1 10468.4 10648.0 10179.3 10378.4 10545.3 10634.1 10943.6 10780.9 11036.2 11099.2 11128.4 11201.4 8053.3 8221.1 8247.3 8300.3 8341.4 9296.3 10751.1 10855.9 10879.5 10932.3 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#3] mootools.html Cycles:180 Average:5585.10 Median:6220.88 stddev:2951.26 (47.4%) stddev-sans-first:2941.73 02:34:56 INFO - PROCESS | 23747 | Values: 1272.0 1467.2 1482.4 1636.3 1792.5 7769.3 7958.8 7962.8 7966.3 7970.5 7784.6 7946.6 7948.5 7968.0 7969.0 2006.4 2307.1 2337.3 2346.0 2359.6 2318.9 2342.2 2360.9 2363.3 2365.3 2301.9 2302.9 2304.0 2311.0 2311.5 2251.1 2319.3 2320.3 2322.2 2323.9 2267.6 2278.5 2294.2 2329.7 2329.9 8069.0 8143.8 8152.1 8155.1 8165.5 4819.1 4993.8 4995.3 4995.5 4999.3 3116.1 3144.4 3173.9 3232.4 3248.6 961.4 964.6 967.6 1897.2 1953.5 10861.9 10971.1 11022.7 11039.5 11056.7 4036.3 4071.4 4085.1 4338.1 4346.1 8812.0 8825.2 8846.8 8874.1 8887.0 4301.7 4648.0 4818.7 4874.3 4901.3 4303.2 4310.0 4319.5 4347.2 4349.8 3558.1 3572.9 3597.4 3620.5 3638.6 1028.1 1055.2 1071.4 1074.1 1079.1 1291.3 1294.2 1311.3 1311.5 1323.8 7674.7 7701.3 7828.8 7844.8 7845.7 489.7 500.1 502.6 503.7 504.6 5657.9 5662.1 5700.1 5724.6 5794.5 9328.9 9941.5 9974.5 10054.1 10099.0 9831.5 9894.1 9954.6 9971.4 10002.3 7448.2 7649.7 7661.0 7662.0 7740.1 7344.6 7376.3 7413.7 7414.3 7414.4 8756.6 8832.0 8848.8 8941.9 8958.0 8868.3 8999.7 9095.1 9149.2 9151.0 6004.2 6437.5 6624.5 6647.5 6797.1 7671.8 7681.1 7692.2 7729.0 7731.5 6773.3 7012.8 7018.5 7111.2 7153.1 6772.1 6776.3 6859.1 6885.0 6901.5 7064.5 7089.3 7136.6 7349.4 7366.8 6675.4 6694.5 6703.8 6710.9 6738.5 6707.9 6781.3 6829.7 6829.8 6856.5 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#4] prototype.html Cycles:180 Average:5233.28 Median:5919.74 stddev:1594.79 (26.9%) stddev-sans-first:1556.30 02:34:56 INFO - PROCESS | 23747 | Values: 334.7 335.7 339.8 345.4 348.1 5819.1 5840.0 5846.2 5858.6 5870.0 5746.5 5753.6 5767.7 5771.2 5832.5 4569.3 4573.6 4575.4 4576.0 4578.9 4572.3 4582.0 4586.7 4588.8 4591.0 4362.4 4449.4 4540.1 4546.6 4547.9 4456.5 4462.8 4468.8 4473.2 4474.1 3885.2 3886.7 3891.0 3892.6 3896.2 5572.2 5587.1 5599.6 5613.6 5617.2 5194.5 5203.5 5205.5 5207.6 5208.9 6193.5 6216.8 6241.8 6249.1 6276.9 4159.5 4247.7 4248.1 4269.2 4334.6 6255.7 6335.6 6461.5 6486.9 6506.7 4100.7 4392.6 4397.3 4398.7 4408.8 4350.8 4453.6 4454.1 4455.1 4459.6 5139.9 5143.9 5156.2 5157.9 5170.0 6216.0 6225.1 6229.0 6230.5 6231.9 1537.8 1556.5 1556.6 1557.7 1557.8 1003.1 1020.8 1040.6 1044.1 1054.4 5912.5 5927.0 5943.9 5948.2 5948.6 6429.3 6429.4 6434.3 6443.5 6446.3 5929.8 5933.1 5933.8 5936.3 5937.7 3447.2 3447.5 3477.9 3478.8 3479.0 6654.0 6678.4 6746.4 6872.0 6877.7 6651.1 6675.6 6681.1 6682.4 6695.9 6820.3 6835.7 6841.5 6845.0 6845.7 6199.2 6316.8 6545.1 6585.2 6585.9 6383.1 6404.4 6407.6 6422.5 6450.5 6800.0 6802.5 6811.2 6815.3 6829.1 4401.2 4456.0 4456.5 4457.2 4457.5 6327.5 6507.3 6508.0 6511.4 6512.6 6206.9 6299.7 6300.0 6305.8 6311.1 6304.3 6312.5 6313.8 6323.6 6329.6 6213.1 6214.5 6219.3 6222.6 6232.5 6142.9 6343.4 6352.3 6359.1 6367.6 6183.6 6189.3 6225.7 6227.3 6237.5 02:34:56 INFO - PROCESS | 23747 | 02:34:56 INFO - PROCESS | 23747 | [#5] yui.html Cycles:180 Average:13906.21 Median:45855.04 stddev:16236.09 (35.4%) stddev-sans-first:16251.26 02:34:56 INFO - PROCESS | 23747 | Values: 681.0 698.4 723.5 743.7 763.7 13329.0 13469.6 13494.2 13507.9 13531.8 12532.7 12913.9 12914.7 12924.0 12924.2 671.2 681.3 817.6 838.1 843.2 837.2 841.3 841.5 843.5 844.6 705.2 885.9 888.3 888.6 889.1 862.9 878.3 879.0 879.3 879.4 642.0 646.3 646.5 647.4 647.5 13239.5 13297.3 13338.1 13344.0 13357.2 12244.0 12771.4 12854.9 12907.5 13177.3 9782.4 10037.7 10182.6 10308.4 10719.4 3598.6 3606.9 3632.5 3665.5 3673.8 48542.5 48621.8 48715.0 48790.3 48853.8 9609.0 10260.2 10344.9 10451.7 10472.6 18952.6 18972.1 18993.5 19000.1 19028.9 7578.0 7829.9 7933.7 8025.8 8044.6 4149.7 4218.4 4259.2 4273.5 4277.5 3151.8 3158.4 3177.6 3179.3 3181.6 524.3 631.3 634.4 647.6 654.1 567.8 594.9 604.7 606.6 624.2 8191.1 8290.3 8652.5 8799.0 8904.7 532.8 587.7 634.3 635.1 637.7 3745.2 4149.8 4308.1 4366.4 4372.3 58421.0 60302.5 60355.0 60403.7 60565.6 50121.0 53139.5 53177.2 53177.7 53335.2 45968.5 46297.1 46485.8 46637.8 46812.0 8852.9 9002.0 9042.5 9053.9 9151.4 32532.3 32789.8 33179.8 33228.3 33828.0 43684.3 44881.8 45790.5 45919.5 46071.8 10904.9 10940.6 10984.4 11093.9 11343.9 8225.7 11168.4 11823.9 12117.2 12138.6 11034.3 11103.6 11194.4 11310.6 11357.1 10153.3 10634.6 10694.3 10709.9 10745.6 11008.7 11048.6 11170.8 11340.7 11453.8 9975.9 10131.3 10337.3 10601.8 10861.4 9451.9 9660.9 9830.2 10261.3 10335.0 02:34:56 INFO - PROCESS | 23747 | -------- Summary: end -------- 02:34:56 INFO - PROCESS | 23747 | 02:34:57 INFO - TEST-INFO | 23747: exit 0 02:34:57 INFO - TEST-OK | dromaeo_css | took 1113022ms 02:34:57 INFO - TEST-START | kraken 02:34:57 INFO - operating with platform_type : linux_ 02:34:57 INFO - Initialising browser for kraken test... 02:34:57 INFO - TEST-INFO | started process 23937 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjkGUQn/profile http://localhost:34790/getInfo.html) 02:35:01 INFO - PROCESS | 23937 | __metrics Screen width/height:1600/1200 02:35:01 INFO - PROCESS | 23937 | colorDepth:24 02:35:01 INFO - PROCESS | 23937 | Browser inner width/height: 1024/697 02:35:01 INFO - PROCESS | 23937 | __metrics 02:35:02 INFO - PROCESS | 23937 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:03 INFO - TEST-INFO | 23937: exit 0 02:35:03 INFO - Browser initialized. 02:35:03 INFO - Running cycle 1/1 for kraken test... 02:35:03 INFO - TEST-INFO | started process 24023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjkGUQn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:15 INFO - PROCESS | 24023 | RSS: Main: 147853312 02:35:15 INFO - PROCESS | 24023 | 02:35:18 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34790/tests/kraken/driver.html?testName=audio-beat-detection) 02:35:18 INFO - PROCESS | 24023 | RSS: Main: 190558208 02:35:18 INFO - PROCESS | 24023 | 02:35:21 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34790/tests/kraken/driver.html?testName=audio-dft) 02:35:21 INFO - PROCESS | 24023 | RSS: Main: 182235136 02:35:21 INFO - PROCESS | 24023 | 02:35:24 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34790/tests/kraken/driver.html?testName=audio-fft) 02:35:25 INFO - PROCESS | 24023 | RSS: Main: 165724160 02:35:25 INFO - PROCESS | 24023 | 02:35:27 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34790/tests/kraken/driver.html?testName=audio-oscillator) 02:35:27 INFO - PROCESS | 24023 | RSS: Main: 166301696 02:35:27 INFO - PROCESS | 24023 | 02:35:30 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34790/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:35:30 INFO - PROCESS | 24023 | RSS: Main: 171364352 02:35:30 INFO - PROCESS | 24023 | 02:35:33 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34790/tests/kraken/driver.html?testName=imaging-darkroom) 02:35:34 INFO - PROCESS | 24023 | RSS: Main: 169287680 02:35:34 INFO - PROCESS | 24023 | 02:35:37 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34790/tests/kraken/driver.html?testName=imaging-desaturate) 02:35:38 INFO - PROCESS | 24023 | RSS: Main: 170528768 02:35:38 INFO - PROCESS | 24023 | 02:35:41 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34790/tests/kraken/driver.html?testName=json-parse-financial) 02:35:41 INFO - PROCESS | 24023 | RSS: Main: 170921984 02:35:41 INFO - PROCESS | 24023 | 02:35:43 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34790/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:35:43 INFO - PROCESS | 24023 | RSS: Main: 181645312 02:35:43 INFO - PROCESS | 24023 | 02:35:45 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:35:46 INFO - PROCESS | 24023 | RSS: Main: 180625408 02:35:46 INFO - PROCESS | 24023 | 02:35:48 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:35:48 INFO - PROCESS | 24023 | RSS: Main: 193536000 02:35:48 INFO - PROCESS | 24023 | 02:35:51 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:35:51 INFO - PROCESS | 24023 | RSS: Main: 198815744 02:35:51 INFO - PROCESS | 24023 | 02:35:54 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:35:54 INFO - PROCESS | 24023 | RSS: Main: 198156288 02:35:54 INFO - PROCESS | 24023 | 02:35:56 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:34790/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34790/tests/kraken/driver.html?testName=ai-astar) 02:35:57 INFO - PROCESS | 24023 | RSS: Main: 259137536 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | __start_tp_report 02:35:57 INFO - PROCESS | 24023 | _x_x_mozilla_page_load 02:35:57 INFO - PROCESS | 24023 | _x_x_mozilla_page_load_details 02:35:57 INFO - PROCESS | 24023 | |i|pagename|runs| 02:35:57 INFO - PROCESS | 24023 | |0;ai-astar;109;111;106;110;110;111;99;111;110;110 02:35:57 INFO - PROCESS | 24023 | |1;audio-beat-detection;167;126;146;163;125;158;152;133;167;128 02:35:57 INFO - PROCESS | 24023 | |2;audio-dft;161;160;162;160;162;160;160;170;161;163 02:35:57 INFO - PROCESS | 24023 | |3;audio-fft;73;73;92;93;74;76;73;119;93;73 02:35:57 INFO - PROCESS | 24023 | |4;audio-oscillator;95;96;138;95;96;96;145;96;96;137 02:35:57 INFO - PROCESS | 24023 | |5;imaging-gaussian-blur;119;115;114;115;115;115;115;115;115;114 02:35:57 INFO - PROCESS | 24023 | |6;imaging-darkroom;146;146;145;145;145;146;145;145;145;146 02:35:57 INFO - PROCESS | 24023 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;97;96 02:35:57 INFO - PROCESS | 24023 | |8;json-parse-financial;58;57;57;58;57;56;59;67;54;55 02:35:57 INFO - PROCESS | 24023 | |9;json-stringify-tinderbox;68;70;68;69;69;69;69;68;69;75 02:35:57 INFO - PROCESS | 24023 | |10;stanford-crypto-aes;89;81;82;82;81;84;82;82;83;83 02:35:57 INFO - PROCESS | 24023 | |11;stanford-crypto-ccm;123;114;117;138;122;119;115;124;118;126 02:35:57 INFO - PROCESS | 24023 | |12;stanford-crypto-pbkdf2;152;138;153;150;149;145;161;149;150;149 02:35:57 INFO - PROCESS | 24023 | |13;stanford-crypto-sha256-iterative;75;71;72;70;70;72;70;76;70;69 02:35:57 INFO - PROCESS | 24023 | __end_tp_report 02:35:57 INFO - PROCESS | 24023 | __start_cc_report 02:35:57 INFO - PROCESS | 24023 | _x_x_mozilla_cycle_collect,969 02:35:57 INFO - PROCESS | 24023 | __end_cc_report 02:35:57 INFO - PROCESS | 24023 | __startTimestamp1456396557004__endTimestamp 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | ------- Summary: start ------- 02:35:57 INFO - PROCESS | 24023 | Number of tests: 14 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.71 (3.4%) stddev-sans-first:3.94 02:35:57 INFO - PROCESS | 24023 | Values: 109.0 111.0 106.0 110.0 110.0 111.0 99.0 111.0 110.0 110.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:155.00 stddev:17.26 (11.1%) stddev-sans-first:16.64 02:35:57 INFO - PROCESS | 24023 | Values: 167.0 126.0 146.0 163.0 125.0 158.0 152.0 133.0 167.0 128.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.50 stddev:3.03 (1.9%) stddev-sans-first:3.20 02:35:57 INFO - PROCESS | 24023 | Values: 161.0 160.0 162.0 160.0 162.0 160.0 160.0 170.0 161.0 163.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:15.27 (20.4%) stddev-sans-first:15.68 02:35:57 INFO - PROCESS | 24023 | Values: 73.0 73.0 92.0 93.0 74.0 76.0 73.0 119.0 93.0 73.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:21.49 (22.4%) stddev-sans-first:22.19 02:35:57 INFO - PROCESS | 24023 | Values: 95.0 96.0 138.0 95.0 96.0 96.0 145.0 96.0 96.0 137.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:0.44 02:35:57 INFO - PROCESS | 24023 | Values: 119.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:35:57 INFO - PROCESS | 24023 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:35:57 INFO - PROCESS | 24023 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:3.55 (6.2%) stddev-sans-first:3.77 02:35:57 INFO - PROCESS | 24023 | Values: 58.0 57.0 57.0 58.0 57.0 56.0 59.0 67.0 54.0 55.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:2.07 (3.0%) stddev-sans-first:2.13 02:35:57 INFO - PROCESS | 24023 | Values: 68.0 70.0 68.0 69.0 69.0 69.0 69.0 68.0 69.0 75.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.33 (2.8%) stddev-sans-first:0.97 02:35:57 INFO - PROCESS | 24023 | Values: 89.0 81.0 82.0 82.0 81.0 84.0 82.0 82.0 83.0 83.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.50 stddev:6.98 (5.7%) stddev-sans-first:7.38 02:35:57 INFO - PROCESS | 24023 | Values: 123.0 114.0 117.0 138.0 122.0 119.0 115.0 124.0 118.0 126.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.00 stddev:5.82 (3.9%) stddev-sans-first:6.10 02:35:57 INFO - PROCESS | 24023 | Values: 152.0 138.0 153.0 150.0 149.0 145.0 161.0 149.0 150.0 149.0 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - PROCESS | 24023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:2.32 (3.2%) stddev-sans-first:2.09 02:35:57 INFO - PROCESS | 24023 | Values: 75.0 71.0 72.0 70.0 70.0 72.0 70.0 76.0 70.0 69.0 02:35:57 INFO - PROCESS | 24023 | -------- Summary: end -------- 02:35:57 INFO - PROCESS | 24023 | 02:35:57 INFO - TEST-INFO | 24023: exit 0 02:35:57 INFO - TEST-OK | kraken | took 60389ms 02:35:57 INFO - SUITE-END | took 1173s 02:35:58 INFO - Completed test suite (00:19:33) 02:35:58 INFO - Working with test: dromaeo_css 02:35:58 INFO - Generating results file: dromaeo_css 02:35:58 INFO - Working with test: kraken 02:35:58 INFO - Generating results file: kraken 02:35:58 INFO - javascript benchmark 02:35:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:35:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:35:58 INFO - process_Request line: dromaeo_css 6816.57 graph.html#tests=[[72,64,35]] 02:35:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:35:58 INFO - process_Request line: kraken 1519.60 graph.html#tests=[[232,64,35]] 02:35:58 INFO - RETURN: dromaeo_css: 6816.57 02:35:58 INFO - RETURN: kraken: 1519.60 02:35:58 INFO - javascript benchmark 02:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3108.4870996285613, 3135.3259049304424, 3168.508881123427, 3169.7464202863757, 3197.5843140391753, 5019.0, 5145.459726728695, 5154.123798954182, 5161.354830646169, 5196.844094677156, 5132.28148059272, 5165.81919632813, 5169.3279873616375, 5174.275601415805, 5257.290265814114, 4656.5343465653505, 4727.90544189116, 4778.54603812639, 4793.90412191756, 4795.472498025214, 4653.953460465403, 4676.3920690310215, 4740.739259340735, 4742.288656701505, 4852.708837469763, 4749.382580264578, 4757.0723708876785, 4767.189577771787, 4790.257510085942, 4806.399200099988, 4747.240441529373, 4757.0248099139935, 4760.428748550196, 4770.7376094314795, 4787.688800228009, 4560.77196140195, 4667.766611669403, 4740.383750112498, 4749.501302363271, 4754.762261886926, 4995.600351971833, 5020.196768517057, 5027.4469808321055, 5032.295478632957, 5080.872978175576, 5420.620556561003, 5532.197831314437, 5540.473655002808, 5544.584156188262, 5544.77820887164, 5525.834224973257, 5548.889022219533, 5565.1095824667855, 5581.05122129239, 5630.634008789457, 5178.508041736029, 5185.662931909414, 5187.144121219994, 5189.221616757516, 5200.947990520122, 5618.43815618443, 5620.494155526022, 5620.634658747168, 5631.267935168402, 5709.314882214161, 5446.2375267462585, 5456.427075157131, 5458.727063646881, 5465.836024919259, 5471.316085489314, 5520.558355331564, 5534.280543529316, 5538.695371754511, 5545.9722701387045, 5596.0, 5393.406725260218, 5512.862178445491, 5529.778808847682, 5552.972700050504, 5600.243967064475, 5473.972630136904, 5501.477359650827, 5506.421825708243, 5509.752061157257, 5511.311086114236, 4255.6169944705125, 4302.65578753699, 4306.440162778818, 4310.094880075219, 4327.350897365421, 3863.3239183142837, 3866.7873266970587, 3880.495535580413, 3897.7271590988357, 3908.9609103909165, 5109.156989096758, 5130.743462826844, 5153.510416510426, 5160.148575485003, 5192.974035129876, 5454.53636440899, 5508.724563771795, 5542.944570554243, 5546.168074788733, 5547.667139971614, 5157.381114266237, 5165.509276618715, 5185.144451165515, 5185.688858668416, 5186.974065129651, 4754.572088512051, 4755.5719985201495, 4757.072370887644, 4763.976180119146, 4779.617630589544, 5658.886822263614, 5708.429157084258, 5709.857253568694, 5710.371859095496, 5715.8856822864145, 5482.698451585042, 5516.503514683698, 5522.834314970557, 5522.9447705524035, 5549.805756798654, 5635.182898479779, 5750.137479378127, 5750.856228594319, 5775.306963164448, 5780.884382312414, 5483.259759932358, 5492.972535137458, 5504.724763761876, 5517.834464966058, 5522.944770552243, 5539.501444869981, 5549.556035517068, 5551.583631227755, 5562.316700915631, 5572.749226284745, 5330.733463326896, 5394.433584473731, 5412.945870541244, 5447.155690867922, 5469.42571030052, 5325.041492531227, 5387.111126664056, 5388.730563471732, 5398.1902714593125, 5399.730013499231, 5243.973780131075, 5280.1815718563685, 5308.230306605444, 5326.09456392422, 5375.59683023767, 5477.260569823023, 5477.780888764564, 5496.422875598005, 5498.037843377313, 5537.972310138423, 5163.715995620277, 5237.423883372902, 5305.31030965972, 5312.601554883322, 5401.945980540144], "unit": "score", "name": "dojo.html", "value": 5112.754950760795}, {"lowerIsBetter": false, "replicates": [515.5076901559011, 515.6983164848562, 521.3795583255925, 538.7844862055179, 552.3620218647463, 28995.27511812206, 37331.0, 37630.8118459408, 37643.247135057354, 37676.24647507048, 41384.17231655365, 41722.7913860431, 41874.0, 41898.37152442716, 41913.790431047804, 8500.872486912702, 8682.088380720028, 8712.956435217846, 8713.390062695615, 8714.694985675502, 8463.915360846406, 8613.956930215372, 8618.396712230146, 8620.224179823814, 8817.95591022044, 8751.824963500727, 8820.073892241318, 8835.337349698766, 8853.5573221339, 8858.689945851896, 8757.737267881941, 8819.867701984474, 8825.867611985825, 8840.425372350808, 8843.292536597057, 8551.871721924175, 8638.697645582375, 8639.827203455958, 8651.6971905983, 8894.822103557957, 40205.597944020476, 40501.0, 40544.391834122514, 40593.18813623711, 40631.39052914209, 3443.4490481522835, 3489.3719130556487, 3539.699125574329, 3883.203943191639, 3973.5033120859894, 30625.0, 30703.846480767676, 30706.38587228265, 30720.69279307201, 32265.51601725976, 3353.195233144052, 3356.865725370982, 3361.0757041813454, 3362.69735723786, 3616.150204701893, 260401.0, 261250.0, 261466.9999999981, 262023.0, 262918.0, 41786.0, 42228.78885605552, 42417.57582424198, 57948.710256448445, 58502.70748646229, 41134.0, 41325.79337103295, 41355.0, 41366.79316603458, 41389.586104139176, 15194.164320962233, 15348.155851428279, 15350.846491535165, 15351.539453816404, 15370.0, 12370.13409061357, 12415.44130514129, 12421.627351179479, 12424.503019879103, 12446.937765311115, 14433.855661443462, 14543.418263269563, 14545.34545945435, 14560.41758329655, 14626.853731462763, 5840.88318233633, 5929.881402372014, 5942.376050514634, 5947.672877991752, 5969.253843269591, 975.3124047546463, 989.9803202701229, 1111.4831603304501, 1139.8689150747605, 1148.1675785055768, 29176.85411572971, 29328.560071598942, 29382.706172938426, 29574.0, 29729.405411892072, 824.5423789796721, 1010.6715317521835, 1054.9736256593494, 1084.3764835219622, 1090.8472813806075, 13001.219926804422, 13717.45130194801, 13957.371918263703, 15667.0, 15952.76070858938, 295567.0, 300037.49793761555, 300760.0, 301080.0, 301397.0, 45809.31286030712, 51376.48623513717, 52522.94954100973, 52626.73686631619, 52721.0, 1334.873187047229, 1373.8351397832323, 1384.6884450998446, 1394.5816255123423, 1405.213080674805, 26060.739392605832, 26731.33171670724, 27044.729552704222, 27496.450070998868, 27621.585676214472, 40606.79696601498, 40889.38665919954, 43127.35308970431, 48846.75576622236, 49760.0, 200424.0, 201218.0, 202336.0, 202512.0, 203553.0, 32676.83661581677, 33083.834580826944, 33175.50236746499, 33261.833690831394, 33374.66625333716, 42404.94734288309, 43890.341644874716, 44121.55878441175, 44203.778981104886, 44411.55588444074, 37199.62800371962, 37788.81105594454, 37842.43236351402, 38896.22207555889, 39049.6095039046, 37619.81190094032, 38001.42997854979, 38956.0, 38979.610203897595, 39055.21889562136, 36717.816410917774, 37487.81256093702, 37921.4311785329, 37991.81004094962, 38015.239695206496, 31735.682643174197, 33727.325453491285, 34098.0, 34368.0, 35851.82074089613, 24591.631125532775, 25264.621030684186, 25587.488250235263, 25751.356216094748, 26055.218343449727], "unit": "score", "name": "ext.html", "value": 17726.656053339706}, {"lowerIsBetter": false, "replicates": [363.1538515259444, 365.1346309247083, 366.1121779684266, 367.27279985628456, 369.5620689482965, 13938.257717785276, 16968.91515542422, 17264.654706905887, 17437.47687569372, 18822.62354752906, 17772.911135444305, 17793.0, 17800.82199178011, 17820.554486137822, 18181.818181818177, 5341.4658534146665, 5389.757460914248, 5512.228288039678, 5543.417941116185, 5579.38626751057, 4048.9797551012202, 5531.115021596545, 5964.821055368346, 6195.380461953813, 6216.844578885519, 6143.508519318466, 6144.139820425144, 6148.108524263979, 6176.814695559118, 6177.5057995360485, 5898.203742494751, 6267.905981410283, 6275.623462592236, 6285.025820997753, 6287.937120628827, 5494.835154945358, 5495.065838807413, 5506.64206826555, 5512.889742205133, 5516.7517461713915, 20919.163233470645, 21174.576508469898, 21272.255471058437, 21286.0, 21420.678689819666, 2248.6964259824877, 2317.2237300504353, 2942.779291553121, 2973.2742179179027, 3033.4994725870206, 12930.676733081655, 13008.86991130086, 13607.31963401826, 13772.931135344359, 13840.238786866717, 1833.8532917366579, 1855.443366989911, 1859.1169194632575, 1912.8660993730443, 1955.3742802303268, 61086.69456652688, 63586.0, 64821.0, 65916.67041664809, 66039.33960660428, 10189.796204075878, 10363.844542331872, 10425.0, 10497.580096796195, 10500.737481563023, 13965.860341396456, 14021.228832414316, 14077.0, 14088.929555352157, 14096.929515352358, 7846.5292082475235, 7926.920730792618, 7981.760547183594, 8006.639701213459, 8039.799005024921, 7770.611469426506, 7797.181295963842, 7838.294553490213, 7922.247386498273, 7925.088614809255, 4538.818447262072, 4563.680542362003, 4576.519465456146, 4642.837500687459, 4677.579017888406, 1718.4415065103642, 1756.1394916490829, 1787.1511032259573, 1808.7919889212646, 1817.681905666503, 817.1828171828172, 837.5560952695081, 918.7886786039248, 962.100436092256, 978.0854900667898, 15932.681346373007, 15965.680686386208, 17091.401800936907, 17458.825411745973, 17550.0, 839.9798484644318, 872.7163671806561, 919.2783664823082, 934.6541779541614, 940.5626383731598, 6180.02239283425, 6398.29618741938, 6659.067730517731, 6667.566608170453, 6686.431653309426, 222743.0, 223748.0, 442148.0, 451799.0, 453187.0, 75218.0, 77258.22741772623, 77718.0, 78293.60853195812, 81765.18234817576, 487.9609631229493, 503.1572116704505, 503.4990184766181, 504.6719632239074, 506.1496685568281, 10277.229207809294, 10399.688009359732, 10646.8402973957, 10695.304805187638, 10812.135029197489, 28102.0, 33235.83382083171, 33368.33263334768, 33999.0, 34624.307513850086, 46805.0, 48689.75655121702, 48785.75607121942, 49119.508804912926, 49366.0, 7879.356661551927, 7903.249191326815, 8017.238362355567, 8159.347252219927, 8284.25441710249, 8463.280621147025, 10496.737581560523, 12017.399130043637, 12147.210431321935, 12632.6841828955, 8486.533240671823, 9884.901150988686, 9966.053224943618, 10468.371897686164, 10648.0, 10179.338343007681, 10378.35584210625, 10545.314554554236, 10634.14926805869, 10943.56225750993, 10780.892191077988, 11036.227464077758, 11099.223054386115, 11128.38793866345, 11201.43992800373, 8053.275205231557, 8221.095679475133, 8247.257746802816, 8300.252977232078, 8341.374396920133, 9296.349255552046, 10751.086157676686, 10855.945720271347, 10879.456027198767, 10932.289401188897], "unit": "score", "name": "jquery.html", "value": 8239.154495072036}, {"lowerIsBetter": false, "replicates": [1271.9682007949793, 1467.2150399536247, 1482.3625840888417, 1636.2718590227346, 1792.48914059493, 7769.261920117587, 7958.76123716288, 7962.800929976754, 7966.2830345268985, 7970.481918675282, 7784.610769461533, 7946.562939038351, 7948.483348582338, 7967.960160199205, 7968.96015519923, 2006.408109607662, 2307.0541078157958, 2337.275444612171, 2345.9530809383887, 2359.6224604063354, 2318.8840557972035, 2342.1919437793936, 2360.9409764755846, 2363.302825666424, 2365.31405892291, 2301.8503797253125, 2302.930912072632, 2303.9654405183937, 2310.9653355199684, 2311.52613714189, 2251.133313674239, 2319.2694301295123, 2320.2575175943703, 2322.1640209524558, 2323.8605683659034, 2267.580497607948, 2278.5442911417617, 2294.162630639821, 2329.7087864017, 2329.871857047862, 8069.0, 8143.75568732939, 8152.103268640445, 8155.062167850714, 8165.469244499089, 4819.08437396897, 4993.7503124843615, 4995.300657907896, 4995.450500444985, 4999.3000979862845, 3116.06518044588, 3144.4497212987635, 3173.873045078194, 3232.402005628943, 3248.6264079630673, 961.365498770815, 964.5948701545298, 967.6129548180784, 1897.2411035585876, 1953.45303315072, 10861.945690271497, 10971.067459265973, 11022.669319920495, 11039.503222354933, 11056.668299951014, 4036.3138266494766, 4071.42999980003, 4085.101277718897, 4338.132373525307, 4346.130773845181, 8811.955940220387, 8825.249853762374, 8846.823063538694, 8874.112588741074, 8886.955565222133, 4301.741895486281, 4647.953520464752, 4818.71087734737, 4874.341963834908, 4901.3383193268455, 4303.225419424533, 4309.978450107792, 4319.460067491564, 4347.152305300499, 4349.826006959686, 3558.1104723819044, 3572.91067723309, 3597.352476554193, 3620.4569314602495, 3638.599754027055, 1028.141501845952, 1055.2454994678842, 1071.4482041748506, 1074.0731506644331, 1079.0558261521169, 1291.3026965438746, 1294.2299331897507, 1311.3115614302376, 1311.4557458654742, 1323.8345206849144, 7674.731384401519, 7701.268379503938, 7828.765137045898, 7844.764657060297, 7845.686172553034, 489.67926008464514, 500.1322705106637, 502.58787794009294, 503.70029832249753, 504.60892808073305, 5657.915131273035, 5662.065759149777, 5700.087985922232, 5724.599278050497, 5794.50746686528, 9328.860067098998, 9941.502924853872, 9974.501274936225, 10054.095131438205, 10099.0, 9831.508424578742, 9894.06006429388, 9954.601815927283, 9971.40171589707, 10002.299839011199, 7448.217937116633, 7649.655765490677, 7661.042369703787, 7662.0, 7740.071191457061, 7344.632768361667, 7376.299251571092, 7413.703451861865, 7414.258574142758, 7414.443916706161, 8756.649734010569, 8831.958531662076, 8848.823023539622, 8941.92696876379, 8957.955210224169, 8868.290536757173, 8999.685011024583, 9095.135962083592, 9149.215902898872, 9151.039140890376, 6004.249468816398, 6437.5171862111465, 6624.503162262946, 6647.4682025438815, 6797.116374871235, 7671.846563068819, 7681.116671582839, 7692.230776922263, 7728.961355193188, 7731.458797884094, 6773.288804675438, 7012.754553590804, 7018.473614478832, 7111.182214045451, 7153.105861767279, 6772.11962444879, 6776.254611992776, 6859.1083159190985, 6885.036094946611, 6901.516893817385, 7064.540804847668, 7089.326513981164, 7136.643167841691, 7349.448791340564, 7366.815829604303, 6675.397904502982, 6694.4644428444635, 6703.798886033427, 6710.899336510054, 6738.494612903954, 6707.865842683216, 6781.254062053269, 6829.6585170742255, 6829.795106146824, 6856.451483881177], "unit": "score", "name": "mootools.html", "value": 4508.395284106887}, {"lowerIsBetter": false, "replicates": [334.6904113694832, 335.7448339262161, 339.8029143097004, 345.3576347992733, 348.0741228332634, 5819.068948968166, 5839.9708001459985, 5846.152307915355, 5858.619189752663, 5870.0, 5746.540276777858, 5753.568482363829, 5767.711614419283, 5771.192033115367, 5832.475077243047, 4569.291759777231, 4573.588377046065, 4575.428071491064, 4576.039031803325, 4578.862634120982, 4572.291294849287, 4581.954180458203, 4586.7018643788215, 4588.793504292298, 4591.035882464686, 4362.389265502832, 4449.421575195236, 4540.06928579642, 4546.590806827385, 4547.931781023287, 4456.509783923766, 4462.776861156962, 4468.843590474334, 4473.2395492766145, 4474.1499115168335, 3885.203533275672, 3886.6696330811915, 3890.961090389088, 3892.630200130983, 3896.181801821621, 5572.219889215513, 5587.1339942309005, 5599.636023658449, 5613.607047506676, 5617.185508101344, 5194.532492075694, 5203.505666961632, 5205.453427390107, 5207.583393328525, 5208.8958220835375, 6193.5045196384635, 6216.751329946796, 6241.843953901143, 6249.0626406039, 6276.905846412307, 4159.480064991876, 4247.660187185049, 4248.08666136779, 4269.231538323101, 4334.5882141196535, 6255.655938923357, 6335.5565110442285, 6461.547691661585, 6486.935130648681, 6506.707198176094, 4100.7334523255895, 4392.582704643054, 4397.274449715761, 4398.670099742532, 4408.845690400821, 4350.760708161019, 4453.599176074104, 4454.086912182995, 4455.108978204372, 4459.576340247671, 5139.897202055938, 5143.897122057538, 5156.226566015128, 5157.922631160535, 5169.9741501293, 6216.036514340284, 6225.128482012522, 6228.968855155786, 6230.501559875199, 6231.875362492816, 1537.7923980262744, 1556.4630202580092, 1556.6186284360178, 1557.7196104701036, 1557.8052743407075, 1003.1122456625939, 1020.7754294055296, 1040.6201736366172, 1044.0759927464096, 1054.383185836279, 5912.467877890925, 5927.022041363213, 5943.940560594338, 5948.196993405922, 5948.553858460633, 6429.324920883333, 6429.38920802523, 6434.292227854932, 6443.48452123829, 6446.290908000116, 5929.762809487658, 5933.080372542263, 5933.821985340447, 5936.28764548257, 5937.732802023919, 3447.207142357272, 3447.517347571342, 3477.913052173716, 3478.7912725236565, 3479.0432631026165, 6654.0, 6678.398944094957, 6746.392824645805, 6872.0, 6877.724891004404, 6651.135352404156, 6675.632840193836, 6681.1314529110905, 6682.398584127452, 6695.933040669531, 6820.31796820324, 6835.726570937107, 6841.521093523505, 6845.0, 6845.726170953106, 6199.16311297969, 6316.8313861935685, 6545.116409284876, 6585.176852893388, 6585.934140658724, 6383.138276332821, 6404.423601875854, 6407.583507072025, 6422.486201103807, 6450.548461607643, 6799.966000169968, 6802.523823332319, 6811.182658081062, 6815.284395138638, 6829.146356705412, 4401.163778882003, 4456.019675671347, 4456.487503936959, 4457.197704413107, 4457.465104187519, 6327.462165715781, 6507.349265073644, 6508.0, 6511.446527045254, 6512.641804700787, 6206.937930620636, 6299.716512757029, 6299.960506516373, 6305.842353941188, 6311.084892690443, 6304.275008374096, 6312.495000399865, 6313.779017734358, 6323.620582765049, 6329.588576742497, 6213.068039793886, 6214.533909956862, 6219.284782250099, 6222.626642401289, 6232.5325600581045, 6142.9078563820685, 6343.429091381798, 6352.301246862934, 6359.109724638647, 6367.554271200971, 6183.628982261079, 6189.257289125334, 6225.719842607003, 6227.252729672468, 6237.4698150657705], "unit": "score", "name": "prototype.html", "value": 4715.327339477806}, {"lowerIsBetter": false, "replicates": [680.9761658341959, 698.3819319901888, 723.4574069447914, 743.6579173580153, 763.7174245529155, 13329.0, 13469.59591212264, 13494.190348579092, 13507.864921350783, 13531.797023044637, 12532.686682832933, 12913.870861291385, 12914.677133071678, 12924.0, 12924.224546527215, 671.1576970901524, 681.2880539835859, 817.5830326533481, 838.1325328285226, 843.2073850580465, 837.2255663511258, 841.3185319890878, 841.5161282262724, 843.4981186194204, 844.6030365728128, 705.1538154214937, 885.8538341173698, 888.2849306308419, 888.6223355074068, 889.0620395482763, 862.8921384826897, 878.2885862451403, 878.9692360767374, 879.3097418526426, 879.4151888993812, 642.0209180998967, 646.2568046746233, 646.524804268862, 647.3623480871385, 647.5078940005583, 13239.470421183141, 13297.335133243396, 13338.133021353678, 13344.0, 13357.198568085945, 12244.0, 12771.361431928459, 12854.949543130559, 12907.483700651963, 13177.341132943411, 9782.364146330467, 10037.749056273651, 10182.643607473703, 10308.381497110122, 10719.410432426213, 3598.604153543108, 3606.9098272543397, 3632.54593175853, 3665.505156803824, 3673.779573225615, 48542.514574854154, 48621.75689121567, 48715.0, 48790.26814597784, 48853.75573122147, 9609.0, 10260.179185665129, 10344.896551034544, 10451.692725222796, 10472.583566606309, 18952.62094758097, 18972.14625341863, 18993.525161871064, 19000.144993475325, 19028.904855475634, 7578.0, 7829.882551761728, 7933.722319718782, 8025.759227223076, 8044.637991290406, 4149.730267532601, 4218.409422680827, 4259.190753756776, 4273.487181538236, 4277.486701595828, 3151.7636177286795, 3158.3525377297597, 3177.6186857576777, 3179.3164469639137, 3181.618205815317, 524.3288590604033, 631.3497097989078, 634.3814780588889, 647.5564238496645, 654.0548906829681, 567.843842943194, 594.881023795234, 604.6644112517595, 606.5753972219464, 624.1511544299749, 8191.139930307351, 8290.295324897452, 8652.54798806331, 8799.0, 8904.688335908342, 532.8428113706466, 587.665030932373, 634.3054355480833, 635.1235295292466, 637.7480895046431, 3745.176061266517, 4149.771762553089, 4308.138372325548, 4366.388705581221, 4372.256716358163, 58421.0, 60302.49243768941, 60355.0, 60403.69798151069, 60565.57737690443, 50121.0, 53139.46860531423, 53177.202341964905, 53177.73411132997, 53335.19997200045, 45968.54031459709, 46297.07405851864, 46485.76757116193, 46637.766811165726, 46812.0, 8852.911470885208, 9002.0, 9042.457452552868, 9053.864192037256, 9151.405158664666, 32532.34935301328, 32789.83605081959, 33179.83410083031, 33228.33543329168, 33828.0, 43684.344734828366, 44881.775591121834, 45790.542094578625, 45919.54080459286, 46071.76964115158, 10904.890951090387, 10940.617078402218, 10984.395858227874, 11093.889061109285, 11343.943280283545, 8225.653018351868, 11168.385738784445, 11823.940880295544, 12117.15179937396, 12138.575149869712, 11034.282771620141, 11103.611373602209, 11194.384308863091, 11310.60412885545, 11357.09143268553, 10153.340032897839, 10634.574617015232, 10694.304870183412, 10709.946450268011, 10745.623903163352, 11008.669739907815, 11048.558057677603, 11170.832437513607, 11340.716482087684, 11453.828192576952, 9975.850362244428, 10131.341462804894, 10337.328073675488, 10601.787964240517, 10861.40262285582, 9451.905480945103, 9660.855087173839, 9830.164436023018, 10261.302115588087, 10335.0], "unit": "score", "name": "yui.html", "value": 6319.156751932869}], "name": "dromaeo_css", "value": 6816.5675031136025}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 110.0, 110.0, 111.0, 99.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [167.0, 126.0, 146.0, 163.0, 125.0, 158.0, 152.0, 133.0, 167.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 160.0, 162.0, 160.0, 160.0, 170.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 92.0, 93.0, 74.0, 76.0, 73.0, 119.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 95.0, 96.0, 96.0, 145.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"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": [58.0, 57.0, 57.0, 58.0, 57.0, 56.0, 59.0, 67.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 75.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [89.0, 81.0, 82.0, 82.0, 81.0, 84.0, 82.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [123.0, 114.0, 117.0, 138.0, 122.0, 119.0, 115.0, 124.0, 118.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 153.0, 150.0, 149.0, 145.0, 161.0, 149.0, 150.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 72.0, 70.0, 70.0, 72.0, 70.0, 76.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1519.6000000000001}]} 02:35:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6816.57"}}} 02:35:58 INFO - Return code: 0 02:35:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:35:58 INFO - # TBPL SUCCESS # 02:35:58 INFO - Running post-action listener: _resource_record_post_action 02:35:58 INFO - Running post-run listener: _resource_record_post_run 02:35:59 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 28672; Write bytes: 537759744; Read time: 208; Write time: 508624 02:35:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240795648; Read time: 0; Write time: 291904 02:35:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 28672; Write bytes: 296964096; Read time: 208; Write time: 216720 02:35:59 INFO - Running post-run listener: _upload_blobber_files 02:35:59 INFO - Blob upload gear active. 02:35:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:35:59 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:35:59 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'] 02:35:59 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 02:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:00 INFO - (blobuploader) - INFO - Done attempting. 02:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:01 INFO - (blobuploader) - INFO - Done attempting. 02:36:01 INFO - (blobuploader) - INFO - Iteration through files over. 02:36:01 INFO - Return code: 0 02:36:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fff85cc8f0565e4769d07a7fc3f81ecd3de0991d3c0f50bf63e8c52ca77dd69e79e28a43b1bad6f2e0e24896a41934ac8766b83b57832f7abe772ac8000e2ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26260fb11cbc8f60e2110011a0823bff6c851e904228c0f9674b7757a1d5f852bbd25fb74a01214d5c7e4659c955caa07b6b032e1750b5508cf012df6b0966a7"} 02:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:36:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:36:01 INFO - Contents: 02:36:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fff85cc8f0565e4769d07a7fc3f81ecd3de0991d3c0f50bf63e8c52ca77dd69e79e28a43b1bad6f2e0e24896a41934ac8766b83b57832f7abe772ac8000e2ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26260fb11cbc8f60e2110011a0823bff6c851e904228c0f9674b7757a1d5f852bbd25fb74a01214d5c7e4659c955caa07b6b032e1750b5508cf012df6b0966a7"} 02:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 02:36:01 INFO - Copying logs to upload dir... 02:36:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.314932 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-25 02:36:01.398337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 02:36:01.401570) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 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/2fff85cc8f0565e4769d07a7fc3f81ecd3de0991d3c0f50bf63e8c52ca77dd69e79e28a43b1bad6f2e0e24896a41934ac8766b83b57832f7abe772ac8000e2ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26260fb11cbc8f60e2110011a0823bff6c851e904228c0f9674b7757a1d5f852bbd25fb74a01214d5c7e4659c955caa07b6b032e1750b5508cf012df6b0966a7"} build_url:https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/fSLiV4zCTraEl_7SxLStpw/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/2fff85cc8f0565e4769d07a7fc3f81ecd3de0991d3c0f50bf63e8c52ca77dd69e79e28a43b1bad6f2e0e24896a41934ac8766b83b57832f7abe772ac8000e2ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26260fb11cbc8f60e2110011a0823bff6c851e904228c0f9674b7757a1d5f852bbd25fb74a01214d5c7e4659c955caa07b6b032e1750b5508cf012df6b0966a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 02:36:01.425419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:36:01.425696) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456395041.397652-1803442957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004739 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 02:36:01.509034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 02:36:01.509391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 02:36:01.509685) ========= ========= Total master_lag: 0.23 =========