builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1455345692.69 results: success (0) buildid: 20160212203128 builduid: 1e417528b49c41dc9dbc533ef962cfe3 revision: 617e089684ae22f75215467ac13729d1ef3bf01e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.691426) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.692248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.695954) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.749227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.749661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.809056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.809346) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004749 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.859111) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.862451) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.862864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:32.863151) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-12 22:41:33-- 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% 217M=0s 2016-02-12 22:41:33 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.258672 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.143845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.144134) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017670 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.193290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.193650) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 617e089684ae22f75215467ac13729d1ef3bf01e --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 617e089684ae22f75215467ac13729d1ef3bf01e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-12 22:41:33,738 truncating revision to first 12 chars 2016-02-12 22:41:33,738 Setting DEBUG logging. 2016-02-12 22:41:33,738 attempt 1/10 2016-02-12 22:41:33,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/617e089684ae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 22:41:34,163 unpacking tar archive at: fx-team-617e089684ae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.920097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.922214) ========= echo 617e089684ae22f75215467ac13729d1ef3bf01e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'617e089684ae22f75215467ac13729d1ef3bf01e'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 617e089684ae22f75215467ac13729d1ef3bf01e program finished with exit code 0 elapsedTime=0.004050 script_repo_revision: '617e089684ae22f75215467ac13729d1ef3bf01e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.974209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.974572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 22:41:33.986442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-02-12 22:41:33.986761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:41:34 INFO - MultiFileLogger online at 20160212 22:41:34 in /builds/slave/test-pgo 22:41:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:41:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:41:34 INFO - {'append_to_log': False, 22:41:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:41:34 INFO - 'blob_upload_branch': 'Fx-Team', 22:41:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:41:34 INFO - 'branch': 'Fx-Team', 22:41:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:41:34 INFO - 'config_files': ('talos/linux_config.py',), 22:41:34 INFO - 'default_actions': ('clobber', 22:41:34 INFO - 'read-buildbot-config', 22:41:34 INFO - 'download-and-extract', 22:41:34 INFO - 'populate-webroot', 22:41:34 INFO - 'create-virtualenv', 22:41:34 INFO - 'install', 22:41:34 INFO - 'run-tests'), 22:41:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:41:34 INFO - 'download_minidump_stackwalk': True, 22:41:34 INFO - 'download_symbols': 'ondemand', 22:41:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:41:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:41:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:41:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:41:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:41:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:41:34 INFO - 'installer_path': 'installer.exe', 22:41:34 INFO - 'log_level': 'info', 22:41:34 INFO - 'log_name': 'talos', 22:41:34 INFO - 'log_to_console': True, 22:41:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:41:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:41:34 INFO - 'opt_config_files': (), 22:41:34 INFO - 'pip_index': False, 22:41:34 INFO - 'sps_profile': False, 22:41:34 INFO - 'sps_profile_interval': 0, 22:41:34 INFO - 'suite': 'dromaeojs-e10s', 22:41:34 INFO - 'system_bits': '32', 22:41:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:41:34 INFO - 'title': 'talos-linux64-ix-032', 22:41:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:41:34 INFO - 'use_talos_json': True, 22:41:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:41:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:41:34 INFO - 'work_dir': 'build'} 22:41:34 INFO - ##### 22:41:34 INFO - ##### Running clobber step. 22:41:34 INFO - ##### 22:41:34 INFO - Running pre-action listener: _resource_record_pre_action 22:41:34 INFO - Running main action method: clobber 22:41:34 INFO - rmtree: /builds/slave/test-pgo/build 22:41:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:41:35 INFO - Running post-action listener: _resource_record_post_action 22:41:35 INFO - ##### 22:41:35 INFO - ##### Running read-buildbot-config step. 22:41:35 INFO - ##### 22:41:35 INFO - Running pre-action listener: _resource_record_pre_action 22:41:35 INFO - Running main action method: read_buildbot_config 22:41:35 INFO - Using buildbot properties: 22:41:35 INFO - { 22:41:35 INFO - "project": "", 22:41:35 INFO - "product": "firefox", 22:41:35 INFO - "script_repo_revision": "production", 22:41:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:41:35 INFO - "repository": "", 22:41:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:41:35 INFO - "buildid": "20160212203128", 22:41:35 INFO - "pgo_build": "True", 22:41:35 INFO - "basedir": "/builds/slave/test-pgo", 22:41:35 INFO - "buildnumber": 492, 22:41:35 INFO - "slavename": "talos-linux64-ix-032", 22:41:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:41:35 INFO - "platform": "ubuntu64_hw", 22:41:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:41:35 INFO - "branch": "fx-team", 22:41:35 INFO - "repo_path": "integration/fx-team", 22:41:35 INFO - "revision": "617e089684ae22f75215467ac13729d1ef3bf01e", 22:41:35 INFO - "stage_platform": "linux64-pgo", 22:41:35 INFO - "builduid": "1e417528b49c41dc9dbc533ef962cfe3", 22:41:35 INFO - "slavebuilddir": "test" 22:41:35 INFO - } 22:41:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:41:35 INFO - Running post-action listener: _resource_record_post_action 22:41:35 INFO - ##### 22:41:35 INFO - ##### Running download-and-extract step. 22:41:35 INFO - ##### 22:41:35 INFO - Running pre-action listener: _resource_record_pre_action 22:41:35 INFO - Running main action method: download_and_extract 22:41:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:41:35 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')]} 22:41:35 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:41:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json 22:41:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json 22:41:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:41:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:41:36 INFO - Downloaded 1448 bytes. 22:41:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:41:36 INFO - Using the following test package requirements: 22:41:36 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:41:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:41:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'jsshell-linux-x86_64.zip'], 22:41:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:41:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:41:36 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:41:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:41:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:41:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:41:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:41:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:36 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:37 INFO - Downloaded 23296074 bytes. 22:41:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:41:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:41:39 INFO - Return code: 0 22:41:39 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 22:41: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')]} 22:41:39 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:40 INFO - Downloaded 23296074 bytes. 22:41:40 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'] 22:41:40 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 22:41:42 INFO - Return code: 0 22:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:42 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:43 INFO - Downloaded 10707070 bytes. 22:41:43 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'] 22:41:43 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 22:41:43 INFO - Return code: 0 22:41:43 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')]} 22:41:43 INFO - https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaQqh15MRt6u7e-nVXkfiA/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 22:41:44 INFO - Downloaded 56531876 bytes. 22:41:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:44 INFO - mkdir: /builds/slave/test-pgo/properties 22:41:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:41:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:41:44 INFO - Contents: 22:41:44 INFO - build_url:https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:41:45 INFO - Running post-action listener: _resource_record_post_action 22:41:45 INFO - Running post-action listener: set_extra_try_arguments 22:41:45 INFO - ##### 22:41:45 INFO - ##### Running populate-webroot step. 22:41:45 INFO - ##### 22:41:45 INFO - Running pre-action listener: _resource_record_pre_action 22:41:45 INFO - Running main action method: populate_webroot 22:41:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:41:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:41:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:41:45 INFO - '--tppagecycles', 22:41:45 INFO - '7'], 22:41:45 INFO - 'tests': ['tsvgm']}}, 22:41:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:41:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:41:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:41:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:41:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:41:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'tests': ['damp', 'tps']}, 22:41:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['damp', 'tps']}, 22:41:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:41:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:41:45 INFO - 'other': {'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'other_l64': {'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'other_nol64': {'tests': ['a11yr', 22:41:45 INFO - 'ts_paint', 22:41:45 INFO - 'tpaint', 22:41:45 INFO - 'sessionrestore', 22:41:45 INFO - 'sessionrestore_no_auto_restore']}, 22:41:45 INFO - 'svgr': {'tests': ['tsvgx', 22:41:45 INFO - 'tsvgr_opacity', 22:41:45 INFO - 'tart', 22:41:45 INFO - 'tscrollx', 22:41:45 INFO - 'cart']}, 22:41:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['tsvgx', 22:41:45 INFO - 'tsvgr_opacity', 22:41:45 INFO - 'tart', 22:41:45 INFO - 'tscrollx', 22:41:45 INFO - 'cart']}, 22:41:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'tests': ['tp5o']}, 22:41:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'talos_options': ['--e10s'], 22:41:45 INFO - 'tests': ['tp5o']}, 22:41:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'talos_options': ['--xperf_path', 22:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:45 INFO - 'tests': ['tp5n']}, 22:41:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:41:45 INFO - 'talos_options': ['--e10s', 22:41:45 INFO - '--xperf_path', 22:41:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:41:45 INFO - 'tests': ['tp5n']}}, 22:41:45 INFO - 'talos.zip': {'path': '', 22:41:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:41:45 INFO - Running post-action listener: _resource_record_post_action 22:41:45 INFO - ##### 22:41:45 INFO - ##### Running create-virtualenv step. 22:41:45 INFO - ##### 22:41:45 INFO - Running pre-action listener: _resource_record_pre_action 22:41:45 INFO - Running main action method: create_virtualenv 22:41:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:41: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 22:41:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:41:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:41:45 INFO - Using real prefix '/usr' 22:41:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:41:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:41:48 INFO - Installing pip.................done. 22:41:48 INFO - Return code: 0 22:41:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41: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 22:41: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 22:41:48 INFO - Using env: {'DISPLAY': ':0', 22:41:48 INFO - 'HOME': '/home/cltbld', 22:41:48 INFO - 'LANG': 'en_US.UTF-8', 22:41:48 INFO - 'LANGUAGE': 'en_US:en', 22:41:48 INFO - 'LOGNAME': 'cltbld', 22:41:48 INFO - 'MAIL': '/var/mail/cltbld', 22:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:48 INFO - 'MOZ_NO_REMOTE': '1', 22:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:48 INFO - 'NO_EM_RESTART': '1', 22:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:48 INFO - 'SHELL': '/bin/bash', 22:41:48 INFO - 'SHLVL': '1', 22:41:48 INFO - 'TERM': 'linux', 22:41:48 INFO - 'TMOUT': '86400', 22:41:48 INFO - 'USER': 'cltbld', 22:41:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:48 INFO - '_': '/tools/buildbot/bin/python'} 22:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41: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 22:41:48 INFO - Cleaning up... 22:41:48 INFO - Return code: 0 22:41:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41: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 22:41: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 22:41:48 INFO - Using env: {'DISPLAY': ':0', 22:41:48 INFO - 'HOME': '/home/cltbld', 22:41:48 INFO - 'LANG': 'en_US.UTF-8', 22:41:48 INFO - 'LANGUAGE': 'en_US:en', 22:41:48 INFO - 'LOGNAME': 'cltbld', 22:41:48 INFO - 'MAIL': '/var/mail/cltbld', 22:41:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:48 INFO - 'MOZ_NO_REMOTE': '1', 22:41:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:48 INFO - 'NO_EM_RESTART': '1', 22:41:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:48 INFO - 'SHELL': '/bin/bash', 22:41:48 INFO - 'SHLVL': '1', 22:41:48 INFO - 'TERM': 'linux', 22:41:48 INFO - 'TMOUT': '86400', 22:41:48 INFO - 'USER': 'cltbld', 22:41:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:48 INFO - '_': '/tools/buildbot/bin/python'} 22:41:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:48 INFO - Downloading/unpacking psutil>=0.7.1 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:50 INFO - Installing collected packages: psutil 22:41:50 INFO - Running setup.py install for psutil 22:41:50 INFO - building 'psutil._psutil_linux' extension 22:41: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 22:41: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 22:41:50 INFO - building 'psutil._psutil_posix' extension 22:41: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 22:41: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 22:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:41:50 INFO - Successfully installed psutil 22:41:51 INFO - Cleaning up... 22:41:51 INFO - Return code: 0 22:41:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41: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 22:41: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 22:41:51 INFO - Using env: {'DISPLAY': ':0', 22:41:51 INFO - 'HOME': '/home/cltbld', 22:41:51 INFO - 'LANG': 'en_US.UTF-8', 22:41:51 INFO - 'LANGUAGE': 'en_US:en', 22:41:51 INFO - 'LOGNAME': 'cltbld', 22:41:51 INFO - 'MAIL': '/var/mail/cltbld', 22:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:51 INFO - 'MOZ_NO_REMOTE': '1', 22:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:51 INFO - 'NO_EM_RESTART': '1', 22:41:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:51 INFO - 'SHELL': '/bin/bash', 22:41:51 INFO - 'SHLVL': '1', 22:41:51 INFO - 'TERM': 'linux', 22:41:51 INFO - 'TMOUT': '86400', 22:41:51 INFO - 'USER': 'cltbld', 22:41:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:51 INFO - '_': '/tools/buildbot/bin/python'} 22:41:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:41:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:41: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) 22:41:53 INFO - Installing collected packages: mozsystemmonitor 22:41:53 INFO - Running setup.py install for mozsystemmonitor 22:41:53 INFO - Successfully installed mozsystemmonitor 22:41:53 INFO - Cleaning up... 22:41:53 INFO - Return code: 0 22:41:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41: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 22:41: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 22:41:53 INFO - Using env: {'DISPLAY': ':0', 22:41:53 INFO - 'HOME': '/home/cltbld', 22:41:53 INFO - 'LANG': 'en_US.UTF-8', 22:41:53 INFO - 'LANGUAGE': 'en_US:en', 22:41:53 INFO - 'LOGNAME': 'cltbld', 22:41:53 INFO - 'MAIL': '/var/mail/cltbld', 22:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:53 INFO - 'MOZ_NO_REMOTE': '1', 22:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:53 INFO - 'NO_EM_RESTART': '1', 22:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:53 INFO - 'SHELL': '/bin/bash', 22:41:53 INFO - 'SHLVL': '1', 22:41:53 INFO - 'TERM': 'linux', 22:41:53 INFO - 'TMOUT': '86400', 22:41:53 INFO - 'USER': 'cltbld', 22:41:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:53 INFO - '_': '/tools/buildbot/bin/python'} 22:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:53 INFO - Downloading/unpacking blobuploader==1.2.4 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:55 INFO - Downloading blobuploader-1.2.4.tar.gz 22:41:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:41:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:41:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41: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 22:41:55 INFO - Downloading docopt-0.6.1.tar.gz 22:41:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:41:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:41:56 INFO - Running setup.py install for blobuploader 22:41:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:41:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:41:56 INFO - Running setup.py install for requests 22:41:56 INFO - Running setup.py install for docopt 22:41:56 INFO - Successfully installed blobuploader requests docopt 22:41:56 INFO - Cleaning up... 22:41:56 INFO - Return code: 0 22:41:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:41: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')]} 22:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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')]} 22:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41: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 22:41: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 22:41:56 INFO - Using env: {'DISPLAY': ':0', 22:41:56 INFO - 'HOME': '/home/cltbld', 22:41:56 INFO - 'LANG': 'en_US.UTF-8', 22:41:56 INFO - 'LANGUAGE': 'en_US:en', 22:41:56 INFO - 'LOGNAME': 'cltbld', 22:41:56 INFO - 'MAIL': '/var/mail/cltbld', 22:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:56 INFO - 'MOZ_NO_REMOTE': '1', 22:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:56 INFO - 'NO_EM_RESTART': '1', 22:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:56 INFO - 'SHELL': '/bin/bash', 22:41:56 INFO - 'SHLVL': '1', 22:41:56 INFO - 'TERM': 'linux', 22:41:56 INFO - 'TMOUT': '86400', 22:41:56 INFO - 'USER': 'cltbld', 22:41:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:56 INFO - '_': '/tools/buildbot/bin/python'} 22:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:56 INFO - Running setup.py (path:/tmp/pip-YYQjFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:56 INFO - Running setup.py (path:/tmp/pip-7sn1FV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:41:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:56 INFO - Running setup.py (path:/tmp/pip-oWH6I6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:57 INFO - Running setup.py (path:/tmp/pip-V3QKi0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:57 INFO - Running setup.py (path:/tmp/pip-eeA5hz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:57 INFO - Running setup.py (path:/tmp/pip-0h46mt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:57 INFO - Running setup.py (path:/tmp/pip-5b9h6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:57 INFO - Running setup.py (path:/tmp/pip-FP6i8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:57 INFO - Running setup.py (path:/tmp/pip-7oV1lB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:41:57 INFO - Running setup.py (path:/tmp/pip-OskAxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:41:57 INFO - Running setup.py (path:/tmp/pip-JvTgPt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:41:57 INFO - Running setup.py (path:/tmp/pip-yBwc7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:41:57 INFO - Running setup.py (path:/tmp/pip-KXMEtO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:41:57 INFO - Running setup.py (path:/tmp/pip-lpPMVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:41:57 INFO - Running setup.py (path:/tmp/pip-WedpVf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:41:57 INFO - Running setup.py (path:/tmp/pip-vLpv1X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:41:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:41:57 INFO - Running setup.py (path:/tmp/pip-pQODB1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:41:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:41:58 INFO - Running setup.py install for manifestparser 22:41:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozcrash 22:41:58 INFO - Running setup.py install for mozdebug 22:41:58 INFO - Running setup.py install for mozdevice 22:41:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozfile 22:41:58 INFO - Running setup.py install for mozhttpd 22:41:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozinfo 22:41:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozInstall 22:41:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:41:58 INFO - Running setup.py install for mozleak 22:41:58 INFO - Running setup.py install for mozlog 22:41:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Running setup.py install for moznetwork 22:41:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Running setup.py install for mozprocess 22:41:59 INFO - Running setup.py install for mozprofile 22:41:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Running setup.py install for mozrunner 22:41:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Running setup.py install for mozscreenshot 22:41:59 INFO - Running setup.py install for moztest 22:41:59 INFO - Running setup.py install for mozversion 22:41:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:41:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:41:59 INFO - Cleaning up... 22:41:59 INFO - Return code: 0 22:41:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:41:59 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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:41:59 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 22:41:59 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 22:41:59 INFO - Using env: {'DISPLAY': ':0', 22:41:59 INFO - 'HOME': '/home/cltbld', 22:41:59 INFO - 'LANG': 'en_US.UTF-8', 22:41:59 INFO - 'LANGUAGE': 'en_US:en', 22:41:59 INFO - 'LOGNAME': 'cltbld', 22:41:59 INFO - 'MAIL': '/var/mail/cltbld', 22:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:41:59 INFO - 'MOZ_NO_REMOTE': '1', 22:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:41:59 INFO - 'NO_EM_RESTART': '1', 22:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:41:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:41:59 INFO - 'SHELL': '/bin/bash', 22:41:59 INFO - 'SHLVL': '1', 22:41:59 INFO - 'TERM': 'linux', 22:41:59 INFO - 'TMOUT': '86400', 22:41:59 INFO - 'USER': 'cltbld', 22:41:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:41:59 INFO - '_': '/tools/buildbot/bin/python'} 22:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42:00 INFO - Running setup.py (path:/tmp/pip-G4Zwa4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42:00 INFO - Running setup.py (path:/tmp/pip-oYU6wn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42:00 INFO - Running setup.py (path:/tmp/pip-6LBjFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42:00 INFO - Running setup.py (path:/tmp/pip-9aTRkU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42:00 INFO - Running setup.py (path:/tmp/pip-JYrqWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42:00 INFO - Running setup.py (path:/tmp/pip-szQXfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42:00 INFO - Running setup.py (path:/tmp/pip-ZaV49t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42:00 INFO - Running setup.py (path:/tmp/pip-5M1KdT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42:00 INFO - Running setup.py (path:/tmp/pip-W_IDrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:42: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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:00 INFO - Running setup.py (path:/tmp/pip-lBnUd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:42:00 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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:00 INFO - Running setup.py (path:/tmp/pip-gocvPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:42:00 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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:00 INFO - Running setup.py (path:/tmp/pip-q8A2vz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:42:00 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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:00 INFO - Running setup.py (path:/tmp/pip-lteTf_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:42:00 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)) 22:42:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42:00 INFO - Running setup.py (path:/tmp/pip-DCA4p8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:42: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)) 22:42:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42:01 INFO - Running setup.py (path:/tmp/pip-uJj0Nn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:42: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)) 22:42:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:42:01 INFO - Running setup.py (path:/tmp/pip-nD6TXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:42: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)) 22:42:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42:01 INFO - Running setup.py (path:/tmp/pip-IxWehP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:42: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)) 22:42: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)) 22:42: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)) 22:42: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)) 22:42: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)) 22:42: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)) 22:42:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:03 INFO - Downloading blessings-1.6.tar.gz 22:42:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:42:03 INFO - Installing collected packages: blessings 22:42:03 INFO - Running setup.py install for blessings 22:42:03 INFO - Successfully installed blessings 22:42:03 INFO - Cleaning up... 22:42:03 INFO - Return code: 0 22:42:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:42:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:42:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:42:03 INFO - Reading from file tmpfile_stdout 22:42:03 INFO - Current package versions: 22:42:03 INFO - argparse == 1.2.1 22:42:03 INFO - blessings == 1.6 22:42:03 INFO - blobuploader == 1.2.4 22:42:03 INFO - docopt == 0.6.1 22:42:03 INFO - manifestparser == 1.1 22:42:03 INFO - mozInstall == 1.12 22:42:03 INFO - mozcrash == 0.16 22:42:03 INFO - mozdebug == 0.1 22:42:03 INFO - mozdevice == 0.48 22:42:03 INFO - mozfile == 1.2 22:42:03 INFO - mozhttpd == 0.7 22:42:03 INFO - mozinfo == 0.9 22:42:03 INFO - mozleak == 0.1 22:42:03 INFO - mozlog == 3.1 22:42:03 INFO - moznetwork == 0.27 22:42:03 INFO - mozprocess == 0.22 22:42:03 INFO - mozprofile == 0.28 22:42:03 INFO - mozrunner == 6.11 22:42:03 INFO - mozscreenshot == 0.1 22:42:03 INFO - mozsystemmonitor == 0.0 22:42:03 INFO - moztest == 0.7 22:42:03 INFO - mozversion == 1.4 22:42:03 INFO - psutil == 3.1.1 22:42:03 INFO - requests == 1.2.3 22:42:03 INFO - wsgiref == 0.1.2 22:42:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:42: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 22:42: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 22:42:03 INFO - Using env: {'DISPLAY': ':0', 22:42:03 INFO - 'HOME': '/home/cltbld', 22:42:03 INFO - 'LANG': 'en_US.UTF-8', 22:42:03 INFO - 'LANGUAGE': 'en_US:en', 22:42:03 INFO - 'LOGNAME': 'cltbld', 22:42:03 INFO - 'MAIL': '/var/mail/cltbld', 22:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:03 INFO - 'MOZ_NO_REMOTE': '1', 22:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:03 INFO - 'NO_EM_RESTART': '1', 22:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:03 INFO - 'SHELL': '/bin/bash', 22:42:03 INFO - 'SHLVL': '1', 22:42:03 INFO - 'TERM': 'linux', 22:42:03 INFO - 'TMOUT': '86400', 22:42:03 INFO - 'USER': 'cltbld', 22:42:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:03 INFO - '_': '/tools/buildbot/bin/python'} 22:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 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)) 22:42:03 INFO - Cleaning up... 22:42:03 INFO - Return code: 0 22:42:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:42:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:42:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:42:03 INFO - Using env: {'DISPLAY': ':0', 22:42:03 INFO - 'HOME': '/home/cltbld', 22:42:03 INFO - 'LANG': 'en_US.UTF-8', 22:42:03 INFO - 'LANGUAGE': 'en_US:en', 22:42:03 INFO - 'LOGNAME': 'cltbld', 22:42:03 INFO - 'MAIL': '/var/mail/cltbld', 22:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:03 INFO - 'MOZ_NO_REMOTE': '1', 22:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:03 INFO - 'NO_EM_RESTART': '1', 22:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:03 INFO - 'SHELL': '/bin/bash', 22:42:03 INFO - 'SHLVL': '1', 22:42:03 INFO - 'TERM': 'linux', 22:42:03 INFO - 'TMOUT': '86400', 22:42:03 INFO - 'USER': 'cltbld', 22:42:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:03 INFO - '_': '/tools/buildbot/bin/python'} 22:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:03 INFO - Downloading/unpacking jsonschema 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:42:05 INFO - Downloading/unpacking functools32 (from jsonschema) 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:42:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:42:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:42:06 INFO - warning: no files found matching '*.txt' 22:42:06 INFO - no previously-included directories found matching 'build' 22:42:06 INFO - no previously-included directories found matching 'dist' 22:42:06 INFO - no previously-included directories found matching '.git*' 22:42:06 INFO - Installing collected packages: jsonschema, functools32 22:42:06 INFO - Running setup.py install for functools32 22:42:06 INFO - warning: no files found matching '*.txt' 22:42:06 INFO - no previously-included directories found matching 'build' 22:42:06 INFO - no previously-included directories found matching 'dist' 22:42:06 INFO - no previously-included directories found matching '.git*' 22:42:06 INFO - Successfully installed jsonschema functools32 22:42:06 INFO - Cleaning up... 22:42:06 INFO - Return code: 0 22:42:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:42: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')]} 22:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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')]} 22:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:42: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 0x7f68d652af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cef670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', '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 22:42: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 22:42: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 22:42:06 INFO - Using env: {'DISPLAY': ':0', 22:42:06 INFO - 'HOME': '/home/cltbld', 22:42:06 INFO - 'LANG': 'en_US.UTF-8', 22:42:06 INFO - 'LANGUAGE': 'en_US:en', 22:42:06 INFO - 'LOGNAME': 'cltbld', 22:42:06 INFO - 'MAIL': '/var/mail/cltbld', 22:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:06 INFO - 'MOZ_NO_REMOTE': '1', 22:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:06 INFO - 'NO_EM_RESTART': '1', 22:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:06 INFO - 'SHELL': '/bin/bash', 22:42:06 INFO - 'SHLVL': '1', 22:42:06 INFO - 'TERM': 'linux', 22:42:06 INFO - 'TMOUT': '86400', 22:42:06 INFO - 'USER': 'cltbld', 22:42:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:06 INFO - '_': '/tools/buildbot/bin/python'} 22:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:42:06 INFO - Downloading/unpacking flake8 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:42:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:42:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42: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 22:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:08 INFO - no previously-included directories found matching 'docs/_build' 22:42:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:42:09 INFO - Running setup.py install for pep8 22:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:42:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:42:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:42:09 INFO - no previously-included directories found matching 'docs/_build' 22:42:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:42:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:42:09 INFO - Cleaning up... 22:42:09 INFO - Return code: 0 22:42:09 INFO - Running post-action listener: _resource_record_post_action 22:42:09 INFO - Running post-action listener: _start_resource_monitoring 22:42:09 INFO - Starting resource monitoring. 22:42:09 INFO - ##### 22:42:09 INFO - ##### Running install step. 22:42:09 INFO - ##### 22:42:09 INFO - Running pre-action listener: _resource_record_pre_action 22:42:09 INFO - Running main action method: install 22:42:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:42:09 INFO - Reading from file tmpfile_stdout 22:42:09 INFO - Detecting whether we're running mozinstall >=1.0... 22:42:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:42:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:42:09 INFO - Reading from file tmpfile_stdout 22:42:09 INFO - Output received: 22:42:09 INFO - Usage: mozinstall [options] installer 22:42:09 INFO - Options: 22:42:09 INFO - -h, --help show this help message and exit 22:42:09 INFO - -d DEST, --destination=DEST 22:42:09 INFO - Directory to install application into. [default: 22:42:09 INFO - "/builds/slave/test-pgo"] 22:42:09 INFO - --app=APP Application being installed. [default: firefox] 22:42:09 INFO - mkdir: /builds/slave/test-pgo/build/application 22:42: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'] 22:42: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 22:42:28 INFO - Reading from file tmpfile_stdout 22:42:28 INFO - Output received: 22:42:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:42:28 INFO - Running post-action listener: _resource_record_post_action 22:42:28 INFO - ##### 22:42:28 INFO - ##### Running run-tests step. 22:42:28 INFO - ##### 22:42:28 INFO - Running pre-action listener: _resource_record_pre_action 22:42:28 INFO - Running main action method: run_tests 22:42:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:42:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:42:28 INFO - Python 2.7.3 22:42:28 INFO - Return code: 0 22:42:28 INFO - grabbing minidump binary from tooltool 22:42: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')]} 22:42:28 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 0x1d7e8c0>, '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 0x1d7f7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d7fc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:42:28 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 22:42:28 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 22:42:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:42:28 INFO - Return code: 0 22:42:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:42:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:42:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:42:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:42:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:42:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:42:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:42:29 INFO - Return code: 0 22:42:29 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:42:29 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:42:29 INFO - Using env: {'DISPLAY': ':0', 22:42:29 INFO - 'HOME': '/home/cltbld', 22:42:29 INFO - 'LANG': 'en_US.UTF-8', 22:42:29 INFO - 'LANGUAGE': 'en_US:en', 22:42:29 INFO - 'LOGNAME': 'cltbld', 22:42:29 INFO - 'MAIL': '/var/mail/cltbld', 22:42:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:42:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:42:29 INFO - 'MOZ_NO_REMOTE': '1', 22:42:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:42:29 INFO - 'NO_EM_RESTART': '1', 22:42:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:42:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:42:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:42:29 INFO - 'SHELL': '/bin/bash', 22:42:29 INFO - 'SHLVL': '1', 22:42:29 INFO - 'TERM': 'linux', 22:42:29 INFO - 'TMOUT': '86400', 22:42:29 INFO - 'USER': 'cltbld', 22:42:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1455332845.313142-613843721', 22:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:42:29 INFO - '_': '/tools/buildbot/bin/python'} 22:42:29 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:42:29 INFO - mozversion application_buildid: 20160212203128 22:42:29 INFO - mozversion application_changeset: 617e089684ae22f75215467ac13729d1ef3bf01e 22:42:29 INFO - mozversion application_display_name: Nightly 22:42:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:42:29 INFO - mozversion application_name: Firefox 22:42:29 INFO - mozversion application_remotingname: firefox 22:42:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:42:29 INFO - mozversion application_vendor: Mozilla 22:42:29 INFO - mozversion application_version: 47.0a1 22:42:29 INFO - mozversion platform_buildid: 20160212203128 22:42:29 INFO - mozversion platform_changeset: 617e089684ae22f75215467ac13729d1ef3bf01e 22:42:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:42:29 INFO - mozversion platform_version: 47.0a1 22:42:29 INFO - using testdate: 1455345749 22:42:29 INFO - actual date: 1455345749 22:42:29 INFO - starting webserver on 'localhost:57719' 22:42:29 INFO - SUITE-START | Running 2 tests 22:42:29 INFO - TEST-START | dromaeo_css 22:42:29 INFO - operating with platform_type : linux_ 22:42:29 INFO - Initialising browser for dromaeo_css test... 22:42:29 INFO - TEST-INFO | started process 3023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBJstAo/profile http://localhost:57719/getInfo.html) 22:42:34 INFO - PROCESS | 3023 | 22:42:34 INFO - PROCESS | 3023 | (process:3104): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:35 INFO - PROCESS | 3023 | __metrics Screen width/height:1600/1200 22:42:35 INFO - PROCESS | 3023 | colorDepth:24 22:42:35 INFO - PROCESS | 3023 | Browser inner width/height: 1024/697 22:42:35 INFO - PROCESS | 3023 | __metrics 22:42:36 INFO - TEST-INFO | 3023: exit 0 22:42:36 INFO - Browser initialized. 22:42:36 INFO - Running cycle 1/1 for dromaeo_css test... 22:42:36 INFO - TEST-INFO | started process 3155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBJstAo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:42:38 INFO - PROCESS | 3155 | 22:42:38 INFO - PROCESS | 3155 | (process:3210): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:42:48 INFO - PROCESS | 3155 | RSS: Main: 159162368 22:42:48 INFO - PROCESS | 3155 | 22:43:38 INFO - PROCESS | 3155 | 1455345818375 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] 22:45:46 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57719/tests/dromaeo/cssquery-ext.html) 22:45:47 INFO - PROCESS | 3155 | RSS: Main: 166785024 22:45:47 INFO - PROCESS | 3155 | 22:48:49 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-ext.html (next: http://localhost:57719/tests/dromaeo/cssquery-jquery.html) 22:48:49 INFO - PROCESS | 3155 | RSS: Main: 164286464 22:48:49 INFO - PROCESS | 3155 | 22:51:51 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57719/tests/dromaeo/cssquery-mootools.html) 22:51:52 INFO - PROCESS | 3155 | RSS: Main: 163520512 22:51:52 INFO - PROCESS | 3155 | 22:54:54 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57719/tests/dromaeo/cssquery-prototype.html) 22:54:54 INFO - PROCESS | 3155 | RSS: Main: 161505280 22:54:54 INFO - PROCESS | 3155 | 22:57:57 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57719/tests/dromaeo/cssquery-yui.html) 22:57:57 INFO - PROCESS | 3155 | RSS: Main: 161550336 22:57:57 INFO - PROCESS | 3155 | 23:00:59 INFO - PROCESS | 3155 | Cycle 1(1): loaded http://localhost:57719/tests/dromaeo/cssquery-yui.html (next: http://localhost:57719/tests/dromaeo/cssquery-dojo.html) 23:01:00 INFO - PROCESS | 3155 | RSS: Main: 164188160 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | __start_tp_report 23:01:00 INFO - PROCESS | 3155 | _x_x_mozilla_page_load 23:01:00 INFO - PROCESS | 3155 | _x_x_mozilla_page_load_details 23:01:00 INFO - PROCESS | 3155 | |i|pagename|runs| 23:01:00 INFO - PROCESS | 3155 | |0;dojo.html;3139.905802825916;3204.7916885402446;3208.598925134358;3248.0255923223026;3257.039173443834;5263.236830659562;5331.786728530859;5339.439358867321;5353.06321393756;5354.089804733195;5322.414534401222;5341.225522299274;5345.518903298703;5350.170723537858;5412.2152287918325;97.27847039242451;4897.951020489794;4948.628852836034;4962.975185124069;5023.2214006829;4847.975760121194;4872.196087645534;4904.264360345941;4931.408231012266;4968.751562421882;4857.198562237227;4871.025794841046;4882.780274887638;4887.315775791392;4896.902061958776;4840.854774356775;4894.216925291972;4908.410990681141;4917.188663870457;4928.1129396708575;4822.059698358821;4891.461939186686;4905.8773530661665;4912.975435122838;4940.530649588283;5202.97398513005;5235.869103272411;5241.475852414766;5244.108501554745;5261.657992230531;5719.628224165416;5784.421557844224;5830.591858569902;5832.912506312408;5838.182654428383;5863.648181109147;5878.2064421303;5879.441453061952;5884.264466941632;5901.881962360729;5472.069748142825;5498.395176530578;5503.11950087988;5510.99999999996;5514.5864060195245;5764.020116580192;5968;5979.222701048836;5993.370696076936;6071.544634152457;5710.685912274782;5736.13957906309;5737.569682273846;5741.282339707536;5752.741126649311;5698.287714035746;5769.307683078057;5807.157962095473;5811.27359080115;5834.474897259267;5679.176519404663;5718.056520674126;5734.254546908958;5742.684152371576;5769.480746732815;5742.59801813869;5745.9425405745405;5756.7121643917635;5761.5390768739235;5777.075667893117;4357.150355680612;4412.955870441255;4441.311596702516;4444.377787109807;4491.88770280739;3940.7438516496336;3948.545917219499;3960.544537378181;3967.2462232175794;3992.3412636915164;5339.839804805862;5351.170568561879;5351.357837059578;5373.274607927958;5383.946160538423;5740.311162660508;5773.1051686988585;5783.045797443375;5784.392638772868;5818.359980402152;5368.3826359968325;5371.516563509303;5397.865053373618;5399.433059528771;5410.48600382963;4793.592544633745;4870.780814863339;4898.706077635354;4899.510048995072;4951.752412379366;5917.792877249276;5920.763169473173;5939.316978547522;5939.732712027969;5956.612820166675;5661.631993920382;5727.684977326204;5736.770529178786;5740.1963725077685;5844.064949608212;5916.526677865846;5957.225560677084;6003.969980150071;6018.969905150446;6052.485538729257;5664.320281566238;5674.4892959633835;5691.117876729114;5706.201131841629;5715.742791574472;5555.50000499957;5641.830745077655;5658.688772117573;5808.593398462067;5816.272965879265;5599.412061733459;5617.213590097308;5621.494065534122;5675.31896172462;5679.659220446786;5653.208550802973;5668.461496157858;5678.77284908599;5692.117721753135;5698.686572238401;5620.325560932714;5634.830955071355;5638.295213098363;5644.181593668813;5648.71756412186;5577.414371490935;5685.0903855384595;5699.943000569941;5728.570357223141;5800.738966746591;5569.303837020372;5592.328920529562;5611.663300202001;5620.156976453564;5633.690147041952 23:01:00 INFO - PROCESS | 3155 | |1;ext.html;525.2069375243383;527.5357685236991;527.8627556835224;551.5918220516818;570.0366380816423;34411.139721506974;34675.306493870106;34885.651143488525;34931;35073.12317192071;35772;36296;36475.81762091193;36549;36714.08214794631;8530.786730331729;8722.869156962619;8738.825223495527;8741.650333986632;8743.213110820025;8473.49159050459;8478.321734261275;8559.315254779634;8592.226699597035;8624.439411438269;8576.271016963534;8583.227509524142;8650.956745216265;8670.046294907586;8703.95648021759;8579.785505362384;8586.656533738644;8636.697715579925;8642.351823613255;8683.175098365646;8445.957770211171;8515.48907065578;8528.403011789178;8571.485710857369;8616.569171541461;37312.25375492475;37946.241075178616;37955;37971;38038.619613803785;2638.2480992916926;2759.6274502942047;2903.3612605226817;3174.7777655563887;3200.135963289922;25703.357416064562;25993.870030649727;26356.8682156588;27204.863975679997;27703.861480692467;2991.1624745071413;3064.5862808520787;3078.39971205615;3103.301757104656;3221.838908054588;202010;204847;204911;204962;205626;51102.23346649803;54059.45940540623;54520.45479545233;54551.72724136354;58912.410875890695;54708.179377309374;55095.173572396445;55177.172342414895;55223;55328.72335638296;14415.279236038155;14487.710245795026;14523.564293071013;14545.20001399912;14553.27233638314;10707.411092389837;10708.78582428347;10734.141268698486;10753.623623173307;10760.56957721698;19153.360194995883;19426;19495.415137545897;19705.802941970396;20047.39857804268;7930.762077137695;8277.337812974947;8323.542205178774;8388.37087218461;8414.747557573282;838.3670328901641;858.4977787993969;924.3160061554402;1005.2510879394897;1069.7967386196597;26204.868975655;27378.726212737616;27936.58095128575;27961.720382795913;28208.85895570509;983.7983213441228;1039.2984735303792;1081.3890152064216;1120.6862078618;1192.6720151958107;12452.377381130907;13494.190348579117;13947.372368243454;13956.860431395557;13973.860261397256;400669;407162;408308;409534;409807;51543.7422812891;51892.48107518876;52393.2141017885;52462.47537524576;52475.47524524706;1374.71131062476;1378.7173629405947;1382.8548002459797;1387.1815628779068;1392.4151856220412;26099.217023489327;26398.340041499116;26521.33696657599;27005.189844304703;27157.72842271631;40368.798156009034;40624.1875162501;41384.37923431091;41449;41699.37450938178;278462;281556;282080;283301;284111;31612.841935790173;42394.65519463072;42584.78707606566;43238.78380608077;43717.344239835795;41373;42086.78956605197;42338.36492452677;43053;43075.13849723051;36194.63805361913;36690.44964325484;36731;38098.14263930161;39648.60351396449;35075.422220680055;35964.4605330915;36363.27273454463;36820;37061.629383706895;35572.644273556936;36144.457833132;36305.27389452249;36676.81661591675;36780.632193677724;31949.520757188195;33402.83298583492;34731.30537389289;36062.45906311355;36329.27341453209;24954.500909982064;25185.370365741004;25602.87198563995;25645;25673.871630642476 23:01:00 INFO - PROCESS | 3155 | |2;jquery.html;353.8973697627688;355.9021269150982;358.5912060251314;363.0397598352358;367.32962343722716;13963.720725585483;16738.665226695473;17102.65794684107;17445.389411370605;17797.55506112346;16179.433719819808;16270.43053493125;16369;16474.588135296624;16570.75143872843;5240.81657142001;5470.316210473691;5470.343558772933;5506.091494903336;5521.972390138064;5282.577393808505;5435.239066530669;5479.917801232965;5485.4788795064405;5533.059379905406;3971.26531591655;5455.863603409926;5456.781728730866;5742;5945.227120474354;5738.655680659173;5905.557083218776;5909.793157239519;5938.079597662348;5941.554383421239;5204.089284375257;5226.320578324831;5265.4997775211295;5282.3925248596515;5298.735063246861;20276.898615506827;20441.897790510953;20650.5869882603;20817.375478735663;20961.37115886526;1942.6794578894464;1984.8908310043087;2016.536196674773;2116.947076323089;2513.3088400689776;12579.811302830465;12682.429290681941;13003.869961300456;13076.08467407282;13253.13854599448;1645.761364602138;1645.8354164583566;1690.2309449200707;1758.5963095368513;1766.3376233912284;54203.728981355234;55426.44573554293;56403.43596564023;58516.41483585152;59556;9551.331406801597;9934.907160212371;10074.093331600192;10083.142932850644;10093.142082922886;13177.604671859859;13196.934015330055;13258.668533286746;13266.73466530664;13365.064445488722;6957.547759395623;6967.303269672992;7067.469939754539;7207.099112610924;7354.448416368794;6499.1876015498065;6549.6070235786;6550.312217217219;6559.639219842859;6595.274519802818;4289.656827453796;4337;4346.36977638247;4358.738475691405;4372.234858899744;1732.497575703032;1783.2064731194494;1803.089439832876;1806.8554515638718;1820.1536285627246;843.409613270713;861.2851333393269;873.0320692452817;919.8022425178485;940.6284517615503;16373.754393684105;16538.25577849;17343.2195551198;17353.4793956179;18109.36617218391;869.5652173913044;876.369014309696;916.5737931861717;925.121134921827;980.127686359141;9824.312298139062;9948.35335703177;10002.799944001079;10100.242481813893;10111.544980475895;367584;370753;522747;528825;532121;48456.75771621119;62651.37348626455;63031;64535.67732161403;77414;1136.5056200552622;1160.442987366069;1168.3048586091263;1172.6423440850622;1178.6581891251442;15079.849201508283;15300.617484562976;15591.688166236385;15868.365265389255;15891.364345426053;22573.43566410853;23363.883180583987;32659.34681306313;33872.49191262182;34684.65315346814;43307.56692433036;44366;46070;48036.519634803204;48053;7357.227491113356;7459.664315105942;7537.434692397982;7550.697972081275;7619.69521219145;10493.790124197321;11103.222774405715;11507.194496385173;11931.880681193077;12230.87769122333;3065.386922615441;5030.522100400456;5510.539706977574;9315.34792564514;9654.372465789702;10176.389416634729;10600.416977066336;10616.522256498321;10685.732856678645;10805.135589153006;9250.583723732583;9565.569549370155;9733.464659443798;9821.263405244777;10495.21285903545;7023.438124949889;7144.462816522823;7187.6765545551625;7270.163931147986;7305.963470182615;9595.328327017041;9807.313488055768;9858.654947076819;10020.148287395654;10321 23:01:00 INFO - PROCESS | 3155 | |3;mootools.html;1481.7036592681466;1500.069956626891;1681.6300413908937;1788.9194986225618;1814.8820326678765;7083.858322833553;7603.391728661708;7837.490563113393;7922.603869806509;8044;7898.921010789891;7904.525728456297;7998.240167184123;8002.639881205345;8033.47782394144;2319.6288593824993;2348.38941875112;2351.71779386473;2354.376090336062;2357.787799098081;2273.7044184256106;2301.42464383904;2306.4349234437586;2310.792028717415;2318.675385446039;1969.5666953270259;2232.4195709115584;2275.1354485295565;2325.825563082767;2340.3681006128336;2200.614892393825;2239.1715065425733;2258.9435264118447;2284.8971796269207;2291.450051987528;2235.944101397462;2253;2256.1201131558705;2256.8194544436406;2266.456050547873;7793.142754297023;7882.684692612289;7896.684132634688;7921.881171782428;7957.32362749167;4761.904761904742;4883.731394773286;4886.853394398174;4886.902261954741;4895.0454661341055;3096.28785379364;3125.562421261025;3185.171855317611;3232.6444091149956;3256.820874851906;1014.1886490807325;1014.9847752283722;1671.9916400418042;1718.6476772261656;1723.7069698151345;11171.497282622302;11231.606893758679;11231.943840280828;11263.366811812324;11275.379854108021;4247.851325203603;4287.228298906227;4318.52496225415;4345.630621397154;4354.368616550582;8829.823403531893;8853.778655533662;8887.511186884654;8892.59983300753;8903.465792052497;4825.227963525889;4845.103655823684;4872;4875.634327425457;4901.607871370282;4453.755043472575;4484;4517.774111294422;4532.1842068427995;4554.476235232991;3470.149813295708;3485.3029394121277;3515.156362472988;3524.7708898921487;3537.0449978506176;1050.1126548067025;1068.887766784492;1078.3907092492716;1078.8327809189589;1082.826747720361;908.8136931928939;960.4093482508207;1016.5527168046036;1026.3995562595817;1275.9234445933273;7251.637418129178;7300.306470885257;7308.196098429168;7342.375898048619;7377.188509263977;588.1530595941915;599.2090440618342;601.5788947736602;610.1823556434399;735.9108519391331;5559.166125081189;5649.4350564944;5652.406497317805;5654.547636189095;5746.971265143731;9398.765030874147;9593.808123837623;9621.230301575857;9628.277879159092;9663.226941844636;9761.414315141114;9989.300748947504;10016.39901605906;10021.09810117093;10040.297179197532;7482.214367491444;7606.239376062349;7743.5353878767455;7749.690012399441;7818.648160832776;7367.373773229121;7531.171571127062;7624.58064806441;7635.503692259986;7649.464537482323;8323.916760832315;8784.253338466302;8897.332700047393;8912.688055918012;8992.055834137322;8588.398812083095;8690.522021288889;8719.38964272495;8740.082291359317;9012.729618111467;7068.68190931399;7262.3826974707745;7267.709291628275;7281.526700764433;7297.598632075287;7571.242875712605;7771.689132434865;7776.455648104578;7847.176046515034;7884;6409.7436102555375;7251.311125443074;7403.444741644291;7513.8872916907385;7581.6209189541405;7081.681324340314;7150.570965742072;7169.892451613126;7212.927870721225;7255.020572222682;6990.440764738707;7163.785086447415;7169.4981351304905;7184.317489838457;7191.244919283609;6570.5729127606555;6612.966935165486;6620.470362371095;6625.50308726857;6639.900401493885;6341.460975817107;6410.647414392253;6460.870782584416;6507.186601674791;6510.121133647087 23:01:00 INFO - PROCESS | 3155 | |4;prototype.html;340.2141054164879;341.6719948849105;347.0594688394451;348.71231234231766;350.54429241985423;6132.877342453159;6255.624662520247;6264.248290205182;6334.714937827797;6414.743410263583;6290.49676025918;6293.496520278378;6297.307296197415;6319.462845658113;6334.809955701337;4854.732989685566;4863.465018847924;4867.1482490564185;4872.780724867372;4874.171390863544;4850.975745121269;4866.245731911542;4875.926861097087;4878.170710979124;4887.2913427552985;4734.857954261378;4842.055799119174;4845.570556685786;4861.05209484149;4861.732604706757;4824.252240902666;4833.444153922309;4835.830745923911;4841.564259216652;4841.588464980481;4199.328107502785;4213.241616509027;4214.157168566268;4217.072244106292;4222.493300803892;5873.559483038746;5966.433188847052;6029.547783916224;6032.215811944463;6032.638041717511;5642.097264437712;5661.8584535386535;5696.060150075233;5699.68651724155;5710.714464276811;6710;6713.798586042378;6747.156605424322;6756.358145976124;6757.966210168966;4688.437387513486;4703.270992996091;4703.835365762182;4704.059188162381;4709.552592503706;6844.726210951556;7010.719571217196;7051.612161331124;7056.823579410505;7063.505554611179;4779.115863565252;4787.952120478751;4798.73606951621;4803.687760295569;4823;4855.757212139379;4865.659403841768;4870;4870.805167793319;4893;5478.945210547923;5593.74828132735;5609.15862620602;5620.213170156181;5635.690037048002;6770.255271920085;6770.898436523456;6771.52599318043;6778.051072849805;6800.795976120724;1606.5421354914026;1646.0617448054734;1649.935791414531;1657.1382880902104;1683.856872165855;1138.1975707126455;1155.2952698853692;1156.6876943225282;1161.372858656333;1171.9238249513926;6171.074338849208;6247.531435142291;6270.655113968684;6278.937210627927;6286.151369565142;6831.419329357061;6838.14523184602;6872.725090996304;6877.6217308048535;6885.793426197222;6126.264848218242;6194.256689197326;6201.883660941074;6219.284782250009;6231.688415579293;3726.8136593170234;3738.6261373862394;3755;3755.511783468132;3762.3227818992846;7171.103612048494;7198;7201.13586369639;7202.747903823341;7211.747588834365;6982.511224214256;7010.334018268256;7014.088168538057;7025.156981162293;7033.226345102034;7319.560826350436;7349.63251837406;7383.9261607384315;7396.186419493852;7399.593022383713;6986.895196571953;7036.190838053484;7046.753363632249;7067.303847076767;7092.609906454988;6829.180498340231;6904.585724856524;6918.688659010256;6937.9653101736185;6942.548734332252;7351.154617218875;7363.77908662741;7387.1874093848555;7393.038904942323;7399.223081576357;4660.184467718203;4698.248280275139;4709.058188362273;4711.929321060118;4720;6821.761238356634;6835.863282734417;6911.205211400753;7018.263082376481;7024.1571011478945;6777.1189745332795;6782.457403407814;6785;6791.762288319885;6823.010663453871;6724.7646332378135;6734.191896972198;6738.797836064926;6740.988851672289;6758.7296508139125;6556.606603603799;6660.234073081658;6663.13379260693;6666.633335166418;6689.230738464944;6790.151231096113;6790.694418751267;6792.864142717019;6797.89803152963;6802.421794147355;6665.13353264092;6673.466122710269;6676.132102826601;6677.499187560855;6678.831204539283 23:01:00 INFO - PROCESS | 3155 | |5;yui.html;641.8812519683859;683.3951952522017;692.8164036530319;732.8570928668909;787.086979104239;13716.931415342922;13840.515581954634;13983.23092229927;14023.789643155334;14027.859721402783;13054.086213965027;13082.215067095982;13213.405396757145;13223.140495867761;13248.602541923758;801.2148094867034;817.0685418622775;817.3951276055706;817.6034623207739;838.0195171649185;820.110180454205;829.402829962426;830.5598033042497;832.342449464922;832.6710949175073;865.7489328094845;872.5244741615835;873.4584557574312;873.6112429968666;875.0724232313768;861.9051904290554;864.7362554420899;864.9135086491364;867.0159369116036;868.5006121480143;638.1321402892063;639.6418005916702;640.7789312687115;644.716324817079;644.9258335291455;14297.285135743172;14333.56999290023;14348.210848403334;14349.497767578188;14386.496472623512;11763.294202347886;12243.69390765238;12407.131500794949;12518.374081295899;12669.809952850623;9072.092790720875;9269.490178040205;9276.257899368034;9276.489793061379;9300;3423.2297733009873;3462.1690794209208;3463.740219483549;3471.7916924984584;3473.3053389321985;47371.289430658566;49236;49328.260076098886;50543.49456505424;50770.746146269405;8818.955905220433;8842.646294148291;8898.11018898118;8930.419522731001;10053.849192262122;17667.646647066987;17719.379821706178;17797.911010444866;17837.910810446123;17967.191476383596;7214.422846172293;7394.112706475257;7649.694012239448;7757.301842834172;8084.797880053045;4045.1707399982934;4106.630403263721;4183.769892655872;4192.769397683096;4336.544662810359;3287.342531493711;3326.467765157563;3329.9500507492407;3330.633630300665;3337.8664853405594;568.9943100569025;580.2253990922167;582.7872826418411;585.7510558012827;619.5136817598163;610.664134725899;625.6652690810395;630.2122347066168;642.9099926010363;672.8586996730742;7425.665845036986;7741.341985931146;7821.296083352526;7986.32116270112;8050.436469447082;506.69851438394096;544.6922488793819;605.7334772699998;634.1914059573987;672.6300534705892;3709.9814500927323;3773.867914622975;3876.8255428505786;3938.4683067786054;3945.2898478274187;56380;56480;56558.151627725616;56707.716461417425;57386.7130664344;43531.56468435275;44744.55255447404;44902.77548612236;44949.77525112354;45433;42815.57184428178;44358;44665;44717.32924006142;44991;7579.886301705368;8022.438429309892;8039.758807235792;8212.425130240827;8393.832123357377;33827;34158.487622685185;34352.82823585866;34395;34929.65070349366;38875.222495549366;42313.365299521145;43386.56613433825;43934.340984885894;45245.54754452413;9609.951950240204;9932.106110450095;9985.350952188084;10104.646337378157;10204.591816327264;10352.482375881025;10499.107575856138;10626.36241825493;10700.83948740754;10756;9778.217742580719;10013.299069065388;10266.845997310196;10418.843717344398;10559.313644613076;10159;10169.389836609827;10338.741531461774;10475.371477711362;10726.678199654023;8709.172628600272;10024.183976997712;10272.897271027194;10470.476476176313;10523.210759192938;7833.334166595903;7969.3226075784205;7992.280694737501;8094.838103237785;8291.419600627898;7873.960630197042;8586.441881277697;8755.474671519729;8796.384253102222;8946 23:01:00 INFO - PROCESS | 3155 | __end_tp_report 23:01:00 INFO - PROCESS | 3155 | __start_cc_report 23:01:00 INFO - PROCESS | 3155 | _x_x_mozilla_cycle_collect,320 23:01:00 INFO - PROCESS | 3155 | __end_cc_report 23:01:00 INFO - PROCESS | 3155 | __startTimestamp1455346860241__endTimestamp 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | ------- Summary: start ------- 23:01:00 INFO - PROCESS | 3155 | Number of tests: 6 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#0] dojo.html Cycles:165 Average:5331.87 Median:5620.33 stddev:728.44 (13.0%) stddev-sans-first:710.09 23:01:00 INFO - PROCESS | 3155 | Values: 3139.9 3204.8 3208.6 3248.0 3257.0 5263.2 5331.8 5339.4 5353.1 5354.1 5322.4 5341.2 5345.5 5350.2 5412.2 97.3 4898.0 4948.6 4963.0 5023.2 4848.0 4872.2 4904.3 4931.4 4968.8 4857.2 4871.0 4882.8 4887.3 4896.9 4840.9 4894.2 4908.4 4917.2 4928.1 4822.1 4891.5 4905.9 4913.0 4940.5 5203.0 5235.9 5241.5 5244.1 5261.7 5719.6 5784.4 5830.6 5832.9 5838.2 5863.6 5878.2 5879.4 5884.3 5901.9 5472.1 5498.4 5503.1 5511.0 5514.6 5764.0 5968.0 5979.2 5993.4 6071.5 5710.7 5736.1 5737.6 5741.3 5752.7 5698.3 5769.3 5807.2 5811.3 5834.5 5679.2 5718.1 5734.3 5742.7 5769.5 5742.6 5745.9 5756.7 5761.5 5777.1 4357.2 4413.0 4441.3 4444.4 4491.9 3940.7 3948.5 3960.5 3967.2 3992.3 5339.8 5351.2 5351.4 5373.3 5383.9 5740.3 5773.1 5783.0 5784.4 5818.4 5368.4 5371.5 5397.9 5399.4 5410.5 4793.6 4870.8 4898.7 4899.5 4951.8 5917.8 5920.8 5939.3 5939.7 5956.6 5661.6 5727.7 5736.8 5740.2 5844.1 5916.5 5957.2 6004.0 6019.0 6052.5 5664.3 5674.5 5691.1 5706.2 5715.7 5555.5 5641.8 5658.7 5808.6 5816.3 5599.4 5617.2 5621.5 5675.3 5679.7 5653.2 5668.5 5678.8 5692.1 5698.7 5620.3 5634.8 5638.3 5644.2 5648.7 5577.4 5685.1 5699.9 5728.6 5800.7 5569.3 5592.3 5611.7 5620.2 5633.7 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#1] ext.html Cycles:180 Average:46080.77 Median:36419.55 stddev:81511.96 (223.8%) stddev-sans-first:81668.86 23:01:00 INFO - PROCESS | 3155 | Values: 525.2 527.5 527.9 551.6 570.0 34411.1 34675.3 34885.7 34931.0 35073.1 35772.0 36296.0 36475.8 36549.0 36714.1 8530.8 8722.9 8738.8 8741.7 8743.2 8473.5 8478.3 8559.3 8592.2 8624.4 8576.3 8583.2 8651.0 8670.0 8704.0 8579.8 8586.7 8636.7 8642.4 8683.2 8446.0 8515.5 8528.4 8571.5 8616.6 37312.3 37946.2 37955.0 37971.0 38038.6 2638.2 2759.6 2903.4 3174.8 3200.1 25703.4 25993.9 26356.9 27204.9 27703.9 2991.2 3064.6 3078.4 3103.3 3221.8 202010.0 204847.0 204911.0 204962.0 205626.0 51102.2 54059.5 54520.5 54551.7 58912.4 54708.2 55095.2 55177.2 55223.0 55328.7 14415.3 14487.7 14523.6 14545.2 14553.3 10707.4 10708.8 10734.1 10753.6 10760.6 19153.4 19426.0 19495.4 19705.8 20047.4 7930.8 8277.3 8323.5 8388.4 8414.7 838.4 858.5 924.3 1005.3 1069.8 26204.9 27378.7 27936.6 27961.7 28208.9 983.8 1039.3 1081.4 1120.7 1192.7 12452.4 13494.2 13947.4 13956.9 13973.9 400669.0 407162.0 408308.0 409534.0 409807.0 51543.7 51892.5 52393.2 52462.5 52475.5 1374.7 1378.7 1382.9 1387.2 1392.4 26099.2 26398.3 26521.3 27005.2 27157.7 40368.8 40624.2 41384.4 41449.0 41699.4 278462.0 281556.0 282080.0 283301.0 284111.0 31612.8 42394.7 42584.8 43238.8 43717.3 41373.0 42086.8 42338.4 43053.0 43075.1 36194.6 36690.4 36731.0 38098.1 39648.6 35075.4 35964.5 36363.3 36820.0 37061.6 35572.6 36144.5 36305.3 36676.8 36780.6 31949.5 33402.8 34731.3 36062.5 36329.3 24954.5 25185.4 25602.9 25645.0 25673.9 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#2] jquery.html Cycles:180 Average:25262.92 Median:4341.68 stddev:76952.88 (1772.4%) stddev-sans-first:77146.02 23:01:00 INFO - PROCESS | 3155 | Values: 353.9 355.9 358.6 363.0 367.3 13963.7 16738.7 17102.7 17445.4 17797.6 16179.4 16270.4 16369.0 16474.6 16570.8 5240.8 5470.3 5470.3 5506.1 5522.0 5282.6 5435.2 5479.9 5485.5 5533.1 3971.3 5455.9 5456.8 5742.0 5945.2 5738.7 5905.6 5909.8 5938.1 5941.6 5204.1 5226.3 5265.5 5282.4 5298.7 20276.9 20441.9 20650.6 20817.4 20961.4 1942.7 1984.9 2016.5 2116.9 2513.3 12579.8 12682.4 13003.9 13076.1 13253.1 1645.8 1645.8 1690.2 1758.6 1766.3 54203.7 55426.4 56403.4 58516.4 59556.0 9551.3 9934.9 10074.1 10083.1 10093.1 13177.6 13196.9 13258.7 13266.7 13365.1 6957.5 6967.3 7067.5 7207.1 7354.4 6499.2 6549.6 6550.3 6559.6 6595.3 4289.7 4337.0 4346.4 4358.7 4372.2 1732.5 1783.2 1803.1 1806.9 1820.2 843.4 861.3 873.0 919.8 940.6 16373.8 16538.3 17343.2 17353.5 18109.4 869.6 876.4 916.6 925.1 980.1 9824.3 9948.4 10002.8 10100.2 10111.5 367584.0 370753.0 522747.0 528825.0 532121.0 48456.8 62651.4 63031.0 64535.7 77414.0 1136.5 1160.4 1168.3 1172.6 1178.7 15079.8 15300.6 15591.7 15868.4 15891.4 22573.4 23363.9 32659.3 33872.5 34684.7 43307.6 44366.0 46070.0 48036.5 48053.0 7357.2 7459.7 7537.4 7550.7 7619.7 10493.8 11103.2 11507.2 11931.9 12230.9 3065.4 5030.5 5510.5 9315.3 9654.4 10176.4 10600.4 10616.5 10685.7 10805.1 9250.6 9565.6 9733.5 9821.3 10495.2 7023.4 7144.5 7187.7 7270.2 7306.0 9595.3 9807.3 9858.7 10020.1 10321.0 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#3] mootools.html Cycles:180 Average:5583.37 Median:6375.60 stddev:2940.28 (46.1%) stddev-sans-first:2932.36 23:01:00 INFO - PROCESS | 3155 | Values: 1481.7 1500.1 1681.6 1788.9 1814.9 7083.9 7603.4 7837.5 7922.6 8044.0 7898.9 7904.5 7998.2 8002.6 8033.5 2319.6 2348.4 2351.7 2354.4 2357.8 2273.7 2301.4 2306.4 2310.8 2318.7 1969.6 2232.4 2275.1 2325.8 2340.4 2200.6 2239.2 2258.9 2284.9 2291.5 2235.9 2253.0 2256.1 2256.8 2266.5 7793.1 7882.7 7896.7 7921.9 7957.3 4761.9 4883.7 4886.9 4886.9 4895.0 3096.3 3125.6 3185.2 3232.6 3256.8 1014.2 1015.0 1672.0 1718.6 1723.7 11171.5 11231.6 11231.9 11263.4 11275.4 4247.9 4287.2 4318.5 4345.6 4354.4 8829.8 8853.8 8887.5 8892.6 8903.5 4825.2 4845.1 4872.0 4875.6 4901.6 4453.8 4484.0 4517.8 4532.2 4554.5 3470.1 3485.3 3515.2 3524.8 3537.0 1050.1 1068.9 1078.4 1078.8 1082.8 908.8 960.4 1016.6 1026.4 1275.9 7251.6 7300.3 7308.2 7342.4 7377.2 588.2 599.2 601.6 610.2 735.9 5559.2 5649.4 5652.4 5654.5 5747.0 9398.8 9593.8 9621.2 9628.3 9663.2 9761.4 9989.3 10016.4 10021.1 10040.3 7482.2 7606.2 7743.5 7749.7 7818.6 7367.4 7531.2 7624.6 7635.5 7649.5 8323.9 8784.3 8897.3 8912.7 8992.1 8588.4 8690.5 8719.4 8740.1 9012.7 7068.7 7262.4 7267.7 7281.5 7297.6 7571.2 7771.7 7776.5 7847.2 7884.0 6409.7 7251.3 7403.4 7513.9 7581.6 7081.7 7150.6 7169.9 7212.9 7255.0 6990.4 7163.8 7169.5 7184.3 7191.2 6570.6 6613.0 6620.5 6625.5 6639.9 6341.5 6410.6 6460.9 6507.2 6510.1 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#4] prototype.html Cycles:180 Average:5631.62 Median:6274.80 stddev:1706.85 (27.2%) stddev-sans-first:1664.80 23:01:00 INFO - PROCESS | 3155 | Values: 340.2 341.7 347.1 348.7 350.5 6132.9 6255.6 6264.2 6334.7 6414.7 6290.5 6293.5 6297.3 6319.5 6334.8 4854.7 4863.5 4867.1 4872.8 4874.2 4851.0 4866.2 4875.9 4878.2 4887.3 4734.9 4842.1 4845.6 4861.1 4861.7 4824.3 4833.4 4835.8 4841.6 4841.6 4199.3 4213.2 4214.2 4217.1 4222.5 5873.6 5966.4 6029.5 6032.2 6032.6 5642.1 5661.9 5696.1 5699.7 5710.7 6710.0 6713.8 6747.2 6756.4 6758.0 4688.4 4703.3 4703.8 4704.1 4709.6 6844.7 7010.7 7051.6 7056.8 7063.5 4779.1 4788.0 4798.7 4803.7 4823.0 4855.8 4865.7 4870.0 4870.8 4893.0 5478.9 5593.7 5609.2 5620.2 5635.7 6770.3 6770.9 6771.5 6778.1 6800.8 1606.5 1646.1 1649.9 1657.1 1683.9 1138.2 1155.3 1156.7 1161.4 1171.9 6171.1 6247.5 6270.7 6278.9 6286.2 6831.4 6838.1 6872.7 6877.6 6885.8 6126.3 6194.3 6201.9 6219.3 6231.7 3726.8 3738.6 3755.0 3755.5 3762.3 7171.1 7198.0 7201.1 7202.7 7211.7 6982.5 7010.3 7014.1 7025.2 7033.2 7319.6 7349.6 7383.9 7396.2 7399.6 6986.9 7036.2 7046.8 7067.3 7092.6 6829.2 6904.6 6918.7 6938.0 6942.5 7351.2 7363.8 7387.2 7393.0 7399.2 4660.2 4698.2 4709.1 4711.9 4720.0 6821.8 6835.9 6911.2 7018.3 7024.2 6777.1 6782.5 6785.0 6791.8 6823.0 6724.8 6734.2 6738.8 6741.0 6758.7 6556.6 6660.2 6663.1 6666.6 6689.2 6790.2 6790.7 6792.9 6797.9 6802.4 6665.1 6673.5 6676.1 6677.5 6678.8 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - PROCESS | 3155 | [#5] yui.html Cycles:180 Average:13187.27 Median:25638.72 stddev:15402.19 (60.1%) stddev-sans-first:15416.59 23:01:00 INFO - PROCESS | 3155 | Values: 641.9 683.4 692.8 732.9 787.1 13716.9 13840.5 13983.2 14023.8 14027.9 13054.1 13082.2 13213.4 13223.1 13248.6 801.2 817.1 817.4 817.6 838.0 820.1 829.4 830.6 832.3 832.7 865.7 872.5 873.5 873.6 875.1 861.9 864.7 864.9 867.0 868.5 638.1 639.6 640.8 644.7 644.9 14297.3 14333.6 14348.2 14349.5 14386.5 11763.3 12243.7 12407.1 12518.4 12669.8 9072.1 9269.5 9276.3 9276.5 9300.0 3423.2 3462.2 3463.7 3471.8 3473.3 47371.3 49236.0 49328.3 50543.5 50770.7 8819.0 8842.6 8898.1 8930.4 10053.8 17667.6 17719.4 17797.9 17837.9 17967.2 7214.4 7394.1 7649.7 7757.3 8084.8 4045.2 4106.6 4183.8 4192.8 4336.5 3287.3 3326.5 3330.0 3330.6 3337.9 569.0 580.2 582.8 585.8 619.5 610.7 625.7 630.2 642.9 672.9 7425.7 7741.3 7821.3 7986.3 8050.4 506.7 544.7 605.7 634.2 672.6 3710.0 3773.9 3876.8 3938.5 3945.3 56380.0 56480.0 56558.2 56707.7 57386.7 43531.6 44744.6 44902.8 44949.8 45433.0 42815.6 44358.0 44665.0 44717.3 44991.0 7579.9 8022.4 8039.8 8212.4 8393.8 33827.0 34158.5 34352.8 34395.0 34929.7 38875.2 42313.4 43386.6 43934.3 45245.5 9610.0 9932.1 9985.4 10104.6 10204.6 10352.5 10499.1 10626.4 10700.8 10756.0 9778.2 10013.3 10266.8 10418.8 10559.3 10159.0 10169.4 10338.7 10475.4 10726.7 8709.2 10024.2 10272.9 10470.5 10523.2 7833.3 7969.3 7992.3 8094.8 8291.4 7874.0 8586.4 8755.5 8796.4 8946.0 23:01:00 INFO - PROCESS | 3155 | -------- Summary: end -------- 23:01:00 INFO - PROCESS | 3155 | 23:01:00 INFO - TEST-INFO | 3155: exit 0 23:01:00 INFO - TEST-OK | dromaeo_css | took 1111319ms 23:01:00 INFO - TEST-START | kraken 23:01:00 INFO - operating with platform_type : linux_ 23:01:00 INFO - Initialising browser for kraken test... 23:01:00 INFO - TEST-INFO | started process 3388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVJdoH7/profile http://localhost:57719/getInfo.html) 23:01:05 INFO - PROCESS | 3388 | 23:01:05 INFO - PROCESS | 3388 | (process:3458): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:06 INFO - PROCESS | 3388 | __metrics Screen width/height:1600/1200 23:01:06 INFO - PROCESS | 3388 | colorDepth:24 23:01:06 INFO - PROCESS | 3388 | Browser inner width/height: 1024/697 23:01:06 INFO - PROCESS | 3388 | __metrics 23:01:07 INFO - TEST-INFO | 3388: exit 0 23:01:07 INFO - Browser initialized. 23:01:07 INFO - Running cycle 1/1 for kraken test... 23:01:07 INFO - TEST-INFO | started process 3509 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVJdoH7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:09 INFO - PROCESS | 3509 | 23:01:09 INFO - PROCESS | 3509 | (process:3568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:19 INFO - PROCESS | 3509 | RSS: Main: 158572544 23:01:19 INFO - PROCESS | 3509 | 23:01:22 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection) 23:01:22 INFO - PROCESS | 3509 | RSS: Main: 165126144 23:01:22 INFO - PROCESS | 3509 | 23:01:25 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-dft) 23:01:26 INFO - PROCESS | 3509 | RSS: Main: 168415232 23:01:26 INFO - PROCESS | 3509 | 23:01:29 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-fft) 23:01:29 INFO - PROCESS | 3509 | RSS: Main: 161701888 23:01:29 INFO - PROCESS | 3509 | 23:01:31 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator) 23:01:32 INFO - PROCESS | 3509 | RSS: Main: 159924224 23:01:32 INFO - PROCESS | 3509 | 23:01:34 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:01:35 INFO - PROCESS | 3509 | RSS: Main: 160194560 23:01:35 INFO - PROCESS | 3509 | 23:01:38 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom) 23:01:38 INFO - PROCESS | 3509 | RSS: Main: 159993856 23:01:38 INFO - PROCESS | 3509 | 23:01:42 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate) 23:01:42 INFO - PROCESS | 3509 | RSS: Main: 162189312 23:01:42 INFO - PROCESS | 3509 | 23:01:45 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial) 23:01:46 INFO - PROCESS | 3509 | RSS: Main: 161509376 23:01:46 INFO - PROCESS | 3509 | 23:01:47 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:01:48 INFO - PROCESS | 3509 | RSS: Main: 162697216 23:01:48 INFO - PROCESS | 3509 | 23:01:50 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:01:50 INFO - PROCESS | 3509 | RSS: Main: 160903168 23:01:50 INFO - PROCESS | 3509 | 23:01:52 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:01:53 INFO - PROCESS | 3509 | RSS: Main: 163508224 23:01:53 INFO - PROCESS | 3509 | 23:01:55 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:01:56 INFO - PROCESS | 3509 | RSS: Main: 160620544 23:01:56 INFO - PROCESS | 3509 | 23:01:59 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:01:59 INFO - PROCESS | 3509 | RSS: Main: 163106816 23:01:59 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | Cycle 1(1): loaded http://localhost:57719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57719/tests/kraken/driver.html?testName=ai-astar) 23:02:01 INFO - PROCESS | 3509 | RSS: Main: 163692544 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | __start_tp_report 23:02:01 INFO - PROCESS | 3509 | _x_x_mozilla_page_load 23:02:01 INFO - PROCESS | 3509 | _x_x_mozilla_page_load_details 23:02:01 INFO - PROCESS | 3509 | |i|pagename|runs| 23:02:01 INFO - PROCESS | 3509 | |0;ai-astar;112;108;114;112;114;125;112;111;114;115 23:02:01 INFO - PROCESS | 3509 | |1;audio-beat-detection;152;136;163;168;127;160;148;129;169;127 23:02:01 INFO - PROCESS | 3509 | |2;audio-dft;162;164;163;164;163;162;163;178;165;163 23:02:01 INFO - PROCESS | 3509 | |3;audio-fft;74;73;74;77;75;162;75;75;74;73 23:02:01 INFO - PROCESS | 3509 | |4;audio-oscillator;96;97;149;96;96;97;141;97;96;137 23:02:01 INFO - PROCESS | 3509 | |5;imaging-gaussian-blur;122;117;116;115;116;116;115;117;115;116 23:02:01 INFO - PROCESS | 3509 | |6;imaging-darkroom;146;147;147;149;148;146;148;146;147;148 23:02:01 INFO - PROCESS | 3509 | |7;imaging-desaturate;98;97;97;98;96;97;98;97;98;97 23:02:01 INFO - PROCESS | 3509 | |8;json-parse-financial;57;57;61;57;59;60;58;57;54;58 23:02:01 INFO - PROCESS | 3509 | |9;json-stringify-tinderbox;68;68;68;67;68;68;68;68;69;68 23:02:01 INFO - PROCESS | 3509 | |10;stanford-crypto-aes;90;84;88;92;84;85;85;83;85;84 23:02:01 INFO - PROCESS | 3509 | |11;stanford-crypto-ccm;115;130;122;132;123;117;123;125;121;127 23:02:01 INFO - PROCESS | 3509 | |12;stanford-crypto-pbkdf2;142;143;152;154;150;140;151;158;161;151 23:02:01 INFO - PROCESS | 3509 | |13;stanford-crypto-sha256-iterative;72;70;70;68;67;71;70;71;68;69 23:02:01 INFO - PROCESS | 3509 | __end_tp_report 23:02:01 INFO - PROCESS | 3509 | __start_cc_report 23:02:01 INFO - PROCESS | 3509 | _x_x_mozilla_cycle_collect,770 23:02:01 INFO - PROCESS | 3509 | __end_cc_report 23:02:01 INFO - PROCESS | 3509 | __startTimestamp1455346921704__endTimestamp 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | ------- Summary: start ------- 23:02:01 INFO - PROCESS | 3509 | Number of tests: 14 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:4.45 (3.9%) stddev-sans-first:4.68 23:02:01 INFO - PROCESS | 3509 | Values: 112.0 108.0 114.0 112.0 114.0 125.0 112.0 111.0 114.0 115.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.00 stddev:17.04 (10.9%) stddev-sans-first:18.01 23:02:01 INFO - PROCESS | 3509 | Values: 152.0 136.0 163.0 168.0 127.0 160.0 148.0 129.0 169.0 127.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:4.76 (2.9%) stddev-sans-first:4.95 23:02:01 INFO - PROCESS | 3509 | Values: 162.0 164.0 163.0 164.0 163.0 162.0 163.0 178.0 165.0 163.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#3] audio-fft Cycles:10 Average:83.20 Median:74.50 stddev:27.71 (37.2%) stddev-sans-first:29.19 23:02:01 INFO - PROCESS | 3509 | Values: 74.0 73.0 74.0 77.0 75.0 162.0 75.0 75.0 74.0 73.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:22.36 (23.3%) stddev-sans-first:23.12 23:02:01 INFO - PROCESS | 3509 | Values: 96.0 97.0 149.0 96.0 96.0 97.0 141.0 97.0 96.0 137.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 23:02:01 INFO - PROCESS | 3509 | Values: 122.0 117.0 116.0 115.0 116.0 116.0 115.0 117.0 115.0 116.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.03 (0.7%) stddev-sans-first:1.00 23:02:01 INFO - PROCESS | 3509 | Values: 146.0 147.0 147.0 149.0 148.0 146.0 148.0 146.0 147.0 148.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:02:01 INFO - PROCESS | 3509 | Values: 98.0 97.0 97.0 98.0 96.0 97.0 98.0 97.0 98.0 97.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.93 (3.3%) stddev-sans-first:2.03 23:02:01 INFO - PROCESS | 3509 | Values: 57.0 57.0 61.0 57.0 59.0 60.0 58.0 57.0 54.0 58.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 23:02:01 INFO - PROCESS | 3509 | Values: 68.0 68.0 68.0 67.0 68.0 68.0 68.0 68.0 69.0 68.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:2.98 (3.5%) stddev-sans-first:2.79 23:02:01 INFO - PROCESS | 3509 | Values: 90.0 84.0 88.0 92.0 84.0 85.0 85.0 83.0 85.0 84.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:124.00 stddev:5.30 (4.3%) stddev-sans-first:4.64 23:02:01 INFO - PROCESS | 3509 | Values: 115.0 130.0 122.0 132.0 123.0 117.0 123.0 125.0 121.0 127.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:151.50 stddev:6.83 (4.5%) stddev-sans-first:6.57 23:02:01 INFO - PROCESS | 3509 | Values: 142.0 143.0 152.0 154.0 150.0 140.0 151.0 158.0 161.0 151.0 23:02:01 INFO - PROCESS | 3509 | 23:02:01 INFO - PROCESS | 3509 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.41 23:02:01 INFO - PROCESS | 3509 | Values: 72.0 70.0 70.0 68.0 67.0 71.0 70.0 71.0 68.0 69.0 23:02:01 INFO - PROCESS | 3509 | -------- Summary: end -------- 23:02:01 INFO - PROCESS | 3509 | 23:02:02 INFO - TEST-INFO | 3509: exit 0 23:02:02 INFO - TEST-OK | kraken | took 61713ms 23:02:02 INFO - SUITE-END | took 1173s 23:02:02 INFO - Completed test suite (00:19:33) 23:02:02 INFO - Working with test: dromaeo_css 23:02:02 INFO - Generating results file: dromaeo_css 23:02:02 INFO - Working with test: kraken 23:02:02 INFO - Generating results file: kraken 23:02:02 INFO - javascript benchmark 23:02:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:02:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:02:03 INFO - process_Request line: dromaeo_css 6881.82 graph.html#tests=[[72,64,43]] 23:02:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:02:03 INFO - process_Request line: kraken 1535.80 graph.html#tests=[[232,64,43]] 23:02:03 INFO - RETURN: dromaeo_css: 6881.82 23:02:03 INFO - RETURN: kraken: 1535.80 23:02:03 INFO - javascript benchmark 23:02:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3139.905802825916, 3204.7916885402446, 3208.598925134358, 3248.0255923223026, 3257.039173443834, 5263.236830659562, 5331.786728530859, 5339.439358867321, 5353.06321393756, 5354.089804733195, 5322.414534401222, 5341.225522299274, 5345.518903298703, 5350.170723537858, 5412.2152287918325, 97.27847039242451, 4897.951020489794, 4948.628852836034, 4962.975185124069, 5023.2214006829, 4847.975760121194, 4872.196087645534, 4904.264360345941, 4931.408231012266, 4968.751562421882, 4857.198562237227, 4871.025794841046, 4882.780274887638, 4887.315775791392, 4896.902061958776, 4840.854774356775, 4894.216925291972, 4908.410990681141, 4917.188663870457, 4928.1129396708575, 4822.059698358821, 4891.461939186686, 4905.8773530661665, 4912.975435122838, 4940.530649588283, 5202.97398513005, 5235.869103272411, 5241.475852414766, 5244.108501554745, 5261.657992230531, 5719.628224165416, 5784.421557844224, 5830.591858569902, 5832.912506312408, 5838.182654428383, 5863.648181109147, 5878.2064421303, 5879.441453061952, 5884.264466941632, 5901.881962360729, 5472.069748142825, 5498.395176530578, 5503.11950087988, 5510.99999999996, 5514.5864060195245, 5764.020116580192, 5968.0, 5979.222701048836, 5993.370696076936, 6071.544634152457, 5710.685912274782, 5736.13957906309, 5737.569682273846, 5741.282339707536, 5752.741126649311, 5698.287714035746, 5769.307683078057, 5807.157962095473, 5811.27359080115, 5834.474897259267, 5679.176519404663, 5718.056520674126, 5734.254546908958, 5742.684152371576, 5769.480746732815, 5742.59801813869, 5745.9425405745405, 5756.7121643917635, 5761.5390768739235, 5777.075667893117, 4357.150355680612, 4412.955870441255, 4441.311596702516, 4444.377787109807, 4491.88770280739, 3940.7438516496336, 3948.545917219499, 3960.544537378181, 3967.2462232175794, 3992.3412636915164, 5339.839804805862, 5351.170568561879, 5351.357837059578, 5373.274607927958, 5383.946160538423, 5740.311162660508, 5773.1051686988585, 5783.045797443375, 5784.392638772868, 5818.359980402152, 5368.3826359968325, 5371.516563509303, 5397.865053373618, 5399.433059528771, 5410.48600382963, 4793.592544633745, 4870.780814863339, 4898.706077635354, 4899.510048995072, 4951.752412379366, 5917.792877249276, 5920.763169473173, 5939.316978547522, 5939.732712027969, 5956.612820166675, 5661.631993920382, 5727.684977326204, 5736.770529178786, 5740.1963725077685, 5844.064949608212, 5916.526677865846, 5957.225560677084, 6003.969980150071, 6018.969905150446, 6052.485538729257, 5664.320281566238, 5674.4892959633835, 5691.117876729114, 5706.201131841629, 5715.742791574472, 5555.50000499957, 5641.830745077655, 5658.688772117573, 5808.593398462067, 5816.272965879265, 5599.412061733459, 5617.213590097308, 5621.494065534122, 5675.31896172462, 5679.659220446786, 5653.208550802973, 5668.461496157858, 5678.77284908599, 5692.117721753135, 5698.686572238401, 5620.325560932714, 5634.830955071355, 5638.295213098363, 5644.181593668813, 5648.71756412186, 5577.414371490935, 5685.0903855384595, 5699.943000569941, 5728.570357223141, 5800.738966746591, 5569.303837020372, 5592.328920529562, 5611.663300202001, 5620.156976453564, 5633.690147041952], "unit": "score", "name": "dojo.html", "value": 5286.544062322385}, {"lowerIsBetter": false, "replicates": [525.2069375243383, 527.5357685236991, 527.8627556835224, 551.5918220516818, 570.0366380816423, 34411.139721506974, 34675.306493870106, 34885.651143488525, 34931.0, 35073.12317192071, 35772.0, 36296.0, 36475.81762091193, 36549.0, 36714.08214794631, 8530.786730331729, 8722.869156962619, 8738.825223495527, 8741.650333986632, 8743.213110820025, 8473.49159050459, 8478.321734261275, 8559.315254779634, 8592.226699597035, 8624.439411438269, 8576.271016963534, 8583.227509524142, 8650.956745216265, 8670.046294907586, 8703.95648021759, 8579.785505362384, 8586.656533738644, 8636.697715579925, 8642.351823613255, 8683.175098365646, 8445.957770211171, 8515.48907065578, 8528.403011789178, 8571.485710857369, 8616.569171541461, 37312.25375492475, 37946.241075178616, 37955.0, 37971.0, 38038.619613803785, 2638.2480992916926, 2759.6274502942047, 2903.3612605226817, 3174.7777655563887, 3200.135963289922, 25703.357416064562, 25993.870030649727, 26356.8682156588, 27204.863975679997, 27703.861480692467, 2991.1624745071413, 3064.5862808520787, 3078.39971205615, 3103.301757104656, 3221.838908054588, 202010.0, 204847.0, 204911.0, 204962.0, 205626.0, 51102.23346649803, 54059.45940540623, 54520.45479545233, 54551.72724136354, 58912.410875890695, 54708.179377309374, 55095.173572396445, 55177.172342414895, 55223.0, 55328.72335638296, 14415.279236038155, 14487.710245795026, 14523.564293071013, 14545.20001399912, 14553.27233638314, 10707.411092389837, 10708.78582428347, 10734.141268698486, 10753.623623173307, 10760.56957721698, 19153.360194995883, 19426.0, 19495.415137545897, 19705.802941970396, 20047.39857804268, 7930.762077137695, 8277.337812974947, 8323.542205178774, 8388.37087218461, 8414.747557573282, 838.3670328901641, 858.4977787993969, 924.3160061554402, 1005.2510879394897, 1069.7967386196597, 26204.868975655, 27378.726212737616, 27936.58095128575, 27961.720382795913, 28208.85895570509, 983.7983213441228, 1039.2984735303792, 1081.3890152064216, 1120.6862078618, 1192.6720151958107, 12452.377381130907, 13494.190348579117, 13947.372368243454, 13956.860431395557, 13973.860261397256, 400669.0, 407162.0, 408308.0, 409534.0, 409807.0, 51543.7422812891, 51892.48107518876, 52393.2141017885, 52462.47537524576, 52475.47524524706, 1374.71131062476, 1378.7173629405947, 1382.8548002459797, 1387.1815628779068, 1392.4151856220412, 26099.217023489327, 26398.340041499116, 26521.33696657599, 27005.189844304703, 27157.72842271631, 40368.798156009034, 40624.1875162501, 41384.37923431091, 41449.0, 41699.37450938178, 278462.0, 281556.0, 282080.0, 283301.0, 284111.0, 31612.841935790173, 42394.65519463072, 42584.78707606566, 43238.78380608077, 43717.344239835795, 41373.0, 42086.78956605197, 42338.36492452677, 43053.0, 43075.13849723051, 36194.63805361913, 36690.44964325484, 36731.0, 38098.14263930161, 39648.60351396449, 35075.422220680055, 35964.4605330915, 36363.27273454463, 36820.0, 37061.629383706895, 35572.644273556936, 36144.457833132, 36305.27389452249, 36676.81661591675, 36780.632193677724, 31949.520757188195, 33402.83298583492, 34731.30537389289, 36062.45906311355, 36329.27341453209, 24954.500909982064, 25185.370365741004, 25602.87198563995, 25645.0, 25673.871630642476], "unit": "score", "name": "ext.html", "value": 17865.23808501075}, {"lowerIsBetter": false, "replicates": [353.8973697627688, 355.9021269150982, 358.5912060251314, 363.0397598352358, 367.32962343722716, 13963.720725585483, 16738.665226695473, 17102.65794684107, 17445.389411370605, 17797.55506112346, 16179.433719819808, 16270.43053493125, 16369.0, 16474.588135296624, 16570.75143872843, 5240.81657142001, 5470.316210473691, 5470.343558772933, 5506.091494903336, 5521.972390138064, 5282.577393808505, 5435.239066530669, 5479.917801232965, 5485.4788795064405, 5533.059379905406, 3971.26531591655, 5455.863603409926, 5456.781728730866, 5742.0, 5945.227120474354, 5738.655680659173, 5905.557083218776, 5909.793157239519, 5938.079597662348, 5941.554383421239, 5204.089284375257, 5226.320578324831, 5265.4997775211295, 5282.3925248596515, 5298.735063246861, 20276.898615506827, 20441.897790510953, 20650.5869882603, 20817.375478735663, 20961.37115886526, 1942.6794578894464, 1984.8908310043087, 2016.536196674773, 2116.947076323089, 2513.3088400689776, 12579.811302830465, 12682.429290681941, 13003.869961300456, 13076.08467407282, 13253.13854599448, 1645.761364602138, 1645.8354164583566, 1690.2309449200707, 1758.5963095368513, 1766.3376233912284, 54203.728981355234, 55426.44573554293, 56403.43596564023, 58516.41483585152, 59556.0, 9551.331406801597, 9934.907160212371, 10074.093331600192, 10083.142932850644, 10093.142082922886, 13177.604671859859, 13196.934015330055, 13258.668533286746, 13266.73466530664, 13365.064445488722, 6957.547759395623, 6967.303269672992, 7067.469939754539, 7207.099112610924, 7354.448416368794, 6499.1876015498065, 6549.6070235786, 6550.312217217219, 6559.639219842859, 6595.274519802818, 4289.656827453796, 4337.0, 4346.36977638247, 4358.738475691405, 4372.234858899744, 1732.497575703032, 1783.2064731194494, 1803.089439832876, 1806.8554515638718, 1820.1536285627246, 843.409613270713, 861.2851333393269, 873.0320692452817, 919.8022425178485, 940.6284517615503, 16373.754393684105, 16538.25577849, 17343.2195551198, 17353.4793956179, 18109.36617218391, 869.5652173913044, 876.369014309696, 916.5737931861717, 925.121134921827, 980.127686359141, 9824.312298139062, 9948.35335703177, 10002.799944001079, 10100.242481813893, 10111.544980475895, 367584.0, 370753.0, 522747.0, 528825.0, 532121.0, 48456.75771621119, 62651.37348626455, 63031.0, 64535.67732161403, 77414.0, 1136.5056200552622, 1160.442987366069, 1168.3048586091263, 1172.6423440850622, 1178.6581891251442, 15079.849201508283, 15300.617484562976, 15591.688166236385, 15868.365265389255, 15891.364345426053, 22573.43566410853, 23363.883180583987, 32659.34681306313, 33872.49191262182, 34684.65315346814, 43307.56692433036, 44366.0, 46070.0, 48036.519634803204, 48053.0, 7357.227491113356, 7459.664315105942, 7537.434692397982, 7550.697972081275, 7619.69521219145, 10493.790124197321, 11103.222774405715, 11507.194496385173, 11931.880681193077, 12230.87769122333, 3065.386922615441, 5030.522100400456, 5510.539706977574, 9315.34792564514, 9654.372465789702, 10176.389416634729, 10600.416977066336, 10616.522256498321, 10685.732856678645, 10805.135589153006, 9250.583723732583, 9565.569549370155, 9733.464659443798, 9821.263405244777, 10495.21285903545, 7023.438124949889, 7144.462816522823, 7187.6765545551625, 7270.163931147986, 7305.963470182615, 9595.328327017041, 9807.313488055768, 9858.654947076819, 10020.148287395654, 10321.0], "unit": "score", "name": "jquery.html", "value": 8102.508771999937}, {"lowerIsBetter": false, "replicates": [1481.7036592681466, 1500.069956626891, 1681.6300413908937, 1788.9194986225618, 1814.8820326678765, 7083.858322833553, 7603.391728661708, 7837.490563113393, 7922.603869806509, 8044.0, 7898.921010789891, 7904.525728456297, 7998.240167184123, 8002.639881205345, 8033.47782394144, 2319.6288593824993, 2348.38941875112, 2351.71779386473, 2354.376090336062, 2357.787799098081, 2273.7044184256106, 2301.42464383904, 2306.4349234437586, 2310.792028717415, 2318.675385446039, 1969.5666953270259, 2232.4195709115584, 2275.1354485295565, 2325.825563082767, 2340.3681006128336, 2200.614892393825, 2239.1715065425733, 2258.9435264118447, 2284.8971796269207, 2291.450051987528, 2235.944101397462, 2253.0, 2256.1201131558705, 2256.8194544436406, 2266.456050547873, 7793.142754297023, 7882.684692612289, 7896.684132634688, 7921.881171782428, 7957.32362749167, 4761.904761904742, 4883.731394773286, 4886.853394398174, 4886.902261954741, 4895.0454661341055, 3096.28785379364, 3125.562421261025, 3185.171855317611, 3232.6444091149956, 3256.820874851906, 1014.1886490807325, 1014.9847752283722, 1671.9916400418042, 1718.6476772261656, 1723.7069698151345, 11171.497282622302, 11231.606893758679, 11231.943840280828, 11263.366811812324, 11275.379854108021, 4247.851325203603, 4287.228298906227, 4318.52496225415, 4345.630621397154, 4354.368616550582, 8829.823403531893, 8853.778655533662, 8887.511186884654, 8892.59983300753, 8903.465792052497, 4825.227963525889, 4845.103655823684, 4872.0, 4875.634327425457, 4901.607871370282, 4453.755043472575, 4484.0, 4517.774111294422, 4532.1842068427995, 4554.476235232991, 3470.149813295708, 3485.3029394121277, 3515.156362472988, 3524.7708898921487, 3537.0449978506176, 1050.1126548067025, 1068.887766784492, 1078.3907092492716, 1078.8327809189589, 1082.826747720361, 908.8136931928939, 960.4093482508207, 1016.5527168046036, 1026.3995562595817, 1275.9234445933273, 7251.637418129178, 7300.306470885257, 7308.196098429168, 7342.375898048619, 7377.188509263977, 588.1530595941915, 599.2090440618342, 601.5788947736602, 610.1823556434399, 735.9108519391331, 5559.166125081189, 5649.4350564944, 5652.406497317805, 5654.547636189095, 5746.971265143731, 9398.765030874147, 9593.808123837623, 9621.230301575857, 9628.277879159092, 9663.226941844636, 9761.414315141114, 9989.300748947504, 10016.39901605906, 10021.09810117093, 10040.297179197532, 7482.214367491444, 7606.239376062349, 7743.5353878767455, 7749.690012399441, 7818.648160832776, 7367.373773229121, 7531.171571127062, 7624.58064806441, 7635.503692259986, 7649.464537482323, 8323.916760832315, 8784.253338466302, 8897.332700047393, 8912.688055918012, 8992.055834137322, 8588.398812083095, 8690.522021288889, 8719.38964272495, 8740.082291359317, 9012.729618111467, 7068.68190931399, 7262.3826974707745, 7267.709291628275, 7281.526700764433, 7297.598632075287, 7571.242875712605, 7771.689132434865, 7776.455648104578, 7847.176046515034, 7884.0, 6409.7436102555375, 7251.311125443074, 7403.444741644291, 7513.8872916907385, 7581.6209189541405, 7081.681324340314, 7150.570965742072, 7169.892451613126, 7212.927870721225, 7255.020572222682, 6990.440764738707, 7163.785086447415, 7169.4981351304905, 7184.317489838457, 7191.244919283609, 6570.5729127606555, 6612.966935165486, 6620.470362371095, 6625.50308726857, 6639.900401493885, 6341.460975817107, 6410.647414392253, 6460.870782584416, 6507.186601674791, 6510.121133647087], "unit": "score", "name": "mootools.html", "value": 4522.098606545744}, {"lowerIsBetter": false, "replicates": [340.2141054164879, 341.6719948849105, 347.0594688394451, 348.71231234231766, 350.54429241985423, 6132.877342453159, 6255.624662520247, 6264.248290205182, 6334.714937827797, 6414.743410263583, 6290.49676025918, 6293.496520278378, 6297.307296197415, 6319.462845658113, 6334.809955701337, 4854.732989685566, 4863.465018847924, 4867.1482490564185, 4872.780724867372, 4874.171390863544, 4850.975745121269, 4866.245731911542, 4875.926861097087, 4878.170710979124, 4887.2913427552985, 4734.857954261378, 4842.055799119174, 4845.570556685786, 4861.05209484149, 4861.732604706757, 4824.252240902666, 4833.444153922309, 4835.830745923911, 4841.564259216652, 4841.588464980481, 4199.328107502785, 4213.241616509027, 4214.157168566268, 4217.072244106292, 4222.493300803892, 5873.559483038746, 5966.433188847052, 6029.547783916224, 6032.215811944463, 6032.638041717511, 5642.097264437712, 5661.8584535386535, 5696.060150075233, 5699.68651724155, 5710.714464276811, 6710.0, 6713.798586042378, 6747.156605424322, 6756.358145976124, 6757.966210168966, 4688.437387513486, 4703.270992996091, 4703.835365762182, 4704.059188162381, 4709.552592503706, 6844.726210951556, 7010.719571217196, 7051.612161331124, 7056.823579410505, 7063.505554611179, 4779.115863565252, 4787.952120478751, 4798.73606951621, 4803.687760295569, 4823.0, 4855.757212139379, 4865.659403841768, 4870.0, 4870.805167793319, 4893.0, 5478.945210547923, 5593.74828132735, 5609.15862620602, 5620.213170156181, 5635.690037048002, 6770.255271920085, 6770.898436523456, 6771.52599318043, 6778.051072849805, 6800.795976120724, 1606.5421354914026, 1646.0617448054734, 1649.935791414531, 1657.1382880902104, 1683.856872165855, 1138.1975707126455, 1155.2952698853692, 1156.6876943225282, 1161.372858656333, 1171.9238249513926, 6171.074338849208, 6247.531435142291, 6270.655113968684, 6278.937210627927, 6286.151369565142, 6831.419329357061, 6838.14523184602, 6872.725090996304, 6877.6217308048535, 6885.793426197222, 6126.264848218242, 6194.256689197326, 6201.883660941074, 6219.284782250009, 6231.688415579293, 3726.8136593170234, 3738.6261373862394, 3755.0, 3755.511783468132, 3762.3227818992846, 7171.103612048494, 7198.0, 7201.13586369639, 7202.747903823341, 7211.747588834365, 6982.511224214256, 7010.334018268256, 7014.088168538057, 7025.156981162293, 7033.226345102034, 7319.560826350436, 7349.63251837406, 7383.9261607384315, 7396.186419493852, 7399.593022383713, 6986.895196571953, 7036.190838053484, 7046.753363632249, 7067.303847076767, 7092.609906454988, 6829.180498340231, 6904.585724856524, 6918.688659010256, 6937.9653101736185, 6942.548734332252, 7351.154617218875, 7363.77908662741, 7387.1874093848555, 7393.038904942323, 7399.223081576357, 4660.184467718203, 4698.248280275139, 4709.058188362273, 4711.929321060118, 4720.0, 6821.761238356634, 6835.863282734417, 6911.205211400753, 7018.263082376481, 7024.1571011478945, 6777.1189745332795, 6782.457403407814, 6785.0, 6791.762288319885, 6823.010663453871, 6724.7646332378135, 6734.191896972198, 6738.797836064926, 6740.988851672289, 6758.7296508139125, 6556.606603603799, 6660.234073081658, 6663.13379260693, 6666.633335166418, 6689.230738464944, 6790.151231096113, 6790.694418751267, 6792.864142717019, 6797.89803152963, 6802.421794147355, 6665.13353264092, 6673.466122710269, 6676.132102826601, 6677.499187560855, 6678.831204539283], "unit": "score", "name": "prototype.html", "value": 5072.115287623428}, {"lowerIsBetter": false, "replicates": [641.8812519683859, 683.3951952522017, 692.8164036530319, 732.8570928668909, 787.086979104239, 13716.931415342922, 13840.515581954634, 13983.23092229927, 14023.789643155334, 14027.859721402783, 13054.086213965027, 13082.215067095982, 13213.405396757145, 13223.140495867761, 13248.602541923758, 801.2148094867034, 817.0685418622775, 817.3951276055706, 817.6034623207739, 838.0195171649185, 820.110180454205, 829.402829962426, 830.5598033042497, 832.342449464922, 832.6710949175073, 865.7489328094845, 872.5244741615835, 873.4584557574312, 873.6112429968666, 875.0724232313768, 861.9051904290554, 864.7362554420899, 864.9135086491364, 867.0159369116036, 868.5006121480143, 638.1321402892063, 639.6418005916702, 640.7789312687115, 644.716324817079, 644.9258335291455, 14297.285135743172, 14333.56999290023, 14348.210848403334, 14349.497767578188, 14386.496472623512, 11763.294202347886, 12243.69390765238, 12407.131500794949, 12518.374081295899, 12669.809952850623, 9072.092790720875, 9269.490178040205, 9276.257899368034, 9276.489793061379, 9300.0, 3423.2297733009873, 3462.1690794209208, 3463.740219483549, 3471.7916924984584, 3473.3053389321985, 47371.289430658566, 49236.0, 49328.260076098886, 50543.49456505424, 50770.746146269405, 8818.955905220433, 8842.646294148291, 8898.11018898118, 8930.419522731001, 10053.849192262122, 17667.646647066987, 17719.379821706178, 17797.911010444866, 17837.910810446123, 17967.191476383596, 7214.422846172293, 7394.112706475257, 7649.694012239448, 7757.301842834172, 8084.797880053045, 4045.1707399982934, 4106.630403263721, 4183.769892655872, 4192.769397683096, 4336.544662810359, 3287.342531493711, 3326.467765157563, 3329.9500507492407, 3330.633630300665, 3337.8664853405594, 568.9943100569025, 580.2253990922167, 582.7872826418411, 585.7510558012827, 619.5136817598163, 610.664134725899, 625.6652690810395, 630.2122347066168, 642.9099926010363, 672.8586996730742, 7425.665845036986, 7741.341985931146, 7821.296083352526, 7986.32116270112, 8050.436469447082, 506.69851438394096, 544.6922488793819, 605.7334772699998, 634.1914059573987, 672.6300534705892, 3709.9814500927323, 3773.867914622975, 3876.8255428505786, 3938.4683067786054, 3945.2898478274187, 56380.0, 56480.0, 56558.151627725616, 56707.716461417425, 57386.7130664344, 43531.56468435275, 44744.55255447404, 44902.77548612236, 44949.77525112354, 45433.0, 42815.57184428178, 44358.0, 44665.0, 44717.32924006142, 44991.0, 7579.886301705368, 8022.438429309892, 8039.758807235792, 8212.425130240827, 8393.832123357377, 33827.0, 34158.487622685185, 34352.82823585866, 34395.0, 34929.65070349366, 38875.222495549366, 42313.365299521145, 43386.56613433825, 43934.340984885894, 45245.54754452413, 9609.951950240204, 9932.106110450095, 9985.350952188084, 10104.646337378157, 10204.591816327264, 10352.482375881025, 10499.107575856138, 10626.36241825493, 10700.83948740754, 10756.0, 9778.217742580719, 10013.299069065388, 10266.845997310196, 10418.843717344398, 10559.313644613076, 10159.0, 10169.389836609827, 10338.741531461774, 10475.371477711362, 10726.678199654023, 8709.172628600272, 10024.183976997712, 10272.897271027194, 10470.476476176313, 10523.210759192938, 7833.334166595903, 7969.3226075784205, 7992.280694737501, 8094.838103237785, 8291.419600627898, 7873.960630197042, 8586.441881277697, 8755.474671519729, 8796.384253102222, 8946.0], "unit": "score", "name": "yui.html", "value": 6051.397916035208}], "name": "dromaeo_css", "value": 6881.820031196285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 114.0, 112.0, 114.0, 125.0, 112.0, 111.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 163.0, 168.0, 127.0, 160.0, 148.0, 129.0, 169.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 164.0, 163.0, 162.0, 163.0, 178.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 77.0, 75.0, 162.0, 75.0, 75.0, 74.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 149.0, 96.0, 96.0, 97.0, 141.0, 97.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 116.0, 115.0, 116.0, 116.0, 115.0, 117.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 149.0, 148.0, 146.0, 148.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 97.0, 98.0, 96.0, 97.0, 98.0, 97.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 61.0, 57.0, 59.0, 60.0, 58.0, 57.0, 54.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 88.0, 92.0, 84.0, 85.0, 85.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [115.0, 130.0, 122.0, 132.0, 123.0, 117.0, 123.0, 125.0, 121.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 152.0, 154.0, 150.0, 140.0, 151.0, 158.0, 161.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 70.0, 68.0, 67.0, 71.0, 70.0, 71.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1535.8}]} 23:02:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1535.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6881.82"}}} 23:02:03 INFO - Return code: 0 23:02:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:02:03 INFO - # TBPL SUCCESS # 23:02:03 INFO - Running post-action listener: _resource_record_post_action 23:02:03 INFO - Running post-run listener: _resource_record_post_run 23:02:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550240256; Read time: 20; Write time: 1785348 23:02:04 INFO - install - Wall time: 19s; CPU: 18.0%; Read bytes: 0; Write bytes: 255868928; Read time: 0; Write time: 1069364 23:02:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294371328; Read time: 20; Write time: 715984 23:02:04 INFO - Running post-run listener: _upload_blobber_files 23:02:04 INFO - Blob upload gear active. 23:02:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:02:04 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:02:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:02:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:02:04 INFO - Traceback (most recent call last): 23:02:04 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 253, in 23:02:04 INFO - main() 23:02:04 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 235, in main 23:02:04 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 23:02:04 INFO - File "/builds/slave/test-pgo/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 23:02:04 INFO - return set(response.json().get('whitelist', [])) 23:02:04 INFO - File "/builds/slave/test-pgo/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 23:02:04 INFO - return json.loads(self.text or self.content, **kwargs) 23:02:04 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 23:02:04 INFO - return _default_decoder.decode(s) 23:02:04 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 23:02:04 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 23:02:04 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 23:02:04 INFO - raise ValueError("No JSON object could be decoded") 23:02:04 INFO - ValueError: No JSON object could be decoded 23:02:04 ERROR - Return code: 1 23:02:04 INFO - Setting buildbot property blobber_files to {} 23:02:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:02:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:02:04 INFO - Contents: 23:02:04 INFO - blobber_files:{} 23:02:04 INFO - Running post-run listener: copy_logs_to_upload_dir 23:02:04 INFO - Copying logs to upload dir... 23:02:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:02:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.360089 ========= master_lag: 18.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-02-12 23:02:22.822076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:22.825772) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/IaQqh15MRt6u7e-nVXkfiA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:22.850260) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:22.850581) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1455332845.313142-613843721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 23:02:22.900434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 23:02:22.900753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 23:02:22.901079) ========= ========= Total master_lag: 18.74 =========