builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1456523544.34 results: success (0) buildid: 20160226113128 builduid: 3d84ed5f3aa24228a785e2f1a27c5096 revision: 3693e541f0ee18223dd00a1745a4cd09416722a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.335904) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.336363) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.336665) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009163 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.359912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.360283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.384594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.384990) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021513 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.432336) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.432660) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.433031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.433324) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 13:52:24-- 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% 218M=0s 2016-02-26 13:52:24 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148750 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.594246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.594560) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052128 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:24.656688) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 13:52:24.657064) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3693e541f0ee18223dd00a1745a4cd09416722a9 --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 3693e541f0ee18223dd00a1745a4cd09416722a9 --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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 13:52:24,812 truncating revision to first 12 chars 2016-02-26 13:52:24,812 Setting DEBUG logging. 2016-02-26 13:52:24,812 attempt 1/10 2016-02-26 13:52:24,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3693e541f0ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 13:52:25,570 unpacking tar archive at: fx-team-3693e541f0ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096887 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 13:52:25.766148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:25.766519) ========= echo 3693e541f0ee18223dd00a1745a4cd09416722a9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3693e541f0ee18223dd00a1745a4cd09416722a9'] 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3693e541f0ee18223dd00a1745a4cd09416722a9 program finished with exit code 0 elapsedTime=0.004210 script_repo_revision: '3693e541f0ee18223dd00a1745a4cd09416722a9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:25.815932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:25.816257) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 13:52:25.825903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-02-26 13:52:25.826334) ========= /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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:52:26 INFO - MultiFileLogger online at 20160226 13:52:26 in /builds/slave/test-pgo 13:52:26 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 13:52:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:52:26 INFO - {'append_to_log': False, 13:52:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:52:26 INFO - 'blob_upload_branch': 'Fx-Team', 13:52:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:52:26 INFO - 'branch': 'Fx-Team', 13:52:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:52:26 INFO - 'config_files': ('talos/linux_config.py',), 13:52:26 INFO - 'default_actions': ('clobber', 13:52:26 INFO - 'read-buildbot-config', 13:52:26 INFO - 'download-and-extract', 13:52:26 INFO - 'populate-webroot', 13:52:26 INFO - 'create-virtualenv', 13:52:26 INFO - 'install', 13:52:26 INFO - 'run-tests'), 13:52:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:52:26 INFO - 'download_minidump_stackwalk': True, 13:52:26 INFO - 'download_symbols': 'ondemand', 13:52:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:52:26 INFO - 'tooltool.py': '/tools/tooltool.py', 13:52:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:52:26 INFO - '/tools/misc-python/virtualenv.py')}, 13:52:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:52:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:52:26 INFO - 'installer_path': 'installer.exe', 13:52:26 INFO - 'log_level': 'info', 13:52:26 INFO - 'log_name': 'talos', 13:52:26 INFO - 'log_to_console': True, 13:52:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:52:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:52:26 INFO - 'opt_config_files': (), 13:52:26 INFO - 'pip_index': False, 13:52:26 INFO - 'sps_profile': False, 13:52:26 INFO - 'sps_profile_interval': 0, 13:52:26 INFO - 'suite': 'dromaeojs', 13:52:26 INFO - 'system_bits': '32', 13:52:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:52:26 INFO - 'title': 'talos-linux64-ix-063', 13:52:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:52:26 INFO - 'use_talos_json': True, 13:52:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:52:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:52:26 INFO - 'work_dir': 'build'} 13:52:26 INFO - ##### 13:52:26 INFO - ##### Running clobber step. 13:52:26 INFO - ##### 13:52:26 INFO - Running pre-action listener: _resource_record_pre_action 13:52:26 INFO - Running main action method: clobber 13:52:26 INFO - rmtree: /builds/slave/test-pgo/build 13:52:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - ##### 13:52:27 INFO - ##### Running read-buildbot-config step. 13:52:27 INFO - ##### 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: read_buildbot_config 13:52:27 INFO - Using buildbot properties: 13:52:27 INFO - { 13:52:27 INFO - "project": "", 13:52:27 INFO - "product": "firefox", 13:52:27 INFO - "script_repo_revision": "production", 13:52:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:52:27 INFO - "repository": "", 13:52:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 13:52:27 INFO - "buildid": "20160226113128", 13:52:27 INFO - "pgo_build": "True", 13:52:27 INFO - "basedir": "/builds/slave/test-pgo", 13:52:27 INFO - "buildnumber": 676, 13:52:27 INFO - "slavename": "talos-linux64-ix-063", 13:52:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:52:27 INFO - "platform": "ubuntu64_hw", 13:52:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:52:27 INFO - "branch": "fx-team", 13:52:27 INFO - "repo_path": "integration/fx-team", 13:52:27 INFO - "revision": "3693e541f0ee18223dd00a1745a4cd09416722a9", 13:52:27 INFO - "stage_platform": "linux64-pgo", 13:52:27 INFO - "builduid": "3d84ed5f3aa24228a785e2f1a27c5096", 13:52:27 INFO - "slavebuilddir": "test" 13:52:27 INFO - } 13:52:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 13:52:27 INFO - Running post-action listener: _resource_record_post_action 13:52:27 INFO - ##### 13:52:27 INFO - ##### Running download-and-extract step. 13:52:27 INFO - ##### 13:52:27 INFO - Running pre-action listener: _resource_record_pre_action 13:52:27 INFO - Running main action method: download_and_extract 13:52:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:27 INFO - https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:52:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/test_packages.json 13:52:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/test_packages.json 13:52:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:52:28 INFO - Downloaded 1448 bytes. 13:52:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:52:28 INFO - Using the following test package requirements: 13:52:28 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:52:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:52:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'jsshell-linux-x86_64.zip'], 13:52:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:52:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:52:28 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:52:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:52:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 13:52:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 13:52:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:52:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:28 INFO - https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:31 INFO - Downloaded 23371065 bytes. 13:52:31 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'] 13:52:31 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 13:52:32 INFO - Return code: 0 13:52:32 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 13:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:32 INFO - https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:52:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:52:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 13:52:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:36 INFO - Downloaded 23371065 bytes. 13:52:36 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'] 13:52:36 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 13:52:38 INFO - Return code: 0 13:52: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')]} 13:52:38 INFO - https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 13:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:39 INFO - Downloaded 10713410 bytes. 13:52: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'] 13:52: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 13:52:39 INFO - Return code: 0 13:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:39 INFO - https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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 13:52:44 INFO - Downloaded 56645018 bytes. 13:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:52:44 INFO - mkdir: /builds/slave/test-pgo/properties 13:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:52:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:52:44 INFO - Contents: 13:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 13:52:45 INFO - Running post-action listener: _resource_record_post_action 13:52:45 INFO - Running post-action listener: set_extra_try_arguments 13:52:45 INFO - ##### 13:52:45 INFO - ##### Running populate-webroot step. 13:52:45 INFO - ##### 13:52:45 INFO - Running pre-action listener: _resource_record_pre_action 13:52:45 INFO - Running main action method: populate_webroot 13:52:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:52:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:52:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:52:45 INFO - '--tppagecycles', 13:52:45 INFO - '7'], 13:52:45 INFO - 'tests': ['tsvgm']}}, 13:52:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:52:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:52:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:52:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:52:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:52:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'tests': ['damp', 'tps']}, 13:52:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['damp', 'tps']}, 13:52:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:52:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:52:45 INFO - 'other': {'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'other_l64': {'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'other_nol64': {'tests': ['a11yr', 13:52:45 INFO - 'ts_paint', 13:52:45 INFO - 'tpaint', 13:52:45 INFO - 'sessionrestore', 13:52:45 INFO - 'sessionrestore_no_auto_restore']}, 13:52:45 INFO - 'svgr': {'tests': ['tsvgx', 13:52:45 INFO - 'tsvgr_opacity', 13:52:45 INFO - 'tart', 13:52:45 INFO - 'tscrollx', 13:52:45 INFO - 'cart']}, 13:52:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['tsvgx', 13:52:45 INFO - 'tsvgr_opacity', 13:52:45 INFO - 'tart', 13:52:45 INFO - 'tscrollx', 13:52:45 INFO - 'cart']}, 13:52:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'tests': ['tp5o']}, 13:52:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'talos_options': ['--e10s'], 13:52:45 INFO - 'tests': ['tp5o']}, 13:52:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'talos_options': ['--xperf_path', 13:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:45 INFO - 'tests': ['tp5n']}, 13:52:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:52:45 INFO - 'talos_options': ['--e10s', 13:52:45 INFO - '--xperf_path', 13:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:52:45 INFO - 'tests': ['tp5n']}}, 13:52:45 INFO - 'talos.zip': {'path': '', 13:52:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:52:45 INFO - Running post-action listener: _resource_record_post_action 13:52:45 INFO - ##### 13:52:45 INFO - ##### Running create-virtualenv step. 13:52:45 INFO - ##### 13:52:45 INFO - Running pre-action listener: _resource_record_pre_action 13:52:45 INFO - Running main action method: create_virtualenv 13:52:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:52:45 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 13:52:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:52:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:52:45 INFO - Using real prefix '/usr' 13:52:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:52:46 INFO - Installing distribute.............................................................................................................................................................................................done. 13:52:48 INFO - Installing pip.................done. 13:52:48 INFO - Return code: 0 13:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:52: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:52: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 pip>=1.5 13:52:48 INFO - Using env: {'DISPLAY': ':0', 13:52:48 INFO - 'HOME': '/home/cltbld', 13:52:48 INFO - 'LANG': 'en_US.UTF-8', 13:52:48 INFO - 'LANGUAGE': 'en_US:en', 13:52:48 INFO - 'LOGNAME': 'cltbld', 13:52:48 INFO - 'MAIL': '/var/mail/cltbld', 13:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:48 INFO - 'MOZ_NO_REMOTE': '1', 13:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:48 INFO - 'NO_EM_RESTART': '1', 13:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:48 INFO - 'SHELL': '/bin/bash', 13:52:48 INFO - 'SHLVL': '1', 13:52:48 INFO - 'TERM': 'linux', 13:52:48 INFO - 'TMOUT': '86400', 13:52:48 INFO - 'USER': 'cltbld', 13:52:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:48 INFO - '_': '/tools/buildbot/bin/python'} 13:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:48 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 13:52:48 INFO - Cleaning up... 13:52:48 INFO - Return code: 0 13:52:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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', '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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:52: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:52: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 psutil>=0.7.1 13:52:48 INFO - Using env: {'DISPLAY': ':0', 13:52:48 INFO - 'HOME': '/home/cltbld', 13:52:48 INFO - 'LANG': 'en_US.UTF-8', 13:52:48 INFO - 'LANGUAGE': 'en_US:en', 13:52:48 INFO - 'LOGNAME': 'cltbld', 13:52:48 INFO - 'MAIL': '/var/mail/cltbld', 13:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:48 INFO - 'MOZ_NO_REMOTE': '1', 13:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:48 INFO - 'NO_EM_RESTART': '1', 13:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:48 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:48 INFO - 'SHELL': '/bin/bash', 13:52:48 INFO - 'SHLVL': '1', 13:52:48 INFO - 'TERM': 'linux', 13:52:48 INFO - 'TMOUT': '86400', 13:52:48 INFO - 'USER': 'cltbld', 13:52:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:48 INFO - '_': '/tools/buildbot/bin/python'} 13:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:48 INFO - Downloading/unpacking psutil>=0.7.1 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:50 INFO - Installing collected packages: psutil 13:52:50 INFO - Running setup.py install for psutil 13:52:50 INFO - building 'psutil._psutil_linux' extension 13:52:50 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 13:52:50 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 13:52:50 INFO - building 'psutil._psutil_posix' extension 13:52:50 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 13:52:50 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 13:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:52:51 INFO - Successfully installed psutil 13:52:51 INFO - Cleaning up... 13:52:51 INFO - Return code: 0 13:52:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:52:51 INFO - Using env: {'DISPLAY': ':0', 13:52:51 INFO - 'HOME': '/home/cltbld', 13:52:51 INFO - 'LANG': 'en_US.UTF-8', 13:52:51 INFO - 'LANGUAGE': 'en_US:en', 13:52:51 INFO - 'LOGNAME': 'cltbld', 13:52:51 INFO - 'MAIL': '/var/mail/cltbld', 13:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:51 INFO - 'MOZ_NO_REMOTE': '1', 13:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:51 INFO - 'NO_EM_RESTART': '1', 13:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:51 INFO - 'SHELL': '/bin/bash', 13:52:51 INFO - 'SHLVL': '1', 13:52:51 INFO - 'TERM': 'linux', 13:52:51 INFO - 'TMOUT': '86400', 13:52:51 INFO - 'USER': 'cltbld', 13:52:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:51 INFO - '_': '/tools/buildbot/bin/python'} 13:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:52:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:52:53 INFO - Installing collected packages: mozsystemmonitor 13:52:53 INFO - Running setup.py install for mozsystemmonitor 13:52:53 INFO - Successfully installed mozsystemmonitor 13:52:53 INFO - Cleaning up... 13:52:53 INFO - Return code: 0 13:52:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:52: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')]} 13:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52: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')]} 13:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:52:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:52:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:52:53 INFO - Using env: {'DISPLAY': ':0', 13:52:53 INFO - 'HOME': '/home/cltbld', 13:52:53 INFO - 'LANG': 'en_US.UTF-8', 13:52:53 INFO - 'LANGUAGE': 'en_US:en', 13:52:53 INFO - 'LOGNAME': 'cltbld', 13:52:53 INFO - 'MAIL': '/var/mail/cltbld', 13:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:53 INFO - 'MOZ_NO_REMOTE': '1', 13:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:53 INFO - 'NO_EM_RESTART': '1', 13:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:53 INFO - 'SHELL': '/bin/bash', 13:52:53 INFO - 'SHLVL': '1', 13:52:53 INFO - 'TERM': 'linux', 13:52:53 INFO - 'TMOUT': '86400', 13:52:53 INFO - 'USER': 'cltbld', 13:52:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:53 INFO - '_': '/tools/buildbot/bin/python'} 13:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52: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 13:52:55 INFO - Downloading blobuploader-1.2.4.tar.gz 13:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:52:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:52:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:52:56 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 13:52:56 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 13:52:56 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 13:52:56 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 13:52:56 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 13:52:56 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 13:52:56 INFO - Downloading docopt-0.6.1.tar.gz 13:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:52:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:52:56 INFO - Running setup.py install for blobuploader 13:52:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:52:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:52:56 INFO - Running setup.py install for requests 13:52:56 INFO - Running setup.py install for docopt 13:52:56 INFO - Successfully installed blobuploader requests docopt 13:52:56 INFO - Cleaning up... 13:52:56 INFO - Return code: 0 13:52:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:52:56 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')]} 13:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:56 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')]} 13:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:52:56 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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:52:56 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 13:52:56 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 13:52:56 INFO - Using env: {'DISPLAY': ':0', 13:52:56 INFO - 'HOME': '/home/cltbld', 13:52:56 INFO - 'LANG': 'en_US.UTF-8', 13:52:56 INFO - 'LANGUAGE': 'en_US:en', 13:52:56 INFO - 'LOGNAME': 'cltbld', 13:52:56 INFO - 'MAIL': '/var/mail/cltbld', 13:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:52:56 INFO - 'MOZ_NO_REMOTE': '1', 13:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:52:56 INFO - 'NO_EM_RESTART': '1', 13:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 13:52:56 INFO - 'SHELL': '/bin/bash', 13:52:56 INFO - 'SHLVL': '1', 13:52:56 INFO - 'TERM': 'linux', 13:52:56 INFO - 'TMOUT': '86400', 13:52:56 INFO - 'USER': 'cltbld', 13:52:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:52:56 INFO - '_': '/tools/buildbot/bin/python'} 13:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:57 INFO - Running setup.py (path:/tmp/pip-wfEezP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:57 INFO - Running setup.py (path:/tmp/pip-vglVvy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:57 INFO - Running setup.py (path:/tmp/pip-5ctoH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:57 INFO - Running setup.py (path:/tmp/pip-n5k1QL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:57 INFO - Running setup.py (path:/tmp/pip-FK7gMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:57 INFO - Running setup.py (path:/tmp/pip-0x1aMj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:57 INFO - Running setup.py (path:/tmp/pip-LQzdok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:57 INFO - Running setup.py (path:/tmp/pip-APQk1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:57 INFO - Running setup.py (path:/tmp/pip-LeZvEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:57 INFO - Running setup.py (path:/tmp/pip-MZE5cu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:57 INFO - Running setup.py (path:/tmp/pip-W5g5AA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:57 INFO - Running setup.py (path:/tmp/pip-4Li2hg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:57 INFO - Running setup.py (path:/tmp/pip-MB49tm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:58 INFO - Running setup.py (path:/tmp/pip-HT4Y0A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:58 INFO - Running setup.py (path:/tmp/pip-rj8ewk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:58 INFO - Running setup.py (path:/tmp/pip-GrqXmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:52:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:58 INFO - Running setup.py (path:/tmp/pip-BjOOPc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:52:58 INFO - Running setup.py install for manifestparser 13:52:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Running setup.py install for mozcrash 13:52:58 INFO - Running setup.py install for mozdebug 13:52:58 INFO - Running setup.py install for mozdevice 13:52:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Running setup.py install for mozfile 13:52:58 INFO - Running setup.py install for mozhttpd 13:52:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:52:58 INFO - Running setup.py install for mozinfo 13:52:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozInstall 13:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozleak 13:52:59 INFO - Running setup.py install for mozlog 13:52:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for moznetwork 13:52:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozprocess 13:52:59 INFO - Running setup.py install for mozprofile 13:52:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozrunner 13:52:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:52:59 INFO - Running setup.py install for mozscreenshot 13:52:59 INFO - Running setup.py install for moztest 13:52:59 INFO - Running setup.py install for mozversion 13:53:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:53:00 INFO - Cleaning up... 13:53:00 INFO - Return code: 0 13:53:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53: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')]} 13:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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')]} 13:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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/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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:53:00 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 13:53:00 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 13:53:00 INFO - Using env: {'DISPLAY': ':0', 13:53:00 INFO - 'HOME': '/home/cltbld', 13:53:00 INFO - 'LANG': 'en_US.UTF-8', 13:53:00 INFO - 'LANGUAGE': 'en_US:en', 13:53:00 INFO - 'LOGNAME': 'cltbld', 13:53:00 INFO - 'MAIL': '/var/mail/cltbld', 13:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:00 INFO - 'MOZ_NO_REMOTE': '1', 13:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:00 INFO - 'NO_EM_RESTART': '1', 13:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:00 INFO - 'SHELL': '/bin/bash', 13:53:00 INFO - 'SHLVL': '1', 13:53:00 INFO - 'TERM': 'linux', 13:53:00 INFO - 'TMOUT': '86400', 13:53:00 INFO - 'USER': 'cltbld', 13:53:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:00 INFO - '_': '/tools/buildbot/bin/python'} 13:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:00 INFO - Running setup.py (path:/tmp/pip-eO1HEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:00 INFO - Running setup.py (path:/tmp/pip-rF6gFB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:00 INFO - Running setup.py (path:/tmp/pip-pbtLMa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:00 INFO - Running setup.py (path:/tmp/pip-N6NYwi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:00 INFO - Running setup.py (path:/tmp/pip-HUg51J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:00 INFO - Running setup.py (path:/tmp/pip-sK2Oj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:00 INFO - Running setup.py (path:/tmp/pip-tcRIPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:00 INFO - Running setup.py (path:/tmp/pip-kN7mBH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:00 INFO - Running setup.py (path:/tmp/pip-LmLFKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:53:00 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)) 13:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:00 INFO - Running setup.py (path:/tmp/pip-11Ko9M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:01 INFO - Running setup.py (path:/tmp/pip-rMTiPK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:01 INFO - Running setup.py (path:/tmp/pip-dktvcZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:01 INFO - Running setup.py (path:/tmp/pip-_HnL02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:01 INFO - Running setup.py (path:/tmp/pip-LabaMz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:01 INFO - Running setup.py (path:/tmp/pip-Vi7BRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:01 INFO - Running setup.py (path:/tmp/pip-zN5hMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:53:01 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)) 13:53:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:01 INFO - Running setup.py (path:/tmp/pip-rfdEJc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:53:01 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)) 13:53:01 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)) 13:53:01 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)) 13:53:01 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)) 13:53: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 13:53:01 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)) 13:53:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:03 INFO - Downloading blessings-1.6.tar.gz 13:53:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:53:03 INFO - Installing collected packages: blessings 13:53:03 INFO - Running setup.py install for blessings 13:53:03 INFO - Successfully installed blessings 13:53:03 INFO - Cleaning up... 13:53:03 INFO - Return code: 0 13:53:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:53:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:03 INFO - Reading from file tmpfile_stdout 13:53:03 INFO - Current package versions: 13:53:03 INFO - argparse == 1.2.1 13:53:03 INFO - blessings == 1.6 13:53:03 INFO - blobuploader == 1.2.4 13:53:03 INFO - docopt == 0.6.1 13:53:03 INFO - manifestparser == 1.1 13:53:03 INFO - mozInstall == 1.12 13:53:03 INFO - mozcrash == 0.16 13:53:03 INFO - mozdebug == 0.1 13:53:03 INFO - mozdevice == 0.48 13:53:03 INFO - mozfile == 1.2 13:53:03 INFO - mozhttpd == 0.7 13:53:03 INFO - mozinfo == 0.9 13:53:03 INFO - mozleak == 0.1 13:53:03 INFO - mozlog == 3.1 13:53:03 INFO - moznetwork == 0.27 13:53:03 INFO - mozprocess == 0.22 13:53:03 INFO - mozprofile == 0.28 13:53:03 INFO - mozrunner == 6.11 13:53:03 INFO - mozscreenshot == 0.1 13:53:03 INFO - mozsystemmonitor == 0.0 13:53:03 INFO - moztest == 0.7 13:53:03 INFO - mozversion == 1.4 13:53:03 INFO - psutil == 3.1.1 13:53:03 INFO - requests == 1.2.3 13:53:03 INFO - wsgiref == 0.1.2 13:53:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:53: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')]} 13:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53: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')]} 13:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:03 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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:53:03 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 13:53:03 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 13:53:03 INFO - Using env: {'DISPLAY': ':0', 13:53:03 INFO - 'HOME': '/home/cltbld', 13:53:03 INFO - 'LANG': 'en_US.UTF-8', 13:53:03 INFO - 'LANGUAGE': 'en_US:en', 13:53:03 INFO - 'LOGNAME': 'cltbld', 13:53:03 INFO - 'MAIL': '/var/mail/cltbld', 13:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:03 INFO - 'MOZ_NO_REMOTE': '1', 13:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:03 INFO - 'NO_EM_RESTART': '1', 13:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:03 INFO - 'SHELL': '/bin/bash', 13:53:03 INFO - 'SHLVL': '1', 13:53:03 INFO - 'TERM': 'linux', 13:53:03 INFO - 'TMOUT': '86400', 13:53:03 INFO - 'USER': 'cltbld', 13:53:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:03 INFO - '_': '/tools/buildbot/bin/python'} 13:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 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)) 13:53:04 INFO - Cleaning up... 13:53:04 INFO - Return code: 0 13:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:53:04 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')]} 13:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:04 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')]} 13:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:04 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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:53:04 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 13:53:04 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 13:53:04 INFO - Using env: {'DISPLAY': ':0', 13:53:04 INFO - 'HOME': '/home/cltbld', 13:53:04 INFO - 'LANG': 'en_US.UTF-8', 13:53:04 INFO - 'LANGUAGE': 'en_US:en', 13:53:04 INFO - 'LOGNAME': 'cltbld', 13:53:04 INFO - 'MAIL': '/var/mail/cltbld', 13:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:04 INFO - 'MOZ_NO_REMOTE': '1', 13:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:04 INFO - 'NO_EM_RESTART': '1', 13:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:04 INFO - 'SHELL': '/bin/bash', 13:53:04 INFO - 'SHLVL': '1', 13:53:04 INFO - 'TERM': 'linux', 13:53:04 INFO - 'TMOUT': '86400', 13:53:04 INFO - 'USER': 'cltbld', 13:53:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:04 INFO - '_': '/tools/buildbot/bin/python'} 13:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:04 INFO - Downloading/unpacking jsonschema 13:53:04 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 13:53:04 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 13:53:04 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 13:53:04 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 13:53:04 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 13:53:04 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 13:53:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:53:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:53:06 INFO - warning: no files found matching '*.txt' 13:53:06 INFO - no previously-included directories found matching 'build' 13:53:06 INFO - no previously-included directories found matching 'dist' 13:53:06 INFO - no previously-included directories found matching '.git*' 13:53:06 INFO - Installing collected packages: jsonschema, functools32 13:53:06 INFO - Running setup.py install for functools32 13:53:06 INFO - warning: no files found matching '*.txt' 13:53:06 INFO - no previously-included directories found matching 'build' 13:53:06 INFO - no previously-included directories found matching 'dist' 13:53:06 INFO - no previously-included directories found matching '.git*' 13:53:06 INFO - Successfully installed jsonschema functools32 13:53:06 INFO - Cleaning up... 13:53:06 INFO - Return code: 0 13:53:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:53:06 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')]} 13:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:06 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')]} 13:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:53:06 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 0x7f3a89040f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfd8670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, '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': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', '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 13:53:06 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 13:53:06 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 13:53:06 INFO - Using env: {'DISPLAY': ':0', 13:53:06 INFO - 'HOME': '/home/cltbld', 13:53:06 INFO - 'LANG': 'en_US.UTF-8', 13:53:06 INFO - 'LANGUAGE': 'en_US:en', 13:53:06 INFO - 'LOGNAME': 'cltbld', 13:53:06 INFO - 'MAIL': '/var/mail/cltbld', 13:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:06 INFO - 'MOZ_NO_REMOTE': '1', 13:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:06 INFO - 'NO_EM_RESTART': '1', 13:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:06 INFO - 'SHELL': '/bin/bash', 13:53:06 INFO - 'SHLVL': '1', 13:53:06 INFO - 'TERM': 'linux', 13:53:06 INFO - 'TMOUT': '86400', 13:53:06 INFO - 'USER': 'cltbld', 13:53:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:06 INFO - '_': '/tools/buildbot/bin/python'} 13:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:53:06 INFO - Downloading/unpacking flake8 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53: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 13:53:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:53:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:53:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:08 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 13:53:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:53:09 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 13:53:09 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 13:53:09 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 13:53:09 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 13:53:09 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 13:53:09 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 13:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:53:09 INFO - no previously-included directories found matching 'docs/_build' 13:53:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:53:09 INFO - Running setup.py install for pep8 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:53:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:53:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:53:09 INFO - no previously-included directories found matching 'docs/_build' 13:53:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:53:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:53:09 INFO - Cleaning up... 13:53:09 INFO - Return code: 0 13:53:09 INFO - Running post-action listener: _resource_record_post_action 13:53:09 INFO - Running post-action listener: _start_resource_monitoring 13:53:09 INFO - Starting resource monitoring. 13:53:09 INFO - ##### 13:53:09 INFO - ##### Running install step. 13:53:09 INFO - ##### 13:53:09 INFO - Running pre-action listener: _resource_record_pre_action 13:53:09 INFO - Running main action method: install 13:53:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:53:09 INFO - Reading from file tmpfile_stdout 13:53:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:53:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:53:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:53:09 INFO - Reading from file tmpfile_stdout 13:53:09 INFO - Output received: 13:53:09 INFO - Usage: mozinstall [options] installer 13:53:09 INFO - Options: 13:53:09 INFO - -h, --help show this help message and exit 13:53:09 INFO - -d DEST, --destination=DEST 13:53:09 INFO - Directory to install application into. [default: 13:53:09 INFO - "/builds/slave/test-pgo"] 13:53:09 INFO - --app=APP Application being installed. [default: firefox] 13:53:09 INFO - mkdir: /builds/slave/test-pgo/build/application 13:53:09 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'] 13:53:09 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 13:53:26 INFO - Reading from file tmpfile_stdout 13:53:26 INFO - Output received: 13:53:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:53:26 INFO - Running post-action listener: _resource_record_post_action 13:53:26 INFO - ##### 13:53:26 INFO - ##### Running run-tests step. 13:53:26 INFO - ##### 13:53:26 INFO - Running pre-action listener: _resource_record_pre_action 13:53:26 INFO - Running main action method: run_tests 13:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:53:26 INFO - Python 2.7.3 13:53:26 INFO - Return code: 0 13:53:26 INFO - grabbing minidump binary from tooltool 13:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:53:26 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 0x10678c0>, '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 0x10687c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1068c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:53:26 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 13:53:26 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 13:53:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:53:26 INFO - Return code: 0 13:53:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:53:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:53:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:53:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:53:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:53:27 INFO - Return code: 0 13:53:27 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/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:53:27 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/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 13:53:27 INFO - Using env: {'DISPLAY': ':0', 13:53:27 INFO - 'HOME': '/home/cltbld', 13:53:27 INFO - 'LANG': 'en_US.UTF-8', 13:53:27 INFO - 'LANGUAGE': 'en_US:en', 13:53:27 INFO - 'LOGNAME': 'cltbld', 13:53:27 INFO - 'MAIL': '/var/mail/cltbld', 13:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:53:27 INFO - 'MOZ_NO_REMOTE': '1', 13:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:53:27 INFO - 'NO_EM_RESTART': '1', 13:53:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:53:27 INFO - 'PWD': '/builds/slave/test-pgo', 13:53:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:53:27 INFO - 'SHELL': '/bin/bash', 13:53:27 INFO - 'SHLVL': '1', 13:53:27 INFO - 'TERM': 'linux', 13:53:27 INFO - 'TMOUT': '86400', 13:53:27 INFO - 'USER': 'cltbld', 13:53:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059', 13:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:53:27 INFO - '_': '/tools/buildbot/bin/python'} 13:53:27 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/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 13:53:27 INFO - mozversion application_buildid: 20160226113128 13:53:27 INFO - mozversion application_changeset: 3693e541f0ee18223dd00a1745a4cd09416722a9 13:53:27 INFO - mozversion application_display_name: Nightly 13:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:53:27 INFO - mozversion application_name: Firefox 13:53:27 INFO - mozversion application_remotingname: firefox 13:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:53:27 INFO - mozversion application_vendor: Mozilla 13:53:27 INFO - mozversion application_version: 47.0a1 13:53:27 INFO - mozversion platform_buildid: 20160226113128 13:53:27 INFO - mozversion platform_changeset: 3693e541f0ee18223dd00a1745a4cd09416722a9 13:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:53:27 INFO - mozversion platform_version: 47.0a1 13:53:27 INFO - using testdate: 1456523607 13:53:27 INFO - actual date: 1456523607 13:53:27 INFO - starting webserver on 'localhost:54465' 13:53:27 INFO - SUITE-START | Running 2 tests 13:53:27 INFO - TEST-START | dromaeo_css 13:53:27 INFO - operating with platform_type : linux_ 13:53:27 INFO - Initialising browser for dromaeo_css test... 13:53:27 INFO - TEST-INFO | started process 31482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUcHpq0/profile http://localhost:54465/getInfo.html) 13:53:31 INFO - PROCESS | 31482 | __metrics Screen width/height:1600/1200 13:53:31 INFO - PROCESS | 31482 | colorDepth:24 13:53:31 INFO - PROCESS | 31482 | Browser inner width/height: 1024/697 13:53:31 INFO - PROCESS | 31482 | __metrics 13:53:32 INFO - PROCESS | 31482 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:53:32 INFO - PROCESS | 31482 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:53:33 INFO - TEST-INFO | 31482: exit 0 13:53:33 INFO - Browser initialized. 13:53:33 INFO - Running cycle 1/1 for dromaeo_css test... 13:53:33 INFO - TEST-INFO | started process 31578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUcHpq0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:45 INFO - PROCESS | 31578 | RSS: Main: 147374080 13:53:45 INFO - PROCESS | 31578 | 13:54:36 INFO - PROCESS | 31578 | 1456523676842 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] 13:56:44 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54465/tests/dromaeo/cssquery-ext.html) 13:56:45 INFO - PROCESS | 31578 | RSS: Main: 258912256 13:56:45 INFO - PROCESS | 31578 | 13:59:48 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-ext.html (next: http://localhost:54465/tests/dromaeo/cssquery-jquery.html) 13:59:48 INFO - PROCESS | 31578 | RSS: Main: 232312832 13:59:48 INFO - PROCESS | 31578 | 14:02:50 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54465/tests/dromaeo/cssquery-mootools.html) 14:02:51 INFO - PROCESS | 31578 | RSS: Main: 230440960 14:02:51 INFO - PROCESS | 31578 | 14:05:53 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54465/tests/dromaeo/cssquery-prototype.html) 14:05:53 INFO - PROCESS | 31578 | RSS: Main: 212344832 14:05:53 INFO - PROCESS | 31578 | 14:08:56 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54465/tests/dromaeo/cssquery-yui.html) 14:08:56 INFO - PROCESS | 31578 | RSS: Main: 208138240 14:08:56 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | Cycle 1(1): loaded http://localhost:54465/tests/dromaeo/cssquery-yui.html (next: http://localhost:54465/tests/dromaeo/cssquery-dojo.html) 14:11:59 INFO - PROCESS | 31578 | RSS: Main: 302944256 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | __start_tp_report 14:11:59 INFO - PROCESS | 31578 | _x_x_mozilla_page_load 14:11:59 INFO - PROCESS | 31578 | _x_x_mozilla_page_load_details 14:11:59 INFO - PROCESS | 31578 | |i|pagename|runs| 14:11:59 INFO - PROCESS | 31578 | |0;dojo.html;3072.4469595472806;3087.3207894263264;3138.6390565085007;3141.701538353857;3165.9552347725244;4891.804327826887;4902.60779137669;4967.20524716045;4971.577415919651;4991.351124353833;4983.3272508211385;5016.247562865572;5016.372953380827;5050.646454748169;5077.1622682257475;4590.265557510799;4608.078384323132;4682.484926658065;4699.553542413465;4705.341252224691;4552.4764652065105;4623.653226008046;4632.119897219534;4676.55572720591;4774.904501909959;4617.353570500132;4623.2371658676275;4626.884327891813;4671.556202160789;4685.344051832746;4597.310403439477;4624.05206932578;4641.0949864776385;4646.883827904296;4672.322513235596;4591.678582499227;4613.215753321943;4625.236835922069;4675.18184317743;4690.671652984292;4883.3651625288485;4893.510648935114;4914.04176185644;4925.113479573675;4941.308216849644;5348;5349.0639138151055;5359.38367087786;5359.892802143974;5374.247605335257;5412;5450.100733378988;5504.504594586507;5536.197251398565;5555;5019.723915184663;5023.372078490189;5029.1450453423;5030.195168772979;5058.645894787403;5436.836894893159;5445;5469.343678758495;5473.06957817172;5484.067708489566;5352.6253162279045;5365.356157261153;5367.329083864517;5410.188471729272;5439.592030597721;5427.48438898304;5442.183672449164;5443.074677304868;5450.400455949843;5451.836444906659;5282.920756188661;5375.9462405376225;5423.159410291411;5432.348118225759;5466.972665136649;5403.972980135153;5427.402985671573;5446.019716450997;5449.04641687703;5491.258680078138;4190.371444283382;4201.873943781691;4205.285101532747;4242.363645453145;4244.278472659656;3696.7966761828357;3741.43878418234;3784.829682664287;3797.601251868514;3807.8667246646232;5132.435432102466;5154.587632989352;5155.9742201288755;5159.948400516022;5183.170692689152;5436.70098144598;5447.836564903059;5450.345958484928;5453.890922181534;5497.340319161726;5043.4956504349275;5043.697378157249;5145.279660847485;5155.200943853709;5168.9224661630105;4626.259798432235;4633.189191891405;4645.396098507173;4652.720836749806;4689.249720044776;5743.971280143656;5749.223854779551;5783.479486846204;5786.016377215799;5786.247787787561;5311.44229855875;5454.209139674805;5474.452554744494;5528.226048353315;5536.695481748542;5734.856628584319;5739.225204597493;5761.020626493422;5763.625364351304;5766;5264.9736751315995;5384.9730751346;5386.811461598825;5398.001369746609;5431.9185212221055;5467.972660136674;5504.559635229252;5509.917351239655;5510.9448905510435;5554.305711786027;5336.573074153981;5337.759800809051;5362.436944120967;5375.865603359947;5377.193420986883;5126.53861152498;5207.531322181022;5365.865853353697;5371.167469042305;5380.354357477127;5156.071907056766;5163.173892177384;5167.560757335518;5174.6119041072825;5215.608829337739;5270.156774915995;5272.657277276965;5274.89450210986;5277.498637629419;5321.840344789663;5062.0888240115655;5144.845654630367;5151.098557752303;5208.687478751287;5214.426413094632 14:11:59 INFO - PROCESS | 31578 | |1;ext.html;528.460969810793;549.5548605629443;551.2392897801036;580.7357652268217;583.7694110826224;36709.816450917744;37314.06714832127;37315.06712332193;37388.25223495528;37424.43863342052;40116.59883401165;40629;40674.18651626973;40705.38941915866;40766.388504172384;8384.951881014873;8495.150484951486;8527.95736021319;8539.274161696263;8573.699920502784;8719.956400218021;8898.199162075412;8905.821883562325;8907.198352148305;8910.86633700495;8894.199522043014;8998.415103018282;9003.324750643695;9006.549672516381;9007.729768106934;8818.823623527525;8893.155150260747;8904.643814247422;8918.241949434307;8918.331125165638;8719.782005449852;8778.078301778285;8855.955720221422;8861.601227944693;8865.157810008039;39889;40026;40062.599374006175;40117;40182.397264041065;1553.8601525862614;3331.25046864456;3398.099503631515;3725.329440700673;3956.980215098935;30432.847835760902;30641.69358306433;30748.2312942176;30772.692273077206;31193.064208073793;3836.0985168485386;3867.3425517662067;3894.415837624351;3925.9803700981597;3980.1641655252433;266075;266342;266366;266915;269525;53501;53738.46261537335;53745.1938220927;53994.920101597745;54004;61134.694326528086;61143.6942815292;65754;66395.33604663989;66573;15013.099214046973;15043.247837608076;15134.243287835785;15214.695706085817;15243.542693719206;11298.774024519464;11357.261777984404;11357.898788724113;11389.373584452935;11394.94302528482;20411.897940510204;20945.266915657878;20988.26541071055;21010.474738131365;21048.684269735968;7962.880556791652;8112;8121.512709237465;8207.507549547046;8290.585470726439;1001.8228581416806;1057.5716834681966;1071.244772435431;1077.671310250381;1119.3899324867966;29420.11739647814;29814;31010.68989310078;31590.210244744067;32157;1030.567161792049;1051.7265510967204;1052.1057101463848;1061.363182090755;1123.634818683931;13817.170969741848;14259.144451332953;14293.213873237071;16233.59416014609;16681.332746690237;397163;400576;403494;404134;405460;56235;56679.43320566742;56688;56713;56748.432515675144;1196.5632544121506;1210.267787988272;1383.4742797736797;1406.810080639121;1411.8941079419085;26348.604770928836;28823;28994.13017609475;29061.27346816262;29409.11772646824;43619.78190109029;43963.78018109889;44016.339754904344;44022.559774401845;44043.11913761771;235360;236954.81522592276;237079;237482;238022;27019.729802702506;31243.375132497677;33787.83106084454;34023.65976340205;34131.317373652884;41029.38455923104;41804;41857.372139417326;42107.36838947357;42428.57571424246;34792.13019674427;35130.297394051464;35192.64807351996;35293.82353088321;35478.645213547534;34627;34736.65263347334;34814.65185348114;34944.65055349414;35421.291574168885;34919.476207856394;35076.64923350734;35408.29183416369;38461.230775384895;39074.2185156301;29535.409291814474;31907.521387179677;32959.340813184084;33217.07423407743;33570.832145839115;25061.87469062643;25302.74697253004;25458;25602.487950241262;25633.743662563134 14:11:59 INFO - PROCESS | 31578 | |2;jquery.html;350.4795378862389;352.13726370392544;353.600431512391;361.6148801526373;364.19512876542836;16993.74509382359;17346.653066938652;17997.910010449945;18467.815321846778;18477;15040.323185456653;15110.622234444118;15796.131212783292;15836;15850.20748962553;5375.166849138371;5439.700816455093;5602.7758889644365;5611.80358687446;5612.494875461208;5473.480019398151;5487.807926722566;5517.475839795213;5538.307711536058;5563.109902415615;5350.705711185883;5385.21914322423;5484.945150548503;5532.474414930575;5536.2249285100115;5492.917606235889;5507.256520369739;5516.531094856942;5532.529734972512;5541.168824676311;4890.706557606555;4931.43288521821;4939.753012349368;4941.332920055783;4952.504749525055;20926.581468370547;21844.344669659935;21910.89044554783;21919.232826851145;22010;2072.4404410808997;2165.1555893201507;2337.1118974789642;2338;2364.75170107138;9395.812083758356;9407.29445291606;9441.858372124423;9609.903900960971;9847.655332063343;1815.954601134969;1853.5644123630937;1859.228420205613;1872.11074739499;1905.4378958207362;61954.380456195315;66448.6677566614;67050;67727;70997.93503097509;10060.547275372626;10106.140978016803;10116.595336186618;10199.18406527476;10338.069573738248;13308.201507909556;13371.33143342829;13412.195268283738;13450.461981520826;13451;7105.147382314155;7304.123505179413;7338.743143990041;7394.223606521346;7401.259874012556;7071.575705457689;7072.292770722886;7178.964105179545;7186.568805871664;7192.388646965067;4319.568043195718;4392.912141757147;4408.470983482002;4466.330050492452;4473.194824931478;1830.4783136805947;1872.9157187926576;1873.7564116664746;1875.2217829600836;1877.54000269932;911.1344222988055;953.8330792111353;991.3506653142204;1025.195221750922;1038.065740833241;16982.915085424494;17057.573560661083;17218.483445496655;17332.39336623212;17637.82362176362;926.6802952981211;950.695777351241;953.7234202081457;978.3542861711236;1003.4230317567428;9568.952155239318;9877.654282100091;9899.851502227473;9911.256655750847;10058.145057670034;400105;410348;411494;428287;431876;43873.78063109664;47990.56028319156;73200.2679973204;77899.22100779033;79763;986.1371300112402;996.5465713100522;1014.8883622801486;1017.3641474078701;1023.6775415744016;11568;14778.261086945824;14963.40146394132;15263.465778698137;15383.307751151002;25161.622575661746;31206.21984450407;32466.67533324731;33719;34625.653743462244;42068;44023.339649904636;44957.325640114774;45080.77459612681;45554.31668525041;7621.466497345133;7729.497582657109;7927.128015918129;8056.718014869686;8109.675612975415;9045.77385565366;12247.203931744409;12652.557160499338;12812.743745125232;12873.935630321788;10554.577816887238;10661.413622250851;10710.250282480152;11105.38920359388;11116.388598627153;10619.203559733205;10622.468876556295;10676.946615266874;10852.18608604342;11173.72065698364;7160.928390716026;10791.406472643766;10958.835617465904;11097.445127743742;11121.221514493907;7875.094364148196;7912.604369781373;7952.602369881367;7996.520208787491;8075.152109028702;8245.876311855447;10419.94790026045;10648.414337211529;10725.41010244444;10756.139508839431 14:11:59 INFO - PROCESS | 31578 | |3;mootools.html;1403.0669604712866;1467.4643755029413;1495.4990078323758;1678.9580260493485;1840.1995132117522;6977.372036516713;7611;7747.186545412721;7759.340456061242;7775.183605721402;7531;7750.612469376522;7759.5344279343135;7768.68925242991;7769.689212431496;1955.589326241491;2154.5906277807208;2182.1925887421676;2212.1814928476488;2257.0745994142403;2239.104358256694;2277.851939623919;2279.6124658808044;2279.6466547685136;2280.338701776483;2207.2826331442348;2296.402935236842;2296.816254699628;2297.253392647388;2297.6783250344884;2123.4054464749815;2142.5393540388814;2209.425549357171;2245.9887700561558;2250.0212407602744;2236.7427745809114;2267.444476103365;2268.160780511221;2274.65880117982;2276.2374604507345;7616.695332186706;7651.961740191319;7679.923200768033;7685.654145563463;7700.4609677322605;4624.768761561909;4735.195016847144;4749.287606858964;4767.118083154593;4775;3004.444177827109;3078.4766589679584;3146.4179126861377;3151.1806930198086;3154.7160755532113;941.4351389166445;954.6658669465701;958.0323872888363;1004.5233506745146;1017.8676772019664;10537.262391632588;10689.465526723632;10695.893041069567;10714.464276786208;10724;4021.9195616087513;4156.688248381383;4243.745375277432;4296.720713153635;4308.418363520885;9084.454932703928;9099.499527525917;9104.681336153202;9304.069593040642;9368.859467107999;4304.612584867377;4755.619550435957;4764.547368000034;4765.499622539653;4770.451398089264;4132.235536425771;4145.253854306194;4182.247195504839;4190.958090419118;4192.685548583808;3581.28374325136;3649.1789347396625;3658.689011434058;3674.963250367462;3691.7046636269033;1114.816055350858;1143.8684551276542;1158.976820463603;1170.4791367841228;1170.7365842685329;1367.0362394511844;1369.0895554456374;1403.4666826605824;1406.1282005156868;1407.2541552976938;7305.707771689179;7570.394368450621;7573.545587264782;7579.355754760907;7591.696332146763;454.8317122664635;457.4921836761192;459.4716076512038;460.26587592789446;480.37311308742426;5689.431056894277;5698.943010569924;5705.600607957486;5755.769769209269;5758.1362795581;8902.910970890209;9019.594118264693;9059.773505662411;9155.13026262504;9158.81682366349;8977.057408972094;9021.909780902108;9023.864642030374;9128.3153763468;9137.862932056025;7234.674439650228;7250.492465527468;7382.298681625237;7419.8145046374275;7440.590767507839;7313;7324.523905946309;7365.484416090822;7366.815829604303;7368.778936631909;8230.711925082593;8418.6211620476;8574.742757717278;8691.652333906573;8712.21590056898;8491.532965686947;8649.740507784525;8733.606987685696;8745.906761654793;8883.955580222058;6077;6665.0668906352175;6846.110005699227;7000.579965202104;7108.431325493844;7343.192248852515;7385.409167266714;7431.739889103856;7465.962670186615;7487.925120748723;6544.705488253136;6698.062271282122;6751.594904305757;6780;6886.793396198122;6658.234303055211;6665.5334126612615;6711.63086030273;6810.046593477016;6846.246912839683;6963;7002.159740831133;7032.085828842218;7033.261507541839;7059.258777828254;6472.708728107153;6520.934790652223;6554.672266386567;6558.80323590293;6568.967155164193;6418.069379939976;6420.133282006869;6422.197225346832;6431.614103153825;6432.09950606906 14:11:59 INFO - PROCESS | 31578 | |4;prototype.html;322.5822559785078;329.23781445952625;336.94103531881916;337.2344777355405;344.33886937080786;5753.568482363824;5796.855078623026;5830.4461076197695;5838.445347691968;5870.471657550825;5731.283589551306;5747.080467125261;5749.827505174841;5759.078547432412;5760.971195144019;4304.160688665712;4363.716358436707;4449.132419178261;4486.035502366991;4526.502084770665;4442.600165985061;4444.066745983331;4456.086502267044;4473.1501014807245;4474.3064824952025;4418.779061046935;4464.196444639963;4469.731816091029;4474.552544745516;4495.988402609403;4281.807318670667;4348.543402942709;4441.333799930004;4465.531119232466;4465.776711164429;3921.764694118362;3938.8818335449982;3945.230680017398;3951.8616848410456;3953.683705303569;5502.779888804443;5513;5514.558835293167;5516.282883225195;5528.281323427928;5185.288854677985;5187.688738675653;5190.636655434121;5196.090684130299;5196.32447781786;6077.878442431127;6085.817425477243;6093.817185484442;6097.786577469812;6102.389761023906;4143.834246630161;4266.0827921996915;4279.700420970534;4371.759553224571;4377.649788016951;6309.747610095636;6353.777617783356;6376.585521941105;6377.649229292387;6384.68076596173;4354.107407981356;4364.650827933758;4366.956330436718;4369.453818272716;4380.211561918885;4422.29243321067;4422.800973956179;4423.977880110643;4428.9149158456385;4429.53489883564;5104.770285337168;5111.821086261963;5115.18157094863;5116.769745361467;5131.692098474104;5938.465538101592;6153.1693221415435;6159.907601385983;6165.537584681167;6167.722452489649;1513.3492598182886;1537.1929736888223;1541.3218183999004;1545.2814441284631;1551.5655616427418;935.5930170375908;997.5336255704103;1001.9579637177254;1041.5156952017348;1050.1546255264432;5804.216430781875;5835.299764028344;5842.503387212049;5873.148393483007;5882.323532793698;6227.595206311576;6238.812835614939;6240.7503699852405;6245.531585131133;6245.6252624842655;5860;5862.296524417097;5864.736086876101;5868.735906884201;5887.911681324784;3341.3484370547994;3368.3768502826565;3369.157710572357;3369.966300337014;3370.5449764281507;6443.581167224115;6615;6616.900746488806;6618.371254730793;6632.602043877383;6329;6353.587016843982;6355.777547785805;6356.173697419398;6364.363563643598;6588.110605068255;6588.143541339595;6597;6605.801825945133;6607.80176594703;6228.501719862491;6233.781817636361;6254.312025677081;6259.061140828912;6263.4362907338555;6025.427584379477;6178.196834411498;6198.473129784019;6200.0699895016105;6200.56596038273;6612.966935165294;6654.4676425884845;6659.267480577036;6660.933390666031;6667.599944003376;4360.215161271001;4369.978150109229;4378.365137055172;4382.539833317455;4383.846565370197;6258.906116408349;6261.655608941552;6267.592606480564;6271.3415091414745;6277.623342599459;6073.240844894388;6074.301455332693;6077.756889724362;6084.148219249397;6084.543659225487;5919;6069.271687397364;6069.271687397364;6121.081837724377;6164.7842325518395;5952.791652292149;5976.61152025117;5985.610935289193;5986.371430999682;5993.9700301498215;6109.877802443837;6115.296740874678;6115.5719099664375;6116.510679145568;6117.938820611915;5757.683327417032;5882;5914.704264786829;5943;5954.821355359346 14:11:59 INFO - PROCESS | 31578 | |5;yui.html;666.8866292730236;684.9383555480006;703.2334755116923;718.6837791371796;836.5733475927277;13744.31278436078;14173.291335433212;14173.716525669506;14186.999999999987;14187.716245675094;13017;13286;13293.069485136044;13295.667608309774;13313.201207927532;806.3750593290189;823.1398188892622;823.7775800533852;824.1058451580043;824.4558591329724;674.7199912036499;808.8058865872177;811.3225456743626;814.1492140712969;823.7899335669396;855.9871601925945;865.1219012702112;865.5974971638187;865.6364326982682;866.1598249697784;853.7822855171953;856.7044369692446;858.2533196119385;858.9785255368603;860.2043110123174;521.8590980435299;621.3444815719414;627.6422439209653;634.6445990245477;643.8808820368247;11854.407279635983;11859.407029648482;11862.11034172432;11863.46614402354;11885.524579016828;12327.198732082386;12682.55611053618;12823.230606163566;12844.165129266661;12981.480740770357;9268.629254829866;9426.764330891714;9472.668456604055;9579;9652.083052110038;3559.1280136366495;3568.232829941549;3571.9443987907407;3572.517710109128;3635.1275693833554;49099.99999999964;49506.50493495055;49591.50408495905;49899.50100498985;50121.74939125317;10474.738131546772;10479.318844275098;10542.47287635615;10588.841167382496;10911.727206819893;16878.831211687724;17025.48923532296;17048.659026819394;17054.829451705573;17100.486985390457;7495;7844.568548729874;7945.046594408593;7946.801329966797;7963.981692681555;3859.3824988001784;3895.162540053902;4319;4394.714343567658;4447.844325448594;3148.307372378073;3159;3161.4941609342395;3175.872965081417;3179.8410079495934;575.815738963536;591.3317950715664;592.2922108080888;595.5235811350989;606.8361542383532;621.7015832400383;679.7111227728195;698.0611078099947;702.6943279673359;704.8132244954988;8885.822283554293;9495.715128546155;9506.667266645773;9573.712788616212;9685.806283874283;657.3426573426574;671.5131529640971;674.0933444517117;681.7375310505491;704.0741425026176;3959.3467077932396;3962.603739626072;4075.9388609170887;4127.834886604503;4234.25900467417;54477.45522544803;56902;57318.713406432704;57787;57892.13161802576;46747.532524675;47022.76488617535;47264.527354726015;47437.288440673416;47611.5238847614;44941.32588011182;46220.76889615531;46474.302885456746;46509.76745116321;46615.76692116586;8787;8934.195922367018;9021.684241051795;9124.95437522808;9167.679131230376;34291.485627715105;34631.65368346284;35031.12422189466;36770.448443272835;36925;39610.405843912944;40359;44624.55375446334;44689;45367.546324536335;11539.134564907497;11568.248063876157;11612.187146899974;12017.278963262232;12241.143119981516;12215;12419.751604967669;12438.937805310916;12493.750124997267;12583.307918064595;11915.285082895054;12059.042052602763;12121.333326667118;12413.93793031029;12448.68878278014;11541.249818761753;11880.65957530945;12047.457864395948;12370.62888113358;12467.563635272722;11197.66407007791;11540.538378464767;11767.11746619024;12058.397080146133;12203.023758099509;9764.902350976683;9884.406935583887;9891.554880030271;10051;10282.485875706334;9053.77365565866;9385;9592.856107158537;9625.470599117116;10124.69625911224 14:11:59 INFO - PROCESS | 31578 | __end_tp_report 14:11:59 INFO - PROCESS | 31578 | __start_cc_report 14:11:59 INFO - PROCESS | 31578 | _x_x_mozilla_cycle_collect,868 14:11:59 INFO - PROCESS | 31578 | __end_cc_report 14:11:59 INFO - PROCESS | 31578 | __startTimestamp1456524719591__endTimestamp 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | ------- Summary: start ------- 14:11:59 INFO - PROCESS | 31578 | Number of tests: 6 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#0] dojo.html Cycles:165 Average:5052.63 Median:5183.17 stddev:553.34 (10.7%) stddev-sans-first:532.79 14:11:59 INFO - PROCESS | 31578 | Values: 3072.4 3087.3 3138.6 3141.7 3166.0 4891.8 4902.6 4967.2 4971.6 4991.4 4983.3 5016.2 5016.4 5050.6 5077.2 4590.3 4608.1 4682.5 4699.6 4705.3 4552.5 4623.7 4632.1 4676.6 4774.9 4617.4 4623.2 4626.9 4671.6 4685.3 4597.3 4624.1 4641.1 4646.9 4672.3 4591.7 4613.2 4625.2 4675.2 4690.7 4883.4 4893.5 4914.0 4925.1 4941.3 5348.0 5349.1 5359.4 5359.9 5374.2 5412.0 5450.1 5504.5 5536.2 5555.0 5019.7 5023.4 5029.1 5030.2 5058.6 5436.8 5445.0 5469.3 5473.1 5484.1 5352.6 5365.4 5367.3 5410.2 5439.6 5427.5 5442.2 5443.1 5450.4 5451.8 5282.9 5375.9 5423.2 5432.3 5467.0 5404.0 5427.4 5446.0 5449.0 5491.3 4190.4 4201.9 4205.3 4242.4 4244.3 3696.8 3741.4 3784.8 3797.6 3807.9 5132.4 5154.6 5156.0 5159.9 5183.2 5436.7 5447.8 5450.3 5453.9 5497.3 5043.5 5043.7 5145.3 5155.2 5168.9 4626.3 4633.2 4645.4 4652.7 4689.2 5744.0 5749.2 5783.5 5786.0 5786.2 5311.4 5454.2 5474.5 5528.2 5536.7 5734.9 5739.2 5761.0 5763.6 5766.0 5265.0 5385.0 5386.8 5398.0 5431.9 5468.0 5504.6 5509.9 5510.9 5554.3 5336.6 5337.8 5362.4 5375.9 5377.2 5126.5 5207.5 5365.9 5371.2 5380.4 5156.1 5163.2 5167.6 5174.6 5215.6 5270.2 5272.7 5274.9 5277.5 5321.8 5062.1 5144.8 5151.1 5208.7 5214.4 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#1] ext.html Cycles:180 Average:47128.38 Median:36094.23 stddev:81628.77 (226.2%) stddev-sans-first:81782.77 14:11:59 INFO - PROCESS | 31578 | Values: 528.5 549.6 551.2 580.7 583.8 36709.8 37314.1 37315.1 37388.3 37424.4 40116.6 40629.0 40674.2 40705.4 40766.4 8385.0 8495.2 8528.0 8539.3 8573.7 8720.0 8898.2 8905.8 8907.2 8910.9 8894.2 8998.4 9003.3 9006.5 9007.7 8818.8 8893.2 8904.6 8918.2 8918.3 8719.8 8778.1 8856.0 8861.6 8865.2 39889.0 40026.0 40062.6 40117.0 40182.4 1553.9 3331.3 3398.1 3725.3 3957.0 30432.8 30641.7 30748.2 30772.7 31193.1 3836.1 3867.3 3894.4 3926.0 3980.2 266075.0 266342.0 266366.0 266915.0 269525.0 53501.0 53738.5 53745.2 53994.9 54004.0 61134.7 61143.7 65754.0 66395.3 66573.0 15013.1 15043.2 15134.2 15214.7 15243.5 11298.8 11357.3 11357.9 11389.4 11394.9 20411.9 20945.3 20988.3 21010.5 21048.7 7962.9 8112.0 8121.5 8207.5 8290.6 1001.8 1057.6 1071.2 1077.7 1119.4 29420.1 29814.0 31010.7 31590.2 32157.0 1030.6 1051.7 1052.1 1061.4 1123.6 13817.2 14259.1 14293.2 16233.6 16681.3 397163.0 400576.0 403494.0 404134.0 405460.0 56235.0 56679.4 56688.0 56713.0 56748.4 1196.6 1210.3 1383.5 1406.8 1411.9 26348.6 28823.0 28994.1 29061.3 29409.1 43619.8 43963.8 44016.3 44022.6 44043.1 235360.0 236954.8 237079.0 237482.0 238022.0 27019.7 31243.4 33787.8 34023.7 34131.3 41029.4 41804.0 41857.4 42107.4 42428.6 34792.1 35130.3 35192.6 35293.8 35478.6 34627.0 34736.7 34814.7 34944.7 35421.3 34919.5 35076.6 35408.3 38461.2 39074.2 29535.4 31907.5 32959.3 33217.1 33570.8 25061.9 25302.7 25458.0 25602.5 25633.7 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#2] jquery.html Cycles:180 Average:24393.67 Median:410921.00 stddev:68295.69 (16.6%) stddev-sans-first:68463.41 14:11:59 INFO - PROCESS | 31578 | Values: 350.5 352.1 353.6 361.6 364.2 16993.7 17346.7 17997.9 18467.8 18477.0 15040.3 15110.6 15796.1 15836.0 15850.2 5375.2 5439.7 5602.8 5611.8 5612.5 5473.5 5487.8 5517.5 5538.3 5563.1 5350.7 5385.2 5484.9 5532.5 5536.2 5492.9 5507.3 5516.5 5532.5 5541.2 4890.7 4931.4 4939.8 4941.3 4952.5 20926.6 21844.3 21910.9 21919.2 22010.0 2072.4 2165.2 2337.1 2338.0 2364.8 9395.8 9407.3 9441.9 9609.9 9847.7 1816.0 1853.6 1859.2 1872.1 1905.4 61954.4 66448.7 67050.0 67727.0 70997.9 10060.5 10106.1 10116.6 10199.2 10338.1 13308.2 13371.3 13412.2 13450.5 13451.0 7105.1 7304.1 7338.7 7394.2 7401.3 7071.6 7072.3 7179.0 7186.6 7192.4 4319.6 4392.9 4408.5 4466.3 4473.2 1830.5 1872.9 1873.8 1875.2 1877.5 911.1 953.8 991.4 1025.2 1038.1 16982.9 17057.6 17218.5 17332.4 17637.8 926.7 950.7 953.7 978.4 1003.4 9569.0 9877.7 9899.9 9911.3 10058.1 400105.0 410348.0 411494.0 428287.0 431876.0 43873.8 47990.6 73200.3 77899.2 79763.0 986.1 996.5 1014.9 1017.4 1023.7 11568.0 14778.3 14963.4 15263.5 15383.3 25161.6 31206.2 32466.7 33719.0 34625.7 42068.0 44023.3 44957.3 45080.8 45554.3 7621.5 7729.5 7927.1 8056.7 8109.7 9045.8 12247.2 12652.6 12812.7 12873.9 10554.6 10661.4 10710.3 11105.4 11116.4 10619.2 10622.5 10676.9 10852.2 11173.7 7160.9 10791.4 10958.8 11097.4 11121.2 7875.1 7912.6 7952.6 7996.5 8075.2 8245.9 10419.9 10648.4 10725.4 10756.1 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#3] mootools.html Cycles:180 Average:5415.79 Median:6426.91 stddev:2831.42 (44.1%) stddev-sans-first:2823.30 14:11:59 INFO - PROCESS | 31578 | Values: 1403.1 1467.5 1495.5 1679.0 1840.2 6977.4 7611.0 7747.2 7759.3 7775.2 7531.0 7750.6 7759.5 7768.7 7769.7 1955.6 2154.6 2182.2 2212.2 2257.1 2239.1 2277.9 2279.6 2279.6 2280.3 2207.3 2296.4 2296.8 2297.3 2297.7 2123.4 2142.5 2209.4 2246.0 2250.0 2236.7 2267.4 2268.2 2274.7 2276.2 7616.7 7652.0 7679.9 7685.7 7700.5 4624.8 4735.2 4749.3 4767.1 4775.0 3004.4 3078.5 3146.4 3151.2 3154.7 941.4 954.7 958.0 1004.5 1017.9 10537.3 10689.5 10695.9 10714.5 10724.0 4021.9 4156.7 4243.7 4296.7 4308.4 9084.5 9099.5 9104.7 9304.1 9368.9 4304.6 4755.6 4764.5 4765.5 4770.5 4132.2 4145.3 4182.2 4191.0 4192.7 3581.3 3649.2 3658.7 3675.0 3691.7 1114.8 1143.9 1159.0 1170.5 1170.7 1367.0 1369.1 1403.5 1406.1 1407.3 7305.7 7570.4 7573.5 7579.4 7591.7 454.8 457.5 459.5 460.3 480.4 5689.4 5698.9 5705.6 5755.8 5758.1 8902.9 9019.6 9059.8 9155.1 9158.8 8977.1 9021.9 9023.9 9128.3 9137.9 7234.7 7250.5 7382.3 7419.8 7440.6 7313.0 7324.5 7365.5 7366.8 7368.8 8230.7 8418.6 8574.7 8691.7 8712.2 8491.5 8649.7 8733.6 8745.9 8884.0 6077.0 6665.1 6846.1 7000.6 7108.4 7343.2 7385.4 7431.7 7466.0 7487.9 6544.7 6698.1 6751.6 6780.0 6886.8 6658.2 6665.5 6711.6 6810.0 6846.2 6963.0 7002.2 7032.1 7033.3 7059.3 6472.7 6520.9 6554.7 6558.8 6569.0 6418.1 6420.1 6422.2 6431.6 6432.1 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#4] prototype.html Cycles:180 Average:5119.33 Median:5851.25 stddev:1533.86 (26.2%) stddev-sans-first:1495.31 14:11:59 INFO - PROCESS | 31578 | Values: 322.6 329.2 336.9 337.2 344.3 5753.6 5796.9 5830.4 5838.4 5870.5 5731.3 5747.1 5749.8 5759.1 5761.0 4304.2 4363.7 4449.1 4486.0 4526.5 4442.6 4444.1 4456.1 4473.2 4474.3 4418.8 4464.2 4469.7 4474.6 4496.0 4281.8 4348.5 4441.3 4465.5 4465.8 3921.8 3938.9 3945.2 3951.9 3953.7 5502.8 5513.0 5514.6 5516.3 5528.3 5185.3 5187.7 5190.6 5196.1 5196.3 6077.9 6085.8 6093.8 6097.8 6102.4 4143.8 4266.1 4279.7 4371.8 4377.6 6309.7 6353.8 6376.6 6377.6 6384.7 4354.1 4364.7 4367.0 4369.5 4380.2 4422.3 4422.8 4424.0 4428.9 4429.5 5104.8 5111.8 5115.2 5116.8 5131.7 5938.5 6153.2 6159.9 6165.5 6167.7 1513.3 1537.2 1541.3 1545.3 1551.6 935.6 997.5 1002.0 1041.5 1050.2 5804.2 5835.3 5842.5 5873.1 5882.3 6227.6 6238.8 6240.8 6245.5 6245.6 5860.0 5862.3 5864.7 5868.7 5887.9 3341.3 3368.4 3369.2 3370.0 3370.5 6443.6 6615.0 6616.9 6618.4 6632.6 6329.0 6353.6 6355.8 6356.2 6364.4 6588.1 6588.1 6597.0 6605.8 6607.8 6228.5 6233.8 6254.3 6259.1 6263.4 6025.4 6178.2 6198.5 6200.1 6200.6 6613.0 6654.5 6659.3 6660.9 6667.6 4360.2 4370.0 4378.4 4382.5 4383.8 6258.9 6261.7 6267.6 6271.3 6277.6 6073.2 6074.3 6077.8 6084.1 6084.5 5919.0 6069.3 6069.3 6121.1 6164.8 5952.8 5976.6 5985.6 5986.4 5994.0 6109.9 6115.3 6115.6 6116.5 6117.9 5757.7 5882.0 5914.7 5943.0 5954.8 14:11:59 INFO - PROCESS | 31578 | 14:11:59 INFO - PROCESS | 31578 | [#5] yui.html Cycles:180 Average:13750.91 Median:46492.04 stddev:15630.19 (33.6%) stddev-sans-first:15643.15 14:11:59 INFO - PROCESS | 31578 | Values: 666.9 684.9 703.2 718.7 836.6 13744.3 14173.3 14173.7 14187.0 14187.7 13017.0 13286.0 13293.1 13295.7 13313.2 806.4 823.1 823.8 824.1 824.5 674.7 808.8 811.3 814.1 823.8 856.0 865.1 865.6 865.6 866.2 853.8 856.7 858.3 859.0 860.2 521.9 621.3 627.6 634.6 643.9 11854.4 11859.4 11862.1 11863.5 11885.5 12327.2 12682.6 12823.2 12844.2 12981.5 9268.6 9426.8 9472.7 9579.0 9652.1 3559.1 3568.2 3571.9 3572.5 3635.1 49100.0 49506.5 49591.5 49899.5 50121.7 10474.7 10479.3 10542.5 10588.8 10911.7 16878.8 17025.5 17048.7 17054.8 17100.5 7495.0 7844.6 7945.0 7946.8 7964.0 3859.4 3895.2 4319.0 4394.7 4447.8 3148.3 3159.0 3161.5 3175.9 3179.8 575.8 591.3 592.3 595.5 606.8 621.7 679.7 698.1 702.7 704.8 8885.8 9495.7 9506.7 9573.7 9685.8 657.3 671.5 674.1 681.7 704.1 3959.3 3962.6 4075.9 4127.8 4234.3 54477.5 56902.0 57318.7 57787.0 57892.1 46747.5 47022.8 47264.5 47437.3 47611.5 44941.3 46220.8 46474.3 46509.8 46615.8 8787.0 8934.2 9021.7 9125.0 9167.7 34291.5 34631.7 35031.1 36770.4 36925.0 39610.4 40359.0 44624.6 44689.0 45367.5 11539.1 11568.2 11612.2 12017.3 12241.1 12215.0 12419.8 12438.9 12493.8 12583.3 11915.3 12059.0 12121.3 12413.9 12448.7 11541.2 11880.7 12047.5 12370.6 12467.6 11197.7 11540.5 11767.1 12058.4 12203.0 9764.9 9884.4 9891.6 10051.0 10282.5 9053.8 9385.0 9592.9 9625.5 10124.7 14:11:59 INFO - PROCESS | 31578 | -------- Summary: end -------- 14:11:59 INFO - PROCESS | 31578 | 14:12:00 INFO - TEST-INFO | 31578: exit 0 14:12:00 INFO - TEST-OK | dromaeo_css | took 1112761ms 14:12:00 INFO - TEST-START | kraken 14:12:00 INFO - operating with platform_type : linux_ 14:12:00 INFO - Initialising browser for kraken test... 14:12:00 INFO - TEST-INFO | started process 31765 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4b33_Z/profile http://localhost:54465/getInfo.html) 14:12:04 INFO - PROCESS | 31765 | __metrics Screen width/height:1600/1200 14:12:04 INFO - PROCESS | 31765 | colorDepth:24 14:12:04 INFO - PROCESS | 31765 | Browser inner width/height: 1024/697 14:12:04 INFO - PROCESS | 31765 | __metrics 14:12:04 INFO - PROCESS | 31765 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:05 INFO - PROCESS | 31765 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 14:12:05 INFO - TEST-INFO | 31765: exit 0 14:12:05 INFO - Browser initialized. 14:12:05 INFO - Running cycle 1/1 for kraken test... 14:12:05 INFO - TEST-INFO | started process 31848 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4b33_Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:17 INFO - PROCESS | 31848 | RSS: Main: 147238912 14:12:17 INFO - PROCESS | 31848 | 14:12:20 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-beat-detection) 14:12:20 INFO - PROCESS | 31848 | RSS: Main: 193114112 14:12:20 INFO - PROCESS | 31848 | 14:12:23 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-dft) 14:12:23 INFO - PROCESS | 31848 | RSS: Main: 182685696 14:12:23 INFO - PROCESS | 31848 | 14:12:26 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-fft) 14:12:27 INFO - PROCESS | 31848 | RSS: Main: 166744064 14:12:27 INFO - PROCESS | 31848 | 14:12:29 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54465/tests/kraken/driver.html?testName=audio-oscillator) 14:12:29 INFO - PROCESS | 31848 | RSS: Main: 167829504 14:12:29 INFO - PROCESS | 31848 | 14:12:32 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:12:32 INFO - PROCESS | 31848 | RSS: Main: 169328640 14:12:32 INFO - PROCESS | 31848 | 14:12:35 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-darkroom) 14:12:36 INFO - PROCESS | 31848 | RSS: Main: 169926656 14:12:36 INFO - PROCESS | 31848 | 14:12:39 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54465/tests/kraken/driver.html?testName=imaging-desaturate) 14:12:40 INFO - PROCESS | 31848 | RSS: Main: 171716608 14:12:40 INFO - PROCESS | 31848 | 14:12:43 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54465/tests/kraken/driver.html?testName=json-parse-financial) 14:12:43 INFO - PROCESS | 31848 | RSS: Main: 171159552 14:12:43 INFO - PROCESS | 31848 | 14:12:45 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:12:45 INFO - PROCESS | 31848 | RSS: Main: 179552256 14:12:45 INFO - PROCESS | 31848 | 14:12:47 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:12:48 INFO - PROCESS | 31848 | RSS: Main: 179417088 14:12:48 INFO - PROCESS | 31848 | 14:12:50 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:12:50 INFO - PROCESS | 31848 | RSS: Main: 192172032 14:12:50 INFO - PROCESS | 31848 | 14:12:53 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:12:53 INFO - PROCESS | 31848 | RSS: Main: 196890624 14:12:53 INFO - PROCESS | 31848 | 14:12:56 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:12:57 INFO - PROCESS | 31848 | RSS: Main: 197718016 14:12:57 INFO - PROCESS | 31848 | 14:12:58 INFO - PROCESS | 31848 | Cycle 1(1): loaded http://localhost:54465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54465/tests/kraken/driver.html?testName=ai-astar) 14:12:59 INFO - PROCESS | 31848 | RSS: Main: 255664128 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | __start_tp_report 14:12:59 INFO - PROCESS | 31848 | _x_x_mozilla_page_load 14:12:59 INFO - PROCESS | 31848 | _x_x_mozilla_page_load_details 14:12:59 INFO - PROCESS | 31848 | |i|pagename|runs| 14:12:59 INFO - PROCESS | 31848 | |0;ai-astar;110;111;106;110;111;111;100;110;112;109 14:12:59 INFO - PROCESS | 31848 | |1;audio-beat-detection;151;138;151;172;138;159;153;126;183;129 14:12:59 INFO - PROCESS | 31848 | |2;audio-dft;162;160;163;161;159;160;161;163;164;161 14:12:59 INFO - PROCESS | 31848 | |3;audio-fft;73;73;99;97;73;72;72;129;96;74 14:12:59 INFO - PROCESS | 31848 | |4;audio-oscillator;96;96;148;97;97;95;149;96;95;147 14:12:59 INFO - PROCESS | 31848 | |5;imaging-gaussian-blur;119;116;115;114;115;115;115;114;115;115 14:12:59 INFO - PROCESS | 31848 | |6;imaging-darkroom;145;146;145;145;146;146;146;146;146;146 14:12:59 INFO - PROCESS | 31848 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;97 14:12:59 INFO - PROCESS | 31848 | |8;json-parse-financial;56;56;58;55;56;56;57;66;55;55 14:12:59 INFO - PROCESS | 31848 | |9;json-stringify-tinderbox;68;74;69;69;69;68;68;70;71;72 14:12:59 INFO - PROCESS | 31848 | |10;stanford-crypto-aes;80;82;84;83;83;82;82;91;84;85 14:12:59 INFO - PROCESS | 31848 | |11;stanford-crypto-ccm;123;117;121;116;124;118;127;115;118;117 14:12:59 INFO - PROCESS | 31848 | |12;stanford-crypto-pbkdf2;155;148;141;143;148;138;149;153;148;154 14:12:59 INFO - PROCESS | 31848 | |13;stanford-crypto-sha256-iterative;71;68;70;68;69;70;69;69;68;68 14:12:59 INFO - PROCESS | 31848 | __end_tp_report 14:12:59 INFO - PROCESS | 31848 | __start_cc_report 14:12:59 INFO - PROCESS | 31848 | _x_x_mozilla_cycle_collect,1057 14:12:59 INFO - PROCESS | 31848 | __end_cc_report 14:12:59 INFO - PROCESS | 31848 | __startTimestamp1456524779026__endTimestamp 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | ------- Summary: start ------- 14:12:59 INFO - PROCESS | 31848 | Number of tests: 14 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.56 (3.2%) stddev-sans-first:3.76 14:12:59 INFO - PROCESS | 31848 | Values: 110.0 111.0 106.0 110.0 111.0 111.0 100.0 110.0 112.0 109.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:152.00 stddev:18.17 (12.0%) stddev-sans-first:19.26 14:12:59 INFO - PROCESS | 31848 | Values: 151.0 138.0 151.0 172.0 138.0 159.0 153.0 126.0 183.0 129.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.58 (1.0%) stddev-sans-first:1.66 14:12:59 INFO - PROCESS | 31848 | Values: 162.0 160.0 163.0 161.0 159.0 160.0 161.0 163.0 164.0 161.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#3] audio-fft Cycles:10 Average:85.80 Median:73.50 stddev:19.10 (26.0%) stddev-sans-first:19.68 14:12:59 INFO - PROCESS | 31848 | Values: 73.0 73.0 99.0 97.0 73.0 72.0 72.0 129.0 96.0 74.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:96.00 stddev:25.13 (26.2%) stddev-sans-first:26.01 14:12:59 INFO - PROCESS | 31848 | Values: 96.0 96.0 148.0 97.0 97.0 95.0 149.0 96.0 95.0 147.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 14:12:59 INFO - PROCESS | 31848 | Values: 119.0 116.0 115.0 114.0 115.0 115.0 115.0 114.0 115.0 115.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:12:59 INFO - PROCESS | 31848 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 14:12:59 INFO - PROCESS | 31848 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 97.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:3.30 (5.9%) stddev-sans-first:3.48 14:12:59 INFO - PROCESS | 31848 | Values: 56.0 56.0 58.0 55.0 56.0 56.0 57.0 66.0 55.0 55.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.50 stddev:1.99 (2.9%) stddev-sans-first:2.00 14:12:59 INFO - PROCESS | 31848 | Values: 68.0 74.0 69.0 69.0 69.0 68.0 68.0 70.0 71.0 72.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:2.95 (3.5%) stddev-sans-first:2.83 14:12:59 INFO - PROCESS | 31848 | Values: 80.0 82.0 84.0 83.0 83.0 82.0 82.0 91.0 84.0 85.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.50 stddev:3.95 (3.3%) stddev-sans-first:3.99 14:12:59 INFO - PROCESS | 31848 | Values: 123.0 117.0 121.0 116.0 124.0 118.0 127.0 115.0 118.0 117.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.50 stddev:5.62 (3.8%) stddev-sans-first:5.30 14:12:59 INFO - PROCESS | 31848 | Values: 155.0 148.0 141.0 143.0 148.0 138.0 149.0 153.0 148.0 154.0 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - PROCESS | 31848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.05 (1.5%) stddev-sans-first:0.83 14:12:59 INFO - PROCESS | 31848 | Values: 71.0 68.0 70.0 68.0 69.0 70.0 69.0 69.0 68.0 68.0 14:12:59 INFO - PROCESS | 31848 | -------- Summary: end -------- 14:12:59 INFO - PROCESS | 31848 | 14:12:59 INFO - TEST-INFO | 31848: exit 0 14:12:59 INFO - TEST-OK | kraken | took 59614ms 14:12:59 INFO - SUITE-END | took 1172s 14:13:00 INFO - Completed test suite (00:19:32) 14:13:00 INFO - Working with test: dromaeo_css 14:13:00 INFO - Generating results file: dromaeo_css 14:13:00 INFO - Working with test: kraken 14:13:00 INFO - Generating results file: kraken 14:13:00 INFO - javascript benchmark 14:13:00 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:13:00 INFO - process_Request line: dromaeo_css 6801.53 graph.html#tests=[[72,64,35]] 14:13:00 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:13:00 INFO - process_Request line: kraken 1521.50 graph.html#tests=[[232,64,35]] 14:13:00 INFO - RETURN: dromaeo_css: 6801.53 14:13:00 INFO - RETURN: kraken: 1521.50 14:13:00 INFO - javascript benchmark 14:13:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3072.4469595472806, 3087.3207894263264, 3138.6390565085007, 3141.701538353857, 3165.9552347725244, 4891.804327826887, 4902.60779137669, 4967.20524716045, 4971.577415919651, 4991.351124353833, 4983.3272508211385, 5016.247562865572, 5016.372953380827, 5050.646454748169, 5077.1622682257475, 4590.265557510799, 4608.078384323132, 4682.484926658065, 4699.553542413465, 4705.341252224691, 4552.4764652065105, 4623.653226008046, 4632.119897219534, 4676.55572720591, 4774.904501909959, 4617.353570500132, 4623.2371658676275, 4626.884327891813, 4671.556202160789, 4685.344051832746, 4597.310403439477, 4624.05206932578, 4641.0949864776385, 4646.883827904296, 4672.322513235596, 4591.678582499227, 4613.215753321943, 4625.236835922069, 4675.18184317743, 4690.671652984292, 4883.3651625288485, 4893.510648935114, 4914.04176185644, 4925.113479573675, 4941.308216849644, 5348.0, 5349.0639138151055, 5359.38367087786, 5359.892802143974, 5374.247605335257, 5412.0, 5450.100733378988, 5504.504594586507, 5536.197251398565, 5555.0, 5019.723915184663, 5023.372078490189, 5029.1450453423, 5030.195168772979, 5058.645894787403, 5436.836894893159, 5445.0, 5469.343678758495, 5473.06957817172, 5484.067708489566, 5352.6253162279045, 5365.356157261153, 5367.329083864517, 5410.188471729272, 5439.592030597721, 5427.48438898304, 5442.183672449164, 5443.074677304868, 5450.400455949843, 5451.836444906659, 5282.920756188661, 5375.9462405376225, 5423.159410291411, 5432.348118225759, 5466.972665136649, 5403.972980135153, 5427.402985671573, 5446.019716450997, 5449.04641687703, 5491.258680078138, 4190.371444283382, 4201.873943781691, 4205.285101532747, 4242.363645453145, 4244.278472659656, 3696.7966761828357, 3741.43878418234, 3784.829682664287, 3797.601251868514, 3807.8667246646232, 5132.435432102466, 5154.587632989352, 5155.9742201288755, 5159.948400516022, 5183.170692689152, 5436.70098144598, 5447.836564903059, 5450.345958484928, 5453.890922181534, 5497.340319161726, 5043.4956504349275, 5043.697378157249, 5145.279660847485, 5155.200943853709, 5168.9224661630105, 4626.259798432235, 4633.189191891405, 4645.396098507173, 4652.720836749806, 4689.249720044776, 5743.971280143656, 5749.223854779551, 5783.479486846204, 5786.016377215799, 5786.247787787561, 5311.44229855875, 5454.209139674805, 5474.452554744494, 5528.226048353315, 5536.695481748542, 5734.856628584319, 5739.225204597493, 5761.020626493422, 5763.625364351304, 5766.0, 5264.9736751315995, 5384.9730751346, 5386.811461598825, 5398.001369746609, 5431.9185212221055, 5467.972660136674, 5504.559635229252, 5509.917351239655, 5510.9448905510435, 5554.305711786027, 5336.573074153981, 5337.759800809051, 5362.436944120967, 5375.865603359947, 5377.193420986883, 5126.53861152498, 5207.531322181022, 5365.865853353697, 5371.167469042305, 5380.354357477127, 5156.071907056766, 5163.173892177384, 5167.560757335518, 5174.6119041072825, 5215.608829337739, 5270.156774915995, 5272.657277276965, 5274.89450210986, 5277.498637629419, 5321.840344789663, 5062.0888240115655, 5144.845654630367, 5151.098557752303, 5208.687478751287, 5214.426413094632], "unit": "score", "name": "dojo.html", "value": 5017.812262352827}, {"lowerIsBetter": false, "replicates": [528.460969810793, 549.5548605629443, 551.2392897801036, 580.7357652268217, 583.7694110826224, 36709.816450917744, 37314.06714832127, 37315.06712332193, 37388.25223495528, 37424.43863342052, 40116.59883401165, 40629.0, 40674.18651626973, 40705.38941915866, 40766.388504172384, 8384.951881014873, 8495.150484951486, 8527.95736021319, 8539.274161696263, 8573.699920502784, 8719.956400218021, 8898.199162075412, 8905.821883562325, 8907.198352148305, 8910.86633700495, 8894.199522043014, 8998.415103018282, 9003.324750643695, 9006.549672516381, 9007.729768106934, 8818.823623527525, 8893.155150260747, 8904.643814247422, 8918.241949434307, 8918.331125165638, 8719.782005449852, 8778.078301778285, 8855.955720221422, 8861.601227944693, 8865.157810008039, 39889.0, 40026.0, 40062.599374006175, 40117.0, 40182.397264041065, 1553.8601525862614, 3331.25046864456, 3398.099503631515, 3725.329440700673, 3956.980215098935, 30432.847835760902, 30641.69358306433, 30748.2312942176, 30772.692273077206, 31193.064208073793, 3836.0985168485386, 3867.3425517662067, 3894.415837624351, 3925.9803700981597, 3980.1641655252433, 266075.0, 266342.0, 266366.0, 266915.0, 269525.0, 53501.0, 53738.46261537335, 53745.1938220927, 53994.920101597745, 54004.0, 61134.694326528086, 61143.6942815292, 65754.0, 66395.33604663989, 66573.0, 15013.099214046973, 15043.247837608076, 15134.243287835785, 15214.695706085817, 15243.542693719206, 11298.774024519464, 11357.261777984404, 11357.898788724113, 11389.373584452935, 11394.94302528482, 20411.897940510204, 20945.266915657878, 20988.26541071055, 21010.474738131365, 21048.684269735968, 7962.880556791652, 8112.0, 8121.512709237465, 8207.507549547046, 8290.585470726439, 1001.8228581416806, 1057.5716834681966, 1071.244772435431, 1077.671310250381, 1119.3899324867966, 29420.11739647814, 29814.0, 31010.68989310078, 31590.210244744067, 32157.0, 1030.567161792049, 1051.7265510967204, 1052.1057101463848, 1061.363182090755, 1123.634818683931, 13817.170969741848, 14259.144451332953, 14293.213873237071, 16233.59416014609, 16681.332746690237, 397163.0, 400576.0, 403494.0, 404134.0, 405460.0, 56235.0, 56679.43320566742, 56688.0, 56713.0, 56748.432515675144, 1196.5632544121506, 1210.267787988272, 1383.4742797736797, 1406.810080639121, 1411.8941079419085, 26348.604770928836, 28823.0, 28994.13017609475, 29061.27346816262, 29409.11772646824, 43619.78190109029, 43963.78018109889, 44016.339754904344, 44022.559774401845, 44043.11913761771, 235360.0, 236954.81522592276, 237079.0, 237482.0, 238022.0, 27019.729802702506, 31243.375132497677, 33787.83106084454, 34023.65976340205, 34131.317373652884, 41029.38455923104, 41804.0, 41857.372139417326, 42107.36838947357, 42428.57571424246, 34792.13019674427, 35130.297394051464, 35192.64807351996, 35293.82353088321, 35478.645213547534, 34627.0, 34736.65263347334, 34814.65185348114, 34944.65055349414, 35421.291574168885, 34919.476207856394, 35076.64923350734, 35408.29183416369, 38461.230775384895, 39074.2185156301, 29535.409291814474, 31907.521387179677, 32959.340813184084, 33217.07423407743, 33570.832145839115, 25061.87469062643, 25302.74697253004, 25458.0, 25602.487950241262, 25633.743662563134], "unit": "score", "name": "ext.html", "value": 18519.983037547263}, {"lowerIsBetter": false, "replicates": [350.4795378862389, 352.13726370392544, 353.600431512391, 361.6148801526373, 364.19512876542836, 16993.74509382359, 17346.653066938652, 17997.910010449945, 18467.815321846778, 18477.0, 15040.323185456653, 15110.622234444118, 15796.131212783292, 15836.0, 15850.20748962553, 5375.166849138371, 5439.700816455093, 5602.7758889644365, 5611.80358687446, 5612.494875461208, 5473.480019398151, 5487.807926722566, 5517.475839795213, 5538.307711536058, 5563.109902415615, 5350.705711185883, 5385.21914322423, 5484.945150548503, 5532.474414930575, 5536.2249285100115, 5492.917606235889, 5507.256520369739, 5516.531094856942, 5532.529734972512, 5541.168824676311, 4890.706557606555, 4931.43288521821, 4939.753012349368, 4941.332920055783, 4952.504749525055, 20926.581468370547, 21844.344669659935, 21910.89044554783, 21919.232826851145, 22010.0, 2072.4404410808997, 2165.1555893201507, 2337.1118974789642, 2338.0, 2364.75170107138, 9395.812083758356, 9407.29445291606, 9441.858372124423, 9609.903900960971, 9847.655332063343, 1815.954601134969, 1853.5644123630937, 1859.228420205613, 1872.11074739499, 1905.4378958207362, 61954.380456195315, 66448.6677566614, 67050.0, 67727.0, 70997.93503097509, 10060.547275372626, 10106.140978016803, 10116.595336186618, 10199.18406527476, 10338.069573738248, 13308.201507909556, 13371.33143342829, 13412.195268283738, 13450.461981520826, 13451.0, 7105.147382314155, 7304.123505179413, 7338.743143990041, 7394.223606521346, 7401.259874012556, 7071.575705457689, 7072.292770722886, 7178.964105179545, 7186.568805871664, 7192.388646965067, 4319.568043195718, 4392.912141757147, 4408.470983482002, 4466.330050492452, 4473.194824931478, 1830.4783136805947, 1872.9157187926576, 1873.7564116664746, 1875.2217829600836, 1877.54000269932, 911.1344222988055, 953.8330792111353, 991.3506653142204, 1025.195221750922, 1038.065740833241, 16982.915085424494, 17057.573560661083, 17218.483445496655, 17332.39336623212, 17637.82362176362, 926.6802952981211, 950.695777351241, 953.7234202081457, 978.3542861711236, 1003.4230317567428, 9568.952155239318, 9877.654282100091, 9899.851502227473, 9911.256655750847, 10058.145057670034, 400105.0, 410348.0, 411494.0, 428287.0, 431876.0, 43873.78063109664, 47990.56028319156, 73200.2679973204, 77899.22100779033, 79763.0, 986.1371300112402, 996.5465713100522, 1014.8883622801486, 1017.3641474078701, 1023.6775415744016, 11568.0, 14778.261086945824, 14963.40146394132, 15263.465778698137, 15383.307751151002, 25161.622575661746, 31206.21984450407, 32466.67533324731, 33719.0, 34625.653743462244, 42068.0, 44023.339649904636, 44957.325640114774, 45080.77459612681, 45554.31668525041, 7621.466497345133, 7729.497582657109, 7927.128015918129, 8056.718014869686, 8109.675612975415, 9045.77385565366, 12247.203931744409, 12652.557160499338, 12812.743745125232, 12873.935630321788, 10554.577816887238, 10661.413622250851, 10710.250282480152, 11105.38920359388, 11116.388598627153, 10619.203559733205, 10622.468876556295, 10676.946615266874, 10852.18608604342, 11173.72065698364, 7160.928390716026, 10791.406472643766, 10958.835617465904, 11097.445127743742, 11121.221514493907, 7875.094364148196, 7912.604369781373, 7952.602369881367, 7996.520208787491, 8075.152109028702, 8245.876311855447, 10419.94790026045, 10648.414337211529, 10725.41010244444, 10756.139508839431], "unit": "score", "name": "jquery.html", "value": 8299.573044626575}, {"lowerIsBetter": false, "replicates": [1403.0669604712866, 1467.4643755029413, 1495.4990078323758, 1678.9580260493485, 1840.1995132117522, 6977.372036516713, 7611.0, 7747.186545412721, 7759.340456061242, 7775.183605721402, 7531.0, 7750.612469376522, 7759.5344279343135, 7768.68925242991, 7769.689212431496, 1955.589326241491, 2154.5906277807208, 2182.1925887421676, 2212.1814928476488, 2257.0745994142403, 2239.104358256694, 2277.851939623919, 2279.6124658808044, 2279.6466547685136, 2280.338701776483, 2207.2826331442348, 2296.402935236842, 2296.816254699628, 2297.253392647388, 2297.6783250344884, 2123.4054464749815, 2142.5393540388814, 2209.425549357171, 2245.9887700561558, 2250.0212407602744, 2236.7427745809114, 2267.444476103365, 2268.160780511221, 2274.65880117982, 2276.2374604507345, 7616.695332186706, 7651.961740191319, 7679.923200768033, 7685.654145563463, 7700.4609677322605, 4624.768761561909, 4735.195016847144, 4749.287606858964, 4767.118083154593, 4775.0, 3004.444177827109, 3078.4766589679584, 3146.4179126861377, 3151.1806930198086, 3154.7160755532113, 941.4351389166445, 954.6658669465701, 958.0323872888363, 1004.5233506745146, 1017.8676772019664, 10537.262391632588, 10689.465526723632, 10695.893041069567, 10714.464276786208, 10724.0, 4021.9195616087513, 4156.688248381383, 4243.745375277432, 4296.720713153635, 4308.418363520885, 9084.454932703928, 9099.499527525917, 9104.681336153202, 9304.069593040642, 9368.859467107999, 4304.612584867377, 4755.619550435957, 4764.547368000034, 4765.499622539653, 4770.451398089264, 4132.235536425771, 4145.253854306194, 4182.247195504839, 4190.958090419118, 4192.685548583808, 3581.28374325136, 3649.1789347396625, 3658.689011434058, 3674.963250367462, 3691.7046636269033, 1114.816055350858, 1143.8684551276542, 1158.976820463603, 1170.4791367841228, 1170.7365842685329, 1367.0362394511844, 1369.0895554456374, 1403.4666826605824, 1406.1282005156868, 1407.2541552976938, 7305.707771689179, 7570.394368450621, 7573.545587264782, 7579.355754760907, 7591.696332146763, 454.8317122664635, 457.4921836761192, 459.4716076512038, 460.26587592789446, 480.37311308742426, 5689.431056894277, 5698.943010569924, 5705.600607957486, 5755.769769209269, 5758.1362795581, 8902.910970890209, 9019.594118264693, 9059.773505662411, 9155.13026262504, 9158.81682366349, 8977.057408972094, 9021.909780902108, 9023.864642030374, 9128.3153763468, 9137.862932056025, 7234.674439650228, 7250.492465527468, 7382.298681625237, 7419.8145046374275, 7440.590767507839, 7313.0, 7324.523905946309, 7365.484416090822, 7366.815829604303, 7368.778936631909, 8230.711925082593, 8418.6211620476, 8574.742757717278, 8691.652333906573, 8712.21590056898, 8491.532965686947, 8649.740507784525, 8733.606987685696, 8745.906761654793, 8883.955580222058, 6077.0, 6665.0668906352175, 6846.110005699227, 7000.579965202104, 7108.431325493844, 7343.192248852515, 7385.409167266714, 7431.739889103856, 7465.962670186615, 7487.925120748723, 6544.705488253136, 6698.062271282122, 6751.594904305757, 6780.0, 6886.793396198122, 6658.234303055211, 6665.5334126612615, 6711.63086030273, 6810.046593477016, 6846.246912839683, 6963.0, 7002.159740831133, 7032.085828842218, 7033.261507541839, 7059.258777828254, 6472.708728107153, 6520.934790652223, 6554.672266386567, 6558.80323590293, 6568.967155164193, 6418.069379939976, 6420.133282006869, 6422.197225346832, 6431.614103153825, 6432.09950606906], "unit": "score", "name": "mootools.html", "value": 4371.652920097148}, {"lowerIsBetter": false, "replicates": [322.5822559785078, 329.23781445952625, 336.94103531881916, 337.2344777355405, 344.33886937080786, 5753.568482363824, 5796.855078623026, 5830.4461076197695, 5838.445347691968, 5870.471657550825, 5731.283589551306, 5747.080467125261, 5749.827505174841, 5759.078547432412, 5760.971195144019, 4304.160688665712, 4363.716358436707, 4449.132419178261, 4486.035502366991, 4526.502084770665, 4442.600165985061, 4444.066745983331, 4456.086502267044, 4473.1501014807245, 4474.3064824952025, 4418.779061046935, 4464.196444639963, 4469.731816091029, 4474.552544745516, 4495.988402609403, 4281.807318670667, 4348.543402942709, 4441.333799930004, 4465.531119232466, 4465.776711164429, 3921.764694118362, 3938.8818335449982, 3945.230680017398, 3951.8616848410456, 3953.683705303569, 5502.779888804443, 5513.0, 5514.558835293167, 5516.282883225195, 5528.281323427928, 5185.288854677985, 5187.688738675653, 5190.636655434121, 5196.090684130299, 5196.32447781786, 6077.878442431127, 6085.817425477243, 6093.817185484442, 6097.786577469812, 6102.389761023906, 4143.834246630161, 4266.0827921996915, 4279.700420970534, 4371.759553224571, 4377.649788016951, 6309.747610095636, 6353.777617783356, 6376.585521941105, 6377.649229292387, 6384.68076596173, 4354.107407981356, 4364.650827933758, 4366.956330436718, 4369.453818272716, 4380.211561918885, 4422.29243321067, 4422.800973956179, 4423.977880110643, 4428.9149158456385, 4429.53489883564, 5104.770285337168, 5111.821086261963, 5115.18157094863, 5116.769745361467, 5131.692098474104, 5938.465538101592, 6153.1693221415435, 6159.907601385983, 6165.537584681167, 6167.722452489649, 1513.3492598182886, 1537.1929736888223, 1541.3218183999004, 1545.2814441284631, 1551.5655616427418, 935.5930170375908, 997.5336255704103, 1001.9579637177254, 1041.5156952017348, 1050.1546255264432, 5804.216430781875, 5835.299764028344, 5842.503387212049, 5873.148393483007, 5882.323532793698, 6227.595206311576, 6238.812835614939, 6240.7503699852405, 6245.531585131133, 6245.6252624842655, 5860.0, 5862.296524417097, 5864.736086876101, 5868.735906884201, 5887.911681324784, 3341.3484370547994, 3368.3768502826565, 3369.157710572357, 3369.966300337014, 3370.5449764281507, 6443.581167224115, 6615.0, 6616.900746488806, 6618.371254730793, 6632.602043877383, 6329.0, 6353.587016843982, 6355.777547785805, 6356.173697419398, 6364.363563643598, 6588.110605068255, 6588.143541339595, 6597.0, 6605.801825945133, 6607.80176594703, 6228.501719862491, 6233.781817636361, 6254.312025677081, 6259.061140828912, 6263.4362907338555, 6025.427584379477, 6178.196834411498, 6198.473129784019, 6200.0699895016105, 6200.56596038273, 6612.966935165294, 6654.4676425884845, 6659.267480577036, 6660.933390666031, 6667.599944003376, 4360.215161271001, 4369.978150109229, 4378.365137055172, 4382.539833317455, 4383.846565370197, 6258.906116408349, 6261.655608941552, 6267.592606480564, 6271.3415091414745, 6277.623342599459, 6073.240844894388, 6074.301455332693, 6077.756889724362, 6084.148219249397, 6084.543659225487, 5919.0, 6069.271687397364, 6069.271687397364, 6121.081837724377, 6164.7842325518395, 5952.791652292149, 5976.61152025117, 5985.610935289193, 5986.371430999682, 5993.9700301498215, 6109.877802443837, 6115.296740874678, 6115.5719099664375, 6116.510679145568, 6117.938820611915, 5757.683327417032, 5882.0, 5914.704264786829, 5943.0, 5954.821355359346], "unit": "score", "name": "prototype.html", "value": 4619.849235447776}, {"lowerIsBetter": false, "replicates": [666.8866292730236, 684.9383555480006, 703.2334755116923, 718.6837791371796, 836.5733475927277, 13744.31278436078, 14173.291335433212, 14173.716525669506, 14186.999999999987, 14187.716245675094, 13017.0, 13286.0, 13293.069485136044, 13295.667608309774, 13313.201207927532, 806.3750593290189, 823.1398188892622, 823.7775800533852, 824.1058451580043, 824.4558591329724, 674.7199912036499, 808.8058865872177, 811.3225456743626, 814.1492140712969, 823.7899335669396, 855.9871601925945, 865.1219012702112, 865.5974971638187, 865.6364326982682, 866.1598249697784, 853.7822855171953, 856.7044369692446, 858.2533196119385, 858.9785255368603, 860.2043110123174, 521.8590980435299, 621.3444815719414, 627.6422439209653, 634.6445990245477, 643.8808820368247, 11854.407279635983, 11859.407029648482, 11862.11034172432, 11863.46614402354, 11885.524579016828, 12327.198732082386, 12682.55611053618, 12823.230606163566, 12844.165129266661, 12981.480740770357, 9268.629254829866, 9426.764330891714, 9472.668456604055, 9579.0, 9652.083052110038, 3559.1280136366495, 3568.232829941549, 3571.9443987907407, 3572.517710109128, 3635.1275693833554, 49099.99999999964, 49506.50493495055, 49591.50408495905, 49899.50100498985, 50121.74939125317, 10474.738131546772, 10479.318844275098, 10542.47287635615, 10588.841167382496, 10911.727206819893, 16878.831211687724, 17025.48923532296, 17048.659026819394, 17054.829451705573, 17100.486985390457, 7495.0, 7844.568548729874, 7945.046594408593, 7946.801329966797, 7963.981692681555, 3859.3824988001784, 3895.162540053902, 4319.0, 4394.714343567658, 4447.844325448594, 3148.307372378073, 3159.0, 3161.4941609342395, 3175.872965081417, 3179.8410079495934, 575.815738963536, 591.3317950715664, 592.2922108080888, 595.5235811350989, 606.8361542383532, 621.7015832400383, 679.7111227728195, 698.0611078099947, 702.6943279673359, 704.8132244954988, 8885.822283554293, 9495.715128546155, 9506.667266645773, 9573.712788616212, 9685.806283874283, 657.3426573426574, 671.5131529640971, 674.0933444517117, 681.7375310505491, 704.0741425026176, 3959.3467077932396, 3962.603739626072, 4075.9388609170887, 4127.834886604503, 4234.25900467417, 54477.45522544803, 56902.0, 57318.713406432704, 57787.0, 57892.13161802576, 46747.532524675, 47022.76488617535, 47264.527354726015, 47437.288440673416, 47611.5238847614, 44941.32588011182, 46220.76889615531, 46474.302885456746, 46509.76745116321, 46615.76692116586, 8787.0, 8934.195922367018, 9021.684241051795, 9124.95437522808, 9167.679131230376, 34291.485627715105, 34631.65368346284, 35031.12422189466, 36770.448443272835, 36925.0, 39610.405843912944, 40359.0, 44624.55375446334, 44689.0, 45367.546324536335, 11539.134564907497, 11568.248063876157, 11612.187146899974, 12017.278963262232, 12241.143119981516, 12215.0, 12419.751604967669, 12438.937805310916, 12493.750124997267, 12583.307918064595, 11915.285082895054, 12059.042052602763, 12121.333326667118, 12413.93793031029, 12448.68878278014, 11541.249818761753, 11880.65957530945, 12047.457864395948, 12370.62888113358, 12467.563635272722, 11197.66407007791, 11540.538378464767, 11767.11746619024, 12058.397080146133, 12203.023758099509, 9764.902350976683, 9884.406935583887, 9891.554880030271, 10051.0, 10282.485875706334, 9053.77365565866, 9385.0, 9592.856107158537, 9625.470599117116, 10124.69625911224], "unit": "score", "name": "yui.html", "value": 6354.973817194542}], "name": "dromaeo_css", "value": 6801.52783497114}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 111.0, 111.0, 100.0, 110.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 151.0, 172.0, 138.0, 159.0, 153.0, 126.0, 183.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.0}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 163.0, 161.0, 159.0, 160.0, 161.0, 163.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 99.0, 97.0, 73.0, 72.0, 72.0, 129.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 148.0, 97.0, 97.0, 95.0, 149.0, 96.0, 95.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 55.0, 56.0, 56.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 69.0, 69.0, 69.0, 68.0, 68.0, 70.0, 71.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 84.0, 83.0, 83.0, 82.0, 82.0, 91.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 121.0, 116.0, 124.0, 118.0, 127.0, 115.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [155.0, 148.0, 141.0, 143.0, 148.0, 138.0, 149.0, 153.0, 148.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 70.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1521.4999999999998}]} 14:13:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6801.53"}}} 14:13:00 INFO - Return code: 0 14:13:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:13:00 INFO - # TBPL SUCCESS # 14:13:00 INFO - Running post-action listener: _resource_record_post_action 14:13:00 INFO - Running post-run listener: _resource_record_post_run 14:13:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 28672; Write bytes: 514617344; Read time: 324; Write time: 457472 14:13:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 133402624; Read time: 260; Write time: 146996 14:13:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 24576; Write bytes: 300326912; Read time: 64; Write time: 195416 14:13:01 INFO - Running post-run listener: _upload_blobber_files 14:13:01 INFO - Blob upload gear active. 14:13:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:13:01 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 14:13:01 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'] 14:13:01 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 14:13:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:13:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:13:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:03 INFO - (blobuploader) - INFO - Done attempting. 14:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:13:04 INFO - (blobuploader) - INFO - Done attempting. 14:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:13:04 INFO - Return code: 0 14:13:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:13:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:13:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb514dd5c4ccf01aea611066d7222b4aa5a67196d53bae2003813e3cb74daa32194874a083d70382925fdc94d1217f7bf323645172475bd8540531395c8dd056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a943db1cf10b4f09de1e55834702ac0721e5b5252405b849381c9eb1f342d7a8c0ba37e6c36cad6a72f0ad27fd060a98909cf4854534dc0cc7a512c663ab3c7"} 14:13:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:13:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:13:04 INFO - Contents: 14:13:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb514dd5c4ccf01aea611066d7222b4aa5a67196d53bae2003813e3cb74daa32194874a083d70382925fdc94d1217f7bf323645172475bd8540531395c8dd056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a943db1cf10b4f09de1e55834702ac0721e5b5252405b849381c9eb1f342d7a8c0ba37e6c36cad6a72f0ad27fd060a98909cf4854534dc0cc7a512c663ab3c7"} 14:13:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:13:04 INFO - Copying logs to upload dir... 14:13:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:13:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.218171 ========= master_lag: 9.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-02-26 14:13:13.494489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 14:13:13.497584) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 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/fb514dd5c4ccf01aea611066d7222b4aa5a67196d53bae2003813e3cb74daa32194874a083d70382925fdc94d1217f7bf323645172475bd8540531395c8dd056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a943db1cf10b4f09de1e55834702ac0721e5b5252405b849381c9eb1f342d7a8c0ba37e6c36cad6a72f0ad27fd060a98909cf4854534dc0cc7a512c663ab3c7"} build_url:https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/D6A_TGbrRPy29-F5ZYvJpA/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/fb514dd5c4ccf01aea611066d7222b4aa5a67196d53bae2003813e3cb74daa32194874a083d70382925fdc94d1217f7bf323645172475bd8540531395c8dd056", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a943db1cf10b4f09de1e55834702ac0721e5b5252405b849381c9eb1f342d7a8c0ba37e6c36cad6a72f0ad27fd060a98909cf4854534dc0cc7a512c663ab3c7"}' ========= master_lag: 0.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 14:13:13.669518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:13:13.669830) ========= 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=33d5923976266a1c518c4bf7000001ab-1456522848.967105-856807059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 14:13:13.685611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 14:13:13.685897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 14:13:13.686178) ========= ========= Total master_lag: 9.74 =========