builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1458645338.81 results: success (0) buildid: 20160321203031 builduid: cbae76ee2a374f979803e7a05f49f509 revision: 3587b25bae302c1eed72968dbd7cef883e715948 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.808947) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.809321) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.809597) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006340 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.843476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.843749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.860901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.861210) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.913303) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.913576) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.913902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:38.914186) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-22 04:15:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-22 04:15:39 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.018372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.018674) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.070515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.070814) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3587b25bae302c1eed72968dbd7cef883e715948 --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 3587b25bae302c1eed72968dbd7cef883e715948 --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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-22 04:15:39,223 truncating revision to first 12 chars 2016-03-22 04:15:39,223 Setting DEBUG logging. 2016-03-22 04:15:39,223 attempt 1/10 2016-03-22 04:15:39,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3587b25bae30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-22 04:15:39,523 unpacking tar archive at: fx-team-3587b25bae30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.674042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.674348) ========= echo 3587b25bae302c1eed72968dbd7cef883e715948 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3587b25bae302c1eed72968dbd7cef883e715948'] 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3587b25bae302c1eed72968dbd7cef883e715948 program finished with exit code 0 elapsedTime=0.004713 script_repo_revision: '3587b25bae302c1eed72968dbd7cef883e715948' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.728743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.729058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-22 04:15:39.740710) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-22 04:15:39.740991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:39 INFO - MultiFileLogger online at 20160322 04:15:39 in /builds/slave/test-pgo 04:15:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:15:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:15:39 INFO - {'append_to_log': False, 04:15:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:15:39 INFO - 'blob_upload_branch': 'Fx-Team', 04:15:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:15:39 INFO - 'branch': 'Fx-Team', 04:15:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:39 INFO - 'config_files': ('talos/linux_config.py',), 04:15:39 INFO - 'default_actions': ('clobber', 04:15:39 INFO - 'read-buildbot-config', 04:15:39 INFO - 'download-and-extract', 04:15:39 INFO - 'populate-webroot', 04:15:39 INFO - 'create-virtualenv', 04:15:39 INFO - 'install', 04:15:39 INFO - 'run-tests'), 04:15:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:39 INFO - 'download_minidump_stackwalk': True, 04:15:39 INFO - 'download_symbols': 'ondemand', 04:15:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:39 INFO - 'installer_path': 'installer.exe', 04:15:39 INFO - 'log_level': 'info', 04:15:39 INFO - 'log_name': 'talos', 04:15:39 INFO - 'log_to_console': True, 04:15:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:39 INFO - 'opt_config_files': (), 04:15:39 INFO - 'pip_index': False, 04:15:39 INFO - 'sps_profile': False, 04:15:39 INFO - 'sps_profile_interval': 0, 04:15:39 INFO - 'suite': 'dromaeojs', 04:15:39 INFO - 'system_bits': '32', 04:15:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:39 INFO - 'title': 'talos-linux64-ix-027', 04:15:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:39 INFO - 'use_talos_json': True, 04:15:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:15:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:39 INFO - 'work_dir': 'build'} 04:15:39 INFO - ##### 04:15:39 INFO - ##### Running clobber step. 04:15:39 INFO - ##### 04:15:39 INFO - Running pre-action listener: _resource_record_pre_action 04:15:39 INFO - Running main action method: clobber 04:15:39 INFO - rmtree: /builds/slave/test-pgo/build 04:15:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:15:40 INFO - Running post-action listener: _resource_record_post_action 04:15:40 INFO - ##### 04:15:40 INFO - ##### Running read-buildbot-config step. 04:15:40 INFO - ##### 04:15:40 INFO - Running pre-action listener: _resource_record_pre_action 04:15:40 INFO - Running main action method: read_buildbot_config 04:15:40 INFO - Using buildbot properties: 04:15:40 INFO - { 04:15:40 INFO - "project": "", 04:15:40 INFO - "product": "firefox", 04:15:40 INFO - "script_repo_revision": "production", 04:15:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:15:40 INFO - "repository": "", 04:15:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:15:40 INFO - "buildid": "20160321203031", 04:15:40 INFO - "pgo_build": "True", 04:15:40 INFO - "basedir": "/builds/slave/test-pgo", 04:15:40 INFO - "buildnumber": 553, 04:15:40 INFO - "slavename": "talos-linux64-ix-027", 04:15:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:15:40 INFO - "platform": "ubuntu64_hw", 04:15:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:15:40 INFO - "branch": "fx-team", 04:15:40 INFO - "repo_path": "integration/fx-team", 04:15:40 INFO - "revision": "3587b25bae302c1eed72968dbd7cef883e715948", 04:15:40 INFO - "stage_platform": "linux64-pgo", 04:15:40 INFO - "builduid": "cbae76ee2a374f979803e7a05f49f509", 04:15:40 INFO - "slavebuilddir": "test" 04:15:40 INFO - } 04:15:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:15:40 INFO - Running post-action listener: _resource_record_post_action 04:15:40 INFO - ##### 04:15:40 INFO - ##### Running download-and-extract step. 04:15:40 INFO - ##### 04:15:40 INFO - Running pre-action listener: _resource_record_pre_action 04:15:40 INFO - Running main action method: download_and_extract 04:15:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:40 INFO - https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:15:41 INFO - Downloaded 1361 bytes. 04:15:41 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:15:41 INFO - Using the following test package requirements: 04:15:41 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:15:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'jsshell-linux-x86_64.zip'], 04:15:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:41 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:41 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15:41 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')]} 04:15:41 INFO - https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:15:44 INFO - Downloaded 23570463 bytes. 04:15:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:15:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:15:45 INFO - Return code: 0 04:15:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:45 INFO - https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:15:54 INFO - Downloaded 23570463 bytes. 04:15:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:15:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 04:15:55 INFO - Return code: 0 04:15:55 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')]} 04:15:55 INFO - https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:15:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:15:59 INFO - Downloaded 10847637 bytes. 04:15:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 04:15:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 04:15:59 INFO - Return code: 0 04:15: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')]} 04:15:59 INFO - https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:16:09 INFO - Downloaded 57735259 bytes. 04:16:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:09 INFO - mkdir: /builds/slave/test-pgo/properties 04:16:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:16:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:16:09 INFO - Contents: 04:16:09 INFO - build_url:https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:16:10 INFO - Running post-action listener: _resource_record_post_action 04:16:10 INFO - Running post-action listener: set_extra_try_arguments 04:16:10 INFO - ##### 04:16:10 INFO - ##### Running populate-webroot step. 04:16:10 INFO - ##### 04:16:10 INFO - Running pre-action listener: _resource_record_pre_action 04:16:10 INFO - Running main action method: populate_webroot 04:16:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:10 INFO - '--tppagecycles', 04:16:10 INFO - '7'], 04:16:10 INFO - 'tests': ['tsvgm']}}, 04:16:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:16:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:16:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'tests': ['damp', 'tps']}, 04:16:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['damp', 'tps']}, 04:16:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:10 INFO - 'other': {'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'other_l64': {'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:10 INFO - 'ts_paint', 04:16:10 INFO - 'tpaint', 04:16:10 INFO - 'sessionrestore', 04:16:10 INFO - 'sessionrestore_no_auto_restore', 04:16:10 INFO - 'tabpaint']}, 04:16:10 INFO - 'svgr': {'tests': ['tsvgx', 04:16:10 INFO - 'tsvgr_opacity', 04:16:10 INFO - 'tart', 04:16:10 INFO - 'tscrollx', 04:16:10 INFO - 'cart']}, 04:16:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['tsvgx', 04:16:10 INFO - 'tsvgr_opacity', 04:16:10 INFO - 'tart', 04:16:10 INFO - 'tscrollx', 04:16:10 INFO - 'cart']}, 04:16:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'tests': ['tp5o']}, 04:16:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'talos_options': ['--e10s'], 04:16:10 INFO - 'tests': ['tp5o']}, 04:16:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'talos_options': ['--xperf_path', 04:16:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:10 INFO - 'tests': ['tp5n']}, 04:16:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:10 INFO - 'talos_options': ['--e10s', 04:16:10 INFO - '--xperf_path', 04:16:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:10 INFO - 'tests': ['tp5n']}}, 04:16:10 INFO - 'talos.zip': {'path': '', 04:16:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:10 INFO - Running post-action listener: _resource_record_post_action 04:16:10 INFO - ##### 04:16:10 INFO - ##### Running create-virtualenv step. 04:16:10 INFO - ##### 04:16:10 INFO - Running pre-action listener: _resource_record_pre_action 04:16:10 INFO - Running main action method: create_virtualenv 04:16:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:16:10 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 04:16:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:16:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:10 INFO - Using real prefix '/usr' 04:16:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:16:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:13 INFO - Installing pip.................done. 04:16:13 INFO - Return code: 0 04:16:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:16:13 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')]} 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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')]} 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:13 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 04:16:13 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 04:16:13 INFO - Using env: {'DISPLAY': ':0', 04:16:13 INFO - 'HOME': '/home/cltbld', 04:16:13 INFO - 'LANG': 'en_US.UTF-8', 04:16:13 INFO - 'LANGUAGE': 'en_US:en', 04:16:13 INFO - 'LOGNAME': 'cltbld', 04:16:13 INFO - 'MAIL': '/var/mail/cltbld', 04:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:13 INFO - 'MOZ_NO_REMOTE': '1', 04:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:13 INFO - 'NO_EM_RESTART': '1', 04:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:13 INFO - 'SHELL': '/bin/bash', 04:16:13 INFO - 'SHLVL': '1', 04:16:13 INFO - 'TERM': 'linux', 04:16:13 INFO - 'TMOUT': '86400', 04:16:13 INFO - 'USER': 'cltbld', 04:16:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:13 INFO - '_': '/tools/buildbot/bin/python'} 04:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:13 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 04:16:13 INFO - Cleaning up... 04:16:13 INFO - Return code: 0 04:16:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:16:13 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')]} 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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')]} 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:13 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 04:16:13 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 04:16:13 INFO - Using env: {'DISPLAY': ':0', 04:16:13 INFO - 'HOME': '/home/cltbld', 04:16:13 INFO - 'LANG': 'en_US.UTF-8', 04:16:13 INFO - 'LANGUAGE': 'en_US:en', 04:16:13 INFO - 'LOGNAME': 'cltbld', 04:16:13 INFO - 'MAIL': '/var/mail/cltbld', 04:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:13 INFO - 'MOZ_NO_REMOTE': '1', 04:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:13 INFO - 'NO_EM_RESTART': '1', 04:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:13 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:13 INFO - 'SHELL': '/bin/bash', 04:16:13 INFO - 'SHLVL': '1', 04:16:13 INFO - 'TERM': 'linux', 04:16:13 INFO - 'TMOUT': '86400', 04:16:13 INFO - 'USER': 'cltbld', 04:16:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:13 INFO - '_': '/tools/buildbot/bin/python'} 04:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:13 INFO - Downloading/unpacking psutil>=0.7.1 04:16:13 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 04:16:13 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 04:16:13 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 04:16:13 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 04:16:13 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 04:16:13 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 04:16:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:17 INFO - Installing collected packages: psutil 04:16:17 INFO - Running setup.py install for psutil 04:16:17 INFO - building 'psutil._psutil_linux' extension 04:16:17 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 04:16:18 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 04:16:18 INFO - building 'psutil._psutil_posix' extension 04:16:18 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 04:16:18 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 04:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:18 INFO - Successfully installed psutil 04:16:18 INFO - Cleaning up... 04:16:18 INFO - Return code: 0 04:16:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:18 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 04:16:18 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 04:16:18 INFO - Using env: {'DISPLAY': ':0', 04:16:18 INFO - 'HOME': '/home/cltbld', 04:16:18 INFO - 'LANG': 'en_US.UTF-8', 04:16:18 INFO - 'LANGUAGE': 'en_US:en', 04:16:18 INFO - 'LOGNAME': 'cltbld', 04:16:18 INFO - 'MAIL': '/var/mail/cltbld', 04:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:18 INFO - 'MOZ_NO_REMOTE': '1', 04:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:18 INFO - 'NO_EM_RESTART': '1', 04:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:18 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:18 INFO - 'SHELL': '/bin/bash', 04:16:18 INFO - 'SHLVL': '1', 04:16:18 INFO - 'TERM': 'linux', 04:16:18 INFO - 'TMOUT': '86400', 04:16:18 INFO - 'USER': 'cltbld', 04:16:18 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:18 INFO - '_': '/tools/buildbot/bin/python'} 04:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:18 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 04:16:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:22 INFO - Installing collected packages: mozsystemmonitor 04:16:22 INFO - Running setup.py install for mozsystemmonitor 04:16:22 INFO - Successfully installed mozsystemmonitor 04:16:22 INFO - Cleaning up... 04:16:22 INFO - Return code: 0 04:16:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:22 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 04:16:22 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 04:16:22 INFO - Using env: {'DISPLAY': ':0', 04:16:22 INFO - 'HOME': '/home/cltbld', 04:16:22 INFO - 'LANG': 'en_US.UTF-8', 04:16:22 INFO - 'LANGUAGE': 'en_US:en', 04:16:22 INFO - 'LOGNAME': 'cltbld', 04:16:22 INFO - 'MAIL': '/var/mail/cltbld', 04:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:22 INFO - 'MOZ_NO_REMOTE': '1', 04:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:22 INFO - 'NO_EM_RESTART': '1', 04:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:22 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:22 INFO - 'SHELL': '/bin/bash', 04:16:22 INFO - 'SHLVL': '1', 04:16:22 INFO - 'TERM': 'linux', 04:16:22 INFO - 'TMOUT': '86400', 04:16:22 INFO - 'USER': 'cltbld', 04:16:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:22 INFO - '_': '/tools/buildbot/bin/python'} 04:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:22 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 04:16:22 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 04:16:22 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 04:16:22 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 04:16:22 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 04:16:22 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 04:16:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:16:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:26 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 04:16:26 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 04:16:26 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 04:16:26 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 04:16:26 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 04:16:26 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 04:16:26 INFO - Downloading docopt-0.6.1.tar.gz 04:16:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:26 INFO - Running setup.py install for blobuploader 04:16:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:16:27 INFO - Running setup.py install for requests 04:16:27 INFO - Running setup.py install for docopt 04:16:27 INFO - Successfully installed blobuploader requests docopt 04:16:27 INFO - Cleaning up... 04:16:27 INFO - Return code: 0 04:16:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:27 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:27 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 04:16:27 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 04:16:27 INFO - Using env: {'DISPLAY': ':0', 04:16:27 INFO - 'HOME': '/home/cltbld', 04:16:27 INFO - 'LANG': 'en_US.UTF-8', 04:16:27 INFO - 'LANGUAGE': 'en_US:en', 04:16:27 INFO - 'LOGNAME': 'cltbld', 04:16:27 INFO - 'MAIL': '/var/mail/cltbld', 04:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:27 INFO - 'MOZ_NO_REMOTE': '1', 04:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:27 INFO - 'NO_EM_RESTART': '1', 04:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:27 INFO - 'SHELL': '/bin/bash', 04:16:27 INFO - 'SHLVL': '1', 04:16:27 INFO - 'TERM': 'linux', 04:16:27 INFO - 'TMOUT': '86400', 04:16:27 INFO - 'USER': 'cltbld', 04:16:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:27 INFO - '_': '/tools/buildbot/bin/python'} 04:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:16:27 INFO - Running setup.py (path:/tmp/pip-i9qfdb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:16:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:16:27 INFO - Running setup.py (path:/tmp/pip-qEXNae-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:16:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:16:27 INFO - Running setup.py (path:/tmp/pip-G8__aa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:16:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:16:27 INFO - Running setup.py (path:/tmp/pip-Rs607A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:16:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:16:27 INFO - Running setup.py (path:/tmp/pip-viIlZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:16:28 INFO - Running setup.py (path:/tmp/pip-RNKFqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:16:28 INFO - Running setup.py (path:/tmp/pip-RoOAkA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:16:28 INFO - Running setup.py (path:/tmp/pip-tGKmYc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:16:28 INFO - Running setup.py (path:/tmp/pip-nhb5Fg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:16:28 INFO - Running setup.py (path:/tmp/pip-m_z2sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:16:28 INFO - Running setup.py (path:/tmp/pip-bmb6Fk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:16:28 INFO - Running setup.py (path:/tmp/pip-1XoB5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:16:28 INFO - Running setup.py (path:/tmp/pip-YuPXoU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:16:28 INFO - Running setup.py (path:/tmp/pip-joKf_G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:16:28 INFO - Running setup.py (path:/tmp/pip-oQJpDM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:16:28 INFO - Running setup.py (path:/tmp/pip-uxR1kN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:16:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:16:28 INFO - Running setup.py (path:/tmp/pip-65QWsS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:16:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:28 INFO - Running setup.py install for manifestparser 04:16:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for mozcrash 04:16:29 INFO - Running setup.py install for mozdebug 04:16:29 INFO - Running setup.py install for mozdevice 04:16:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for mozfile 04:16:29 INFO - Running setup.py install for mozhttpd 04:16:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for mozinfo 04:16:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for mozInstall 04:16:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for mozleak 04:16:29 INFO - Running setup.py install for mozlog 04:16:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:16:29 INFO - Running setup.py install for moznetwork 04:16:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Running setup.py install for mozprocess 04:16:30 INFO - Running setup.py install for mozprofile 04:16:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Running setup.py install for mozrunner 04:16:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Running setup.py install for mozscreenshot 04:16:30 INFO - Running setup.py install for moztest 04:16:30 INFO - Running setup.py install for mozversion 04:16:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:16:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:30 INFO - Cleaning up... 04:16:30 INFO - Return code: 0 04:16:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:16:30 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')]} 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:30 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')]} 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:30 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:30 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 04:16:30 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 04:16:30 INFO - Using env: {'DISPLAY': ':0', 04:16:30 INFO - 'HOME': '/home/cltbld', 04:16:30 INFO - 'LANG': 'en_US.UTF-8', 04:16:30 INFO - 'LANGUAGE': 'en_US:en', 04:16:30 INFO - 'LOGNAME': 'cltbld', 04:16:30 INFO - 'MAIL': '/var/mail/cltbld', 04:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:30 INFO - 'MOZ_NO_REMOTE': '1', 04:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:30 INFO - 'NO_EM_RESTART': '1', 04:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:30 INFO - 'SHELL': '/bin/bash', 04:16:30 INFO - 'SHLVL': '1', 04:16:30 INFO - 'TERM': 'linux', 04:16:30 INFO - 'TMOUT': '86400', 04:16:30 INFO - 'USER': 'cltbld', 04:16:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:30 INFO - '_': '/tools/buildbot/bin/python'} 04:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:16:30 INFO - Running setup.py (path:/tmp/pip-tpwuyR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:16:31 INFO - Running setup.py (path:/tmp/pip-0F_OPK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:16:31 INFO - Running setup.py (path:/tmp/pip-emppeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:16:31 INFO - Running setup.py (path:/tmp/pip-O70u6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:16:31 INFO - Running setup.py (path:/tmp/pip-DQHlQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:16:31 INFO - Running setup.py (path:/tmp/pip-5dWPAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:16:31 INFO - Running setup.py (path:/tmp/pip-N7hYT5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:16:31 INFO - Running setup.py (path:/tmp/pip-BYLovY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:16:31 INFO - Running setup.py (path:/tmp/pip-1zD2Fv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:16:31 INFO - Running setup.py (path:/tmp/pip-Z_TMMb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:16:31 INFO - Running setup.py (path:/tmp/pip-G_dnhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:16:31 INFO - Running setup.py (path:/tmp/pip-OSebvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:16:31 INFO - Running setup.py (path:/tmp/pip-G5Dmqs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:16:31 INFO - Running setup.py (path:/tmp/pip-SJUqqA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:16:31 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)) 04:16:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:16:31 INFO - Running setup.py (path:/tmp/pip-EtD7UG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:16:32 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)) 04:16:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:16:32 INFO - Running setup.py (path:/tmp/pip-CgN3L9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:16:32 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)) 04:16:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:16:32 INFO - Running setup.py (path:/tmp/pip-KlwiQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:16:32 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)) 04:16:32 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:32 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:32 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)) 04:16:32 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)) 04:16:32 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)) 04:16:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:32 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 04:16:32 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 04:16:32 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 04:16:32 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 04:16:32 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 04:16:32 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 04:16:35 INFO - Downloading blessings-1.6.tar.gz 04:16:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:35 INFO - Installing collected packages: blessings 04:16:35 INFO - Running setup.py install for blessings 04:16:36 INFO - Successfully installed blessings 04:16:36 INFO - Cleaning up... 04:16:36 INFO - Return code: 0 04:16:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:16:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:16:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:16:36 INFO - Reading from file tmpfile_stdout 04:16:36 INFO - Current package versions: 04:16:36 INFO - argparse == 1.2.1 04:16:36 INFO - blessings == 1.6 04:16:36 INFO - blobuploader == 1.2.4 04:16:36 INFO - docopt == 0.6.1 04:16:36 INFO - manifestparser == 1.1 04:16:36 INFO - mozInstall == 1.12 04:16:36 INFO - mozcrash == 0.17 04:16:36 INFO - mozdebug == 0.1 04:16:36 INFO - mozdevice == 0.48 04:16:36 INFO - mozfile == 1.2 04:16:36 INFO - mozhttpd == 0.7 04:16:36 INFO - mozinfo == 0.9 04:16:36 INFO - mozleak == 0.1 04:16:36 INFO - mozlog == 3.1 04:16:36 INFO - moznetwork == 0.27 04:16:36 INFO - mozprocess == 0.22 04:16:36 INFO - mozprofile == 0.28 04:16:36 INFO - mozrunner == 6.11 04:16:36 INFO - mozscreenshot == 0.1 04:16:36 INFO - mozsystemmonitor == 0.0 04:16:36 INFO - moztest == 0.7 04:16:36 INFO - mozversion == 1.4 04:16:36 INFO - psutil == 3.1.1 04:16:36 INFO - requests == 1.2.3 04:16:36 INFO - wsgiref == 0.1.2 04:16:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:16: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')]} 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:36 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 04:16:36 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 04:16:36 INFO - Using env: {'DISPLAY': ':0', 04:16:36 INFO - 'HOME': '/home/cltbld', 04:16:36 INFO - 'LANG': 'en_US.UTF-8', 04:16:36 INFO - 'LANGUAGE': 'en_US:en', 04:16:36 INFO - 'LOGNAME': 'cltbld', 04:16:36 INFO - 'MAIL': '/var/mail/cltbld', 04:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:36 INFO - 'MOZ_NO_REMOTE': '1', 04:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:36 INFO - 'NO_EM_RESTART': '1', 04:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:36 INFO - 'SHELL': '/bin/bash', 04:16:36 INFO - 'SHLVL': '1', 04:16:36 INFO - 'TERM': 'linux', 04:16:36 INFO - 'TMOUT': '86400', 04:16:36 INFO - 'USER': 'cltbld', 04:16:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:36 INFO - '_': '/tools/buildbot/bin/python'} 04:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 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)) 04:16:36 INFO - Cleaning up... 04:16:36 INFO - Return code: 0 04:16:36 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:16: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')]} 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:16:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:16:36 INFO - Using env: {'DISPLAY': ':0', 04:16:36 INFO - 'HOME': '/home/cltbld', 04:16:36 INFO - 'LANG': 'en_US.UTF-8', 04:16:36 INFO - 'LANGUAGE': 'en_US:en', 04:16:36 INFO - 'LOGNAME': 'cltbld', 04:16:36 INFO - 'MAIL': '/var/mail/cltbld', 04:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:36 INFO - 'MOZ_NO_REMOTE': '1', 04:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:36 INFO - 'NO_EM_RESTART': '1', 04:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:36 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:36 INFO - 'SHELL': '/bin/bash', 04:16:36 INFO - 'SHLVL': '1', 04:16:36 INFO - 'TERM': 'linux', 04:16:36 INFO - 'TMOUT': '86400', 04:16:36 INFO - 'USER': 'cltbld', 04:16:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:36 INFO - '_': '/tools/buildbot/bin/python'} 04:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:36 INFO - Downloading/unpacking jsonschema 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:40 INFO - Downloading/unpacking functools32 (from jsonschema) 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:40 INFO - warning: no files found matching '*.txt' 04:16:40 INFO - no previously-included directories found matching 'build' 04:16:40 INFO - no previously-included directories found matching 'dist' 04:16:40 INFO - no previously-included directories found matching '.git*' 04:16:40 INFO - Installing collected packages: jsonschema, functools32 04:16:40 INFO - Running setup.py install for functools32 04:16:40 INFO - warning: no files found matching '*.txt' 04:16:40 INFO - no previously-included directories found matching 'build' 04:16:40 INFO - no previously-included directories found matching 'dist' 04:16:40 INFO - no previously-included directories found matching '.git*' 04:16:40 INFO - Successfully installed jsonschema functools32 04:16:40 INFO - Cleaning up... 04:16:40 INFO - Return code: 0 04:16:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:40 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 0x7f64b3d84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bc6b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, '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': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', '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 04:16:40 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 04:16:40 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 04:16:40 INFO - Using env: {'DISPLAY': ':0', 04:16:40 INFO - 'HOME': '/home/cltbld', 04:16:40 INFO - 'LANG': 'en_US.UTF-8', 04:16:40 INFO - 'LANGUAGE': 'en_US:en', 04:16:40 INFO - 'LOGNAME': 'cltbld', 04:16:40 INFO - 'MAIL': '/var/mail/cltbld', 04:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:40 INFO - 'MOZ_NO_REMOTE': '1', 04:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:40 INFO - 'NO_EM_RESTART': '1', 04:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:16:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:16:40 INFO - 'SHELL': '/bin/bash', 04:16:40 INFO - 'SHLVL': '1', 04:16:40 INFO - 'TERM': 'linux', 04:16:40 INFO - 'TMOUT': '86400', 04:16:40 INFO - 'USER': 'cltbld', 04:16:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:40 INFO - '_': '/tools/buildbot/bin/python'} 04:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:40 INFO - Downloading/unpacking flake8 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:43 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 04:16:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 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 04:16:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:44 INFO - no previously-included directories found matching 'docs/_build' 04:16:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:44 INFO - Running setup.py install for pep8 04:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:44 INFO - no previously-included directories found matching 'docs/_build' 04:16:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:16:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:44 INFO - Cleaning up... 04:16:44 INFO - Return code: 0 04:16:44 INFO - Running post-action listener: _resource_record_post_action 04:16:44 INFO - Running post-action listener: _start_resource_monitoring 04:16:44 INFO - Starting resource monitoring. 04:16:44 INFO - ##### 04:16:44 INFO - ##### Running install step. 04:16:44 INFO - ##### 04:16:44 INFO - Running pre-action listener: _resource_record_pre_action 04:16:44 INFO - Running main action method: install 04:16:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:16:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:16:44 INFO - Reading from file tmpfile_stdout 04:16:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:16:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:16:44 INFO - Reading from file tmpfile_stdout 04:16:44 INFO - Output received: 04:16:44 INFO - Usage: mozinstall [options] installer 04:16:44 INFO - Options: 04:16:44 INFO - -h, --help show this help message and exit 04:16:44 INFO - -d DEST, --destination=DEST 04:16:44 INFO - Directory to install application into. [default: 04:16:44 INFO - "/builds/slave/test-pgo"] 04:16:44 INFO - --app=APP Application being installed. [default: firefox] 04:16:44 INFO - mkdir: /builds/slave/test-pgo/build/application 04:16:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:16:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:17:01 INFO - Reading from file tmpfile_stdout 04:17:01 INFO - Output received: 04:17:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:17:01 INFO - Running post-action listener: _resource_record_post_action 04:17:01 INFO - ##### 04:17:01 INFO - ##### Running run-tests step. 04:17:01 INFO - ##### 04:17:01 INFO - Running pre-action listener: _resource_record_pre_action 04:17:01 INFO - Running main action method: run_tests 04:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:17:01 INFO - Python 2.7.3 04:17:01 INFO - Return code: 0 04:17:01 INFO - grabbing minidump binary from tooltool 04:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:01 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 0x13b71d0>, '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 0x13ba750>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13babe0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:17:01 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 04:17:01 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 04:17:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:17:01 INFO - Return code: 0 04:17:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:17:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:17:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:17:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:17:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:17:02 INFO - Return code: 0 04:17:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:17:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:17:02 INFO - Using env: {'DISPLAY': ':0', 04:17:02 INFO - 'HOME': '/home/cltbld', 04:17:02 INFO - 'LANG': 'en_US.UTF-8', 04:17:02 INFO - 'LANGUAGE': 'en_US:en', 04:17:02 INFO - 'LOGNAME': 'cltbld', 04:17:02 INFO - 'MAIL': '/var/mail/cltbld', 04:17:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:17:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:02 INFO - 'MOZ_NO_REMOTE': '1', 04:17:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:17:02 INFO - 'NO_EM_RESTART': '1', 04:17:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:17:02 INFO - 'PWD': '/builds/slave/test-pgo', 04:17:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:17:02 INFO - 'SHELL': '/bin/bash', 04:17:02 INFO - 'SHLVL': '1', 04:17:02 INFO - 'TERM': 'linux', 04:17:02 INFO - 'TMOUT': '86400', 04:17:02 INFO - 'USER': 'cltbld', 04:17:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894', 04:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:02 INFO - '_': '/tools/buildbot/bin/python'} 04:17:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:17:02 INFO - mozversion application_buildid: 20160321203031 04:17:02 INFO - mozversion application_changeset: 3587b25bae302c1eed72968dbd7cef883e715948 04:17:02 INFO - mozversion application_display_name: Nightly 04:17:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:17:02 INFO - mozversion application_name: Firefox 04:17:02 INFO - mozversion application_remotingname: firefox 04:17:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:17:02 INFO - mozversion application_vendor: Mozilla 04:17:02 INFO - mozversion application_version: 48.0a1 04:17:02 INFO - mozversion platform_buildid: 20160321203031 04:17:02 INFO - mozversion platform_changeset: 3587b25bae302c1eed72968dbd7cef883e715948 04:17:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:17:02 INFO - mozversion platform_version: 48.0a1 04:17:02 INFO - using testdate: 1458645422 04:17:02 INFO - actual date: 1458645422 04:17:02 INFO - starting webserver on 'localhost:44786' 04:17:02 INFO - SUITE-START | Running 2 tests 04:17:02 INFO - TEST-START | dromaeo_css 04:17:02 INFO - operating with platform_type : linux_ 04:17:02 INFO - Initialising browser for dromaeo_css test... 04:17:02 INFO - TEST-INFO | started process 4947 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoqql_f/profile http://localhost:44786/getInfo.html) 04:17:06 INFO - PROCESS | 4947 | __metrics Screen width/height:1600/1200 04:17:06 INFO - PROCESS | 4947 | colorDepth:24 04:17:06 INFO - PROCESS | 4947 | Browser inner width/height: 1024/697 04:17:06 INFO - PROCESS | 4947 | __metrics 04:17:07 ERROR - PROCESS | 4947 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:17:08 INFO - TEST-INFO | 4947: exit 0 04:17:08 INFO - Browser initialized. 04:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:17:08 INFO - TEST-INFO | started process 5043 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoqql_f/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:20 INFO - PROCESS | 5043 | RSS: Main: 156405760 04:17:20 INFO - PROCESS | 5043 | 04:18:11 INFO - PROCESS | 5043 | 1458645491337 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] 04:20:19 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44786/tests/dromaeo/cssquery-ext.html) 04:20:20 INFO - PROCESS | 5043 | RSS: Main: 256897024 04:20:20 INFO - PROCESS | 5043 | 04:23:22 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-ext.html (next: http://localhost:44786/tests/dromaeo/cssquery-jquery.html) 04:23:22 INFO - PROCESS | 5043 | RSS: Main: 239509504 04:23:22 INFO - PROCESS | 5043 | 04:26:24 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44786/tests/dromaeo/cssquery-mootools.html) 04:26:25 INFO - PROCESS | 5043 | RSS: Main: 237375488 04:26:25 INFO - PROCESS | 5043 | 04:29:27 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44786/tests/dromaeo/cssquery-prototype.html) 04:29:27 INFO - PROCESS | 5043 | RSS: Main: 217473024 04:29:27 INFO - PROCESS | 5043 | 04:32:30 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44786/tests/dromaeo/cssquery-yui.html) 04:32:30 INFO - PROCESS | 5043 | RSS: Main: 223006720 04:32:30 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | Cycle 1(1): loaded http://localhost:44786/tests/dromaeo/cssquery-yui.html (next: http://localhost:44786/tests/dromaeo/cssquery-dojo.html) 04:35:33 INFO - PROCESS | 5043 | RSS: Main: 254246912 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | __start_tp_report 04:35:33 INFO - PROCESS | 5043 | _x_x_mozilla_page_load 04:35:33 INFO - PROCESS | 5043 | _x_x_mozilla_page_load_details 04:35:33 INFO - PROCESS | 5043 | |i|pagename|runs| 04:35:33 INFO - PROCESS | 5043 | |0;dojo.html;3003.5494675798627;3028.273214428538;3092.5051991681335;3101.5812865263183;3122.266267427155;5174.835661976053;5182.807954170543;5243.711595862231;5254.080535906215;5289.629725919178;5309.761060752266;5318.893622127555;5362.249285100089;5374.838754837351;5375.784968601261;4653.7440440775745;4701.012787314677;4795.040991801636;4850.175470170079;4883.413990321166;4685.36747539083;4818.759062046901;4843.854684359475;4884.560389564938;4901.387326584177;4737.407824021997;4763.190257656172;4766.499517550642;4809.639277054217;4813.855584332476;4644.4658864230705;4653.371794807692;4671.69633973794;4673.299005149221;4706.552877476668;4648.976755116203;4672;4677.836275730333;4731.976340118312;4780.330753694486;5235.816746413895;5245.423003469616;5258.684478931276;5278.208268759717;5298.046351656701;5659.320881494205;5660.2075709400715;5661.122526008476;5661.745221465044;5663.235463212455;5504.91742623861;5683;5685.687287199244;5686.0617998030275;5777.62445441045;5366.087765079946;5371.516563509224;5380.892382152335;5421.512063914267;5430.782768689248;5859.472647461749;5860.208871802252;5862.677552734641;5864.67744274069;5865.384134665798;5477.260569823023;5484.725763711878;5564.33228012641;5576.219329293902;5635.436456354414;5701.543876489871;5707.486326230659;5710.828675139753;5712.6286791358425;5715.514181294553;5692.57305702074;5694.402087780806;5696.174054762037;5696.430356964353;5702.429757024347;5469.671819690831;5658.717064146858;5727.31272247333;5744.310682718101;5788.392218817048;4288.957110428918;4300.247456695129;4302.204092242945;4308.202982448257;4348.652107831366;3817.9809100954317;3841.9231615367535;3854.9229015419533;3879.0690234343556;3895.4351619015083;5273.709945952933;5286.524212820865;5307.575393968474;5312.681239125664;5333.57331413486;5652.123920792284;5690.487856092972;5691.089425691869;5692.516136128393;5713;5280.973595132076;5371.086915224421;5377.892442151135;5379.435159308295;5436.401995780461;4820.180569303227;4837.346958160673;4839.104765618372;4866.853994380174;4870.805167793319;5737.08206686928;5759.1937128802;5790.94209057904;5803.912941305884;5808.448197421239;5455.0726376515295;5517.117261238182;5540.445955404427;5579.637323573955;5720.3421606515785;5928.081147422156;5940.821775346746;5941.465268125889;5963;5966.612170208922;5556.361018482926;5614.691191984317;5615.157726341082;5615.7192140392;5616.69108199053;5524.281843360337;5668.716564171693;5695.088785794253;5703.600747947604;5788.507976822018;5576.386597474194;5578.944210558005;5581.972090139686;5583.246261754611;5600.327960644749;5490.615656904138;5520.889582208413;5521.171824226398;5548.4174161712435;5549;5348.171033489815;5516.14499752539;5523.199136125159;5623.943760562505;5630.774769009194;5523.364813046391;5560.332760068818;5570.025245581925;5593.300837395325;5593.776248949996;5458.8362349128;5480.561555075664;5484.972575137099;5485.862853428696;5514.641548299348 04:35:33 INFO - PROCESS | 5043 | |1;ext.html;539.816462402783;557.4898967444789;560.319212157229;582.7872826418358;594.417470878539;39877.2024559509;40630.39054414179;40630.7968460158;40643.18713625729;40683.38974915379;42271;42671;42725.35911961323;42743.78628106863;42823.78588107063;8613.224809767135;8791.252743516809;8794.384393092487;8800.427972181787;8803.691870784523;8621.094785047573;8718.520481373522;8730.432521886089;8730.476171429702;8731.781705457382;8929.464232146092;8997.100289971017;9007.684731034415;9009.144131307516;9009.729708108767;8874.378793484459;8942.15049570293;8942.86585701215;8956.820863582692;8960.551972401354;8825.338099642553;8928.508932008737;8940;8942.374033817636;8947.150020748084;41052.79473602613;41267;41404.1719165618;41420.79289603563;41541.58458415407;2003.5892642008353;3485.721142308609;3562.358775420423;4226.5139508956245;4273.87178384649;29643.85178074096;30015;30190.24524386886;30814.075577732703;32190.19524511906;3974.960250397488;4123.8969025774595;4126.834926602933;4142.0680346922;4249.022724773288;333430;333528;335702;336824.99999999756;336887;58861;58888.11667824986;59214.70392648009;59429.70285148547;59523.70238148781;57237.71381143068;68221.31778682249;69184.65407672929;69202;69495;16321.34714611426;16399.344026238818;16520.256588453547;16521.66956660884;16530.421435249707;11579.363135027486;11581.363025033705;11585.884141158649;11659.358735269472;11691.88308116925;20639.484012899797;20948.790512094685;20978.84616346085;21231.893840530698;21945.890270548865;7954.323882470055;8128.9187108129345;8231.711890083818;8328.250457458858;8378.49729016261;957.5355952363099;988.2489308125876;1146.4325159046325;1167.573835550035;1206.1737709668905;32328.19179520484;32434.675653243637;32452.513212301834;32857;33405.498917516255;1132.9320240785414;1145.1583086431467;1164.1443538998828;1233.5744168261936;1244.7012716948047;16506.83493165077;16910.577235568962;16930;16957;17178.570535736708;367518;367762;370956;371587;371701;56608.43391566114;57203;57823.710881445324;57873.710631447415;57920.420795791506;1043.5147656339839;1268.0806415348798;1306.4447609765812;1388.0908005256574;1433.7634290342185;29001.56497652579;30319;30420;30828.22929426782;30924.536131958488;40775.59224407718;52153.47846521486;52856.20715689345;52918.735406322725;52930;266805;271020;271549;271957;272708;38875.6112438872;39661.80169099136;45177.77411113055;45860;48182.27726584174;45981.77009114933;46370.53629463797;46596.30105548352;46923.53076469192;47655.76172119117;41564.58435415607;42140.78929605455;42648.78675606602;42932.35601466043;43554.34668480039;42178.578214217465;42627.57372426236;42688.65691721367;42692.78653606712;42737.786311068245;45144.77427612841;45323.09353812971;45451.54548454473;45937.540624594665;46272.30591541062;38951.6104838948;38991.6100838988;39441;40995.590044099175;42367;32703.836480817445;33489;33669.83165084159;34183.658163419044;34529.654703452645 04:35:33 INFO - PROCESS | 5043 | |2;jquery.html;379.6867584243;380.4806439210478;381.4488064746442;382.3480964954751;385.7280617164899;17435.738463923037;18257.908710456446;19155.233790648374;19559.70660440091;19577.51056223595;17520.299188032463;17638.559036024108;18210.908945455256;18228.362007329713;18255.726164107517;5133.922991155136;5260.421353651095;5296.576273898079;5299.311089558352;5302.920456193141;3790.8294126764363;5263.526282634562;5593.468620481048;5841.591088623777;5860.882782344351;5795.1017592273265;5840.474357307841;5855.79504717335;5858.677772722499;5860.501857342131;5486.753096110665;5710.486056254916;5713.685747283918;5716.1425786131995;5796.30444346679;3652.76257043294;5389.514943655051;5494.423085575997;5515.393306736256;5568.888622227532;12825;13125.409356578977;13226.272555009471;13267.137636053625;13295.20228786276;2259.604569200383;2422.733499315074;2815.183596756938;2837.3757773289844;2958.2604348912773;9181.586828592663;9619.807603847954;9878.407295562289;10040.146587540068;10108.837483689396;1992.22303301711;2072.585482903425;2166.945826354354;2199.7580266170708;2293.0598454633687;68275.65862170707;68652.6567367165;70417.29582704158;72515.27484725138;73545.63227183884;10716.142708583295;10906.5092070857;11055.557777688802;11256.493457794419;11277.71805704864;14495.275236238145;14534.85465145335;14684.853151468562;14798.260086995608;14822.110673359633;7998.200179981955;8078.757637270891;8088.4742491739025;8212.876806847902;8236.258736713604;7925.643346049442;8094.231048050426;8219.095899451055;8367.707130250412;8393;4819.734914579662;4845.055214233191;4848.3454733610515;4858.902821943541;4931.580815630711;1815.4372144635206;1907.7996810334714;1925.1336898395778;1949.0547084663926;1996.3212507747435;978.6623614852864;981.239539357004;981.8379967305458;1029.433811403725;1065.893410658928;17462.738058929128;17527.561810954827;17641.206145723474;17691.73462398065;17917.19372628235;1023.3399457349967;1026.2816028779735;1034.6585626743156;1035.1304903880775;1097.2209731091016;9976.700698979042;10651.627193048205;10711.357318560755;10759.462026898624;10808.459577021118;430694;440003;446460;447628;447645;73990;77016.22983770202;79090.20909790829;82490.58754706188;86653;488.4919683529161;501.7541404711738;504.8031267805559;504.8207886200419;505.24970418927865;10285.228607854291;10485.633002844865;10877.728056798644;11000.614978475714;11162.720931976766;26380.4723905517;36618.63381366152;36659.252780207426;36989.63010369862;37072;52509.737451312496;53212.46787532075;53320.20019699785;53619.731901340245;54519.45480545144;8125.228103330174;8161.591920403837;8414;8512.97844258693;8546.658133674584;8897.866532001895;10401.58393664245;11418.714532136763;12121;13336.866631333562;11058.502367393326;11323.094152467947;11335.829962550404;11642.708932276422;11771.705707357041;11191.888081119085;11245.606403775828;11280.928311810365;11286.097112230838;11383.089352851586;11151.609693661008;11511;11765.882341176479;11899.583514576949;12032.398380081137;7904;8080.71717489885;8273.83452330962;8560.828783424173;8619.396642234984;10523.631672891412;10741.946290268812;11001.724956876142;11140.220184587326;11393.886061139283 04:35:33 INFO - PROCESS | 5043 | |3;mootools.html;1321.128055483381;1453.5058080252716;1480.7408703476892;1650.537849402168;1823.1431227323162;7712.614369281535;7882.645280962356;7919.881201781971;7934.365250779938;7961.920380796198;7819.960900195505;7965.44241903067;7968.840623187532;7973.641186146623;7974.362051035918;2005.1979208316643;2256.187772401934;2273.9090436382608;2283.4177284792436;2346.530693861226;2351.9176828810996;2356.893939772706;2360.752121027293;2361.2207971369494;2363.8463499872455;2248.415411992877;2289.622212334971;2294.942626434344;2295.6326987681973;2296.3799774060994;2283.5090455552054;2303.735070466901;2337.801286890616;2356.5051339218785;2358.587247231736;2310.110607416157;2314.8148148148107;2316.1661801751357;2343.8593684378993;2355.8350915435926;7980.241877021674;8028.638711258008;8051.59742012897;8053.557054362008;8061.717839875576;4798.208295631217;4901.8774530636665;4907.288443175756;4940.25896115582;4955.752212389366;3045.817250964927;3135.827529485877;3181.3796309719614;3227.596550431196;3237.7086062254275;1042.5517027678095;1062.0282441566035;1085.567051492031;1123.859517560305;1134.9489272982735;11213.10295176384;11379.487923043484;11405.771884562262;11417.42912854354;11438.828417573743;4322.200392927319;4338.0890013097605;4388.539203383599;4410.911781764346;4428.2914733642465;9624.75938101553;9626.807463850684;9639;9644.18024467914;9649.986751391003;4333.501647310537;4959.7272150032095;4973.05511952735;4983.302337672729;4987.650864439527;4417.977910110493;4478.619317358061;4504.346869703874;4508.346289787963;4533;3810.2760475509563;3862.0537968197973;3875.7093218008763;3908.179282350681;3944.8619298324993;1208.350601429043;1227.8281040654315;1229.1211783574608;1233.890595698834;1243.160866415166;1339.1295657822493;1351.1555277951281;1373.3613869550707;1382.9031967762362;1383.5918404070824;7729.768106956801;7837.568933708701;7863.37093032556;7889.605519723991;7891.289783919475;473.78679594182756;473.9715617062987;476.81404252341616;482.4909720245105;484.4066019126542;5959;5965.254343207099;5984.461398474158;6032.065029920369;6033.637981721111;9321.207697345666;9798;9822.066903644143;9890.752731181778;9890.950545247228;9685.9031409685;9696.709098726908;9701.07839755222;9752.21982241419;9759.12167904892;7357.59533225667;7623.085229772463;7681.116671582728;7696.4227682924;7699.846003079907;7225.349718525358;7301.780946571611;7305.926940730737;7322.2677732228485;7385.630718463948;8440.451370660887;8645.740627781177;8754;8766.91233087661;8907.554622268732;8727.65089396417;8772.342074344577;8895.4662720237;8909.955450222968;8924.286057115285;6336.841578960379;6559.704813283318;6742.224644165984;6965.965170174117;7070.787876363717;7298.96350518244;7322.524035937647;7328.267173282629;7370.262973702587;7379.409647228316;6390.712417941111;6652.869012268023;6665.933340666531;6714.496412769159;6810.693518791765;6542.149520562297;6546.443552298108;6620.3710647488415;6644.468442524683;6700.698468569024;7314.634268286458;7326.3406293433845;7350.852982940204;7354.264573542603;7363.8159046024275;6365.045243213555;6429.421352078335;6430.549861509649;6435.935640643721;6440.355964403522;6636.966815165893;6645.60126392418;6660.966695166493;6661.566998145299;6667.766628167991 04:35:33 INFO - PROCESS | 5043 | |4;prototype.html;344.9137715571107;345.0786400311169;345.123386598041;348.54166770696526;353.5651149086625;5870.765169393219;5911.20198773165;5927.525797936166;5927.73325200366;5933.169356290123;5806.1000544915605;5833.620814647055;5861.032929566627;5869.090291004901;5900.586958912878;4311.6335111515555;4417.580329868657;4502.0545685406105;4536.274196128612;4552.795124219418;4530.728156310632;4533.387992621004;4543.250363689987;4546.045330480603;4548.317752337143;4485.506594274627;4494.550544945496;4495;4496.910061798762;4504.1892459357305;4285.892852678692;4390.253656878338;4482.148391805546;4483.574060464251;4485.573870482299;3964.207158568298;3964.3657014877767;3967;3970.166265084336;3972.245273398045;5674;5678.176664383683;5682.801101961411;5690.174924635946;5695.5443564514735;5268.657537260104;5271.947280527184;5282.418933917266;5286.365636123652;5291.047611429941;6204.6587437690905;6205.410486003822;6212.502999760053;6217.502599792051;6221.813345599594;4390.012247244376;4456.554344565518;4462.531434199394;4478.104379124188;4492.775361231926;6372.968135159341;6503.154589903283;6520.608763474207;6523.93476065238;6531.673416329165;4606.792694328763;4607.101615185074;4608.861734147981;4609.492955774862;4614.0310534787395;4662.860114196579;4663.743494107856;4664.486906440289;4666.626669866402;4668.486466488684;5309.814156504503;5310.468953104659;5317.2024196370085;5319.361676598833;5323.068463018956;6152.753889844356;6296.275928268216;6296.496280297565;6314.9684251579365;6315.684215789192;1633.991830040866;1639.0821140161547;1650.1584192062135;1651.719207734688;1656.155360765994;1023.1814548361281;1116.0792346314324;1117.050507069001;1120.7086157599083;1149.672343382132;5933.762649494059;5957.731902064417;5974.253218347707;5990.341062483123;5997.940020599738;6330.873382532323;6378.202724659418;6406.423421891959;6408.807735767934;6409.967950160312;5949.9107513387335;5950.375210602911;5954.642721436728;5955.34491205967;5956.374580669054;3391.406503861814;3414.2830005698584;3421.674940880612;3432.639572844865;3441.5525981622227;6467.306050316706;6517.641529715816;6594.934050659528;6599.53803233769;6606.339366063451;6473.741050358027;6474.967625161844;6517.934820651828;6526.64103474304;6527.02094685801;6540.247871494744;6542.705578248991;6550.443212326911;6556.606603603799;6559.934400655932;6364.299927008118;6391.2330520337855;6394.296627371078;6417.614943103242;6431.549791514736;6275.184226050585;6290.622562646256;6292.653904035139;6301.991681330965;6328.525360597881;6717.16035495563;6761.797146085625;6774.187097548326;6789.660516974032;6796.796096117125;4366.170427618742;4393.121375724804;4396.472423309224;4406.2289099406835;4410.051838854662;6522.315156908457;6525.412712855866;6527.967360163168;6535.803925882231;6538.346165383614;6332.176817013943;6336.556441049082;6351.110844481684;6351.428371446592;6354.3963323484195;6077.969610151921;6304.211973503312;6308.148399965946;6316.305206427198;6356.141920840627;6153.784617538365;6157.876842463215;6184.536159787944;6191.4118158774845;6218.689065546614;6313.979526551643;6320.5575609706875;6337.651429171256;6338.11266422692;6348.873022539616;5924;6058.151858739692;6152;6197.597156184834;6202.193714817045 04:35:33 INFO - PROCESS | 5043 | |5;yui.html;757.257887270475;785.1598789295456;827.3835992185826;867.1025488619279;873.9169778871009;12658.936705316471;12683;12745;12770.744585108292;12858.871411285885;11754.706132346695;12437.502499899992;12438.564650237244;12441.564545240919;12457;650.8600650860064;801.6312496251732;816.4121832280748;824.814416756231;832.5629044751494;828.1304630138361;832.4797001873828;833.9958300208491;835.2983493865152;837.5351679817699;868.1882439918664;871.4117970370006;871.4727589808169;872.0233338660677;872.1888643561485;669.8024082895533;858.1118542308711;873.2926329672954;875.9605817738217;883.6509578716435;641.0960545630638;643.5623775832432;643.6363454648156;643.6459947029163;643.8969764837603;11770.058395328353;11814.645560633195;11819.586314478953;11822.172447928648;11826.290422574588;13149;13336;13352.86647133526;13897.652558686013;13918.721625567534;12190.268583884996;12388.31864247466;12574;12608.306543140123;12807.167534110253;3801.600831912637;3829.7319187656876;3856.325143099946;3890.2414029264305;3915.804209789499;53955.19067214034;55062.39251289831;55841.72079139578;55949.72025139848;56314.718426407606;10710.196735244888;10727.463626818628;10943.343399395902;10948;11357.772844543062;18670.253189872525;18717.344892928682;18845;18867.622647547247;18875.716864247046;7603.543787372775;7703.961480192564;7740.225977402328;7753.379729621617;7853.489523180975;4363.912721745547;4398.142362239332;4477.9100423424115;4496.145732310851;4559.065391594715;3222.5971753530807;3232.8060316381093;3247.5291082792864;3268.8692452302116;3286.5070239463794;574.6465923457127;577.0882006429831;584.5382148103037;588.2206076948061;675.1189697444881;713.1905287498727;719.1873183302835;760.1144666463618;763.3892885691536;794.213728408871;9629.133377995873;9905.10854023127;10027.498625068863;10034.899651003543;10042.19662427004;693.836948317145;752.766642340876;756.4969295418595;769.5844244108118;788.6884680551265;4466.843660471868;4687.156311863897;4744.383230180055;4770.379850619397;4810.4467986182035;61438.38561614326;61882.69058654768;62017.68991155105;62104;62733;55275.72362138244;56217.15674264889;56580;57061.42938570644;57249;47874;48195.795105123354;48272.7586362073;48873;49794.25308620374;10205.13256373187;10213.182945364502;10230.28388012832;10257;10273.845892311472;37582;37782.81108594439;37822;37897.62102378941;39476.80261598789;43539.56460435355;46505.76747116378;46711.29933050939;46772.532274676814;47101.29348059713;10709.357438553712;10825.945870270598;11491.54033838637;11549.805536947953;11570.94214528922;12844.229346239255;13178.406971686489;13383.933080334536;13501.932490337485;13887.444502219798;11957.402129893644;12384.938075309567;12517.311547864954;12861.164024338388;13170.80243796363;11628.709282267673;11966.521339146684;12331.383430828244;12543.56097536582;12744.936275318563;12203.75592488163;12447.377631118588;12548.372581370711;12910.289934053717;13008.934955325163;9874.358166719141;9912.15746661513;9953.353032052893;10237.488125593542;10630.202734794766;10771.676849694522;10973.615923442641;11143.662760468796;11156.274842135235;11505.309681419141 04:35:33 INFO - PROCESS | 5043 | __end_tp_report 04:35:33 INFO - PROCESS | 5043 | __start_cc_report 04:35:33 INFO - PROCESS | 5043 | _x_x_mozilla_cycle_collect,851 04:35:33 INFO - PROCESS | 5043 | __end_cc_report 04:35:33 INFO - PROCESS | 5043 | __startTimestamp1458646533429__endTimestamp 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | ------- Summary: start ------- 04:35:33 INFO - PROCESS | 5043 | Number of tests: 6 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#0] dojo.html Cycles:165 Average:5258.08 Median:5484.97 stddev:612.72 (11.2%) stddev-sans-first:588.52 04:35:33 INFO - PROCESS | 5043 | Values: 3003.5 3028.3 3092.5 3101.6 3122.3 5174.8 5182.8 5243.7 5254.1 5289.6 5309.8 5318.9 5362.2 5374.8 5375.8 4653.7 4701.0 4795.0 4850.2 4883.4 4685.4 4818.8 4843.9 4884.6 4901.4 4737.4 4763.2 4766.5 4809.6 4813.9 4644.5 4653.4 4671.7 4673.3 4706.6 4649.0 4672.0 4677.8 4732.0 4780.3 5235.8 5245.4 5258.7 5278.2 5298.0 5659.3 5660.2 5661.1 5661.7 5663.2 5504.9 5683.0 5685.7 5686.1 5777.6 5366.1 5371.5 5380.9 5421.5 5430.8 5859.5 5860.2 5862.7 5864.7 5865.4 5477.3 5484.7 5564.3 5576.2 5635.4 5701.5 5707.5 5710.8 5712.6 5715.5 5692.6 5694.4 5696.2 5696.4 5702.4 5469.7 5658.7 5727.3 5744.3 5788.4 4289.0 4300.2 4302.2 4308.2 4348.7 3818.0 3841.9 3854.9 3879.1 3895.4 5273.7 5286.5 5307.6 5312.7 5333.6 5652.1 5690.5 5691.1 5692.5 5713.0 5281.0 5371.1 5377.9 5379.4 5436.4 4820.2 4837.3 4839.1 4866.9 4870.8 5737.1 5759.2 5790.9 5803.9 5808.4 5455.1 5517.1 5540.4 5579.6 5720.3 5928.1 5940.8 5941.5 5963.0 5966.6 5556.4 5614.7 5615.2 5615.7 5616.7 5524.3 5668.7 5695.1 5703.6 5788.5 5576.4 5578.9 5582.0 5583.2 5600.3 5490.6 5520.9 5521.2 5548.4 5549.0 5348.2 5516.1 5523.2 5623.9 5630.8 5523.4 5560.3 5570.0 5593.3 5593.8 5458.8 5480.6 5485.0 5485.9 5514.6 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#1] ext.html Cycles:180 Average:51472.17 Median:41481.19 stddev:85761.88 (206.7%) stddev-sans-first:85917.20 04:35:33 INFO - PROCESS | 5043 | Values: 539.8 557.5 560.3 582.8 594.4 39877.2 40630.4 40630.8 40643.2 40683.4 42271.0 42671.0 42725.4 42743.8 42823.8 8613.2 8791.3 8794.4 8800.4 8803.7 8621.1 8718.5 8730.4 8730.5 8731.8 8929.5 8997.1 9007.7 9009.1 9009.7 8874.4 8942.2 8942.9 8956.8 8960.6 8825.3 8928.5 8940.0 8942.4 8947.2 41052.8 41267.0 41404.2 41420.8 41541.6 2003.6 3485.7 3562.4 4226.5 4273.9 29643.9 30015.0 30190.2 30814.1 32190.2 3975.0 4123.9 4126.8 4142.1 4249.0 333430.0 333528.0 335702.0 336825.0 336887.0 58861.0 58888.1 59214.7 59429.7 59523.7 57237.7 68221.3 69184.7 69202.0 69495.0 16321.3 16399.3 16520.3 16521.7 16530.4 11579.4 11581.4 11585.9 11659.4 11691.9 20639.5 20948.8 20978.8 21231.9 21945.9 7954.3 8128.9 8231.7 8328.3 8378.5 957.5 988.2 1146.4 1167.6 1206.2 32328.2 32434.7 32452.5 32857.0 33405.5 1132.9 1145.2 1164.1 1233.6 1244.7 16506.8 16910.6 16930.0 16957.0 17178.6 367518.0 367762.0 370956.0 371587.0 371701.0 56608.4 57203.0 57823.7 57873.7 57920.4 1043.5 1268.1 1306.4 1388.1 1433.8 29001.6 30319.0 30420.0 30828.2 30924.5 40775.6 52153.5 52856.2 52918.7 52930.0 266805.0 271020.0 271549.0 271957.0 272708.0 38875.6 39661.8 45177.8 45860.0 48182.3 45981.8 46370.5 46596.3 46923.5 47655.8 41564.6 42140.8 42648.8 42932.4 43554.3 42178.6 42627.6 42688.7 42692.8 42737.8 45144.8 45323.1 45451.5 45937.5 46272.3 38951.6 38991.6 39441.0 40995.6 42367.0 32703.8 33489.0 33669.8 34183.7 34529.7 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#2] jquery.html Cycles:180 Average:26022.48 Median:36824.44 stddev:72824.46 (197.8%) stddev-sans-first:73003.30 04:35:33 INFO - PROCESS | 5043 | Values: 379.7 380.5 381.4 382.3 385.7 17435.7 18257.9 19155.2 19559.7 19577.5 17520.3 17638.6 18210.9 18228.4 18255.7 5133.9 5260.4 5296.6 5299.3 5302.9 3790.8 5263.5 5593.5 5841.6 5860.9 5795.1 5840.5 5855.8 5858.7 5860.5 5486.8 5710.5 5713.7 5716.1 5796.3 3652.8 5389.5 5494.4 5515.4 5568.9 12825.0 13125.4 13226.3 13267.1 13295.2 2259.6 2422.7 2815.2 2837.4 2958.3 9181.6 9619.8 9878.4 10040.1 10108.8 1992.2 2072.6 2166.9 2199.8 2293.1 68275.7 68652.7 70417.3 72515.3 73545.6 10716.1 10906.5 11055.6 11256.5 11277.7 14495.3 14534.9 14684.9 14798.3 14822.1 7998.2 8078.8 8088.5 8212.9 8236.3 7925.6 8094.2 8219.1 8367.7 8393.0 4819.7 4845.1 4848.3 4858.9 4931.6 1815.4 1907.8 1925.1 1949.1 1996.3 978.7 981.2 981.8 1029.4 1065.9 17462.7 17527.6 17641.2 17691.7 17917.2 1023.3 1026.3 1034.7 1035.1 1097.2 9976.7 10651.6 10711.4 10759.5 10808.5 430694.0 440003.0 446460.0 447628.0 447645.0 73990.0 77016.2 79090.2 82490.6 86653.0 488.5 501.8 504.8 504.8 505.2 10285.2 10485.6 10877.7 11000.6 11162.7 26380.5 36618.6 36659.3 36989.6 37072.0 52509.7 53212.5 53320.2 53619.7 54519.5 8125.2 8161.6 8414.0 8513.0 8546.7 8897.9 10401.6 11418.7 12121.0 13336.9 11058.5 11323.1 11335.8 11642.7 11771.7 11191.9 11245.6 11280.9 11286.1 11383.1 11151.6 11511.0 11765.9 11899.6 12032.4 7904.0 8080.7 8273.8 8560.8 8619.4 10523.6 10741.9 11001.7 11140.2 11393.9 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#3] mootools.html Cycles:180 Average:5591.29 Median:6350.94 stddev:2948.46 (46.4%) stddev-sans-first:2939.26 04:35:33 INFO - PROCESS | 5043 | Values: 1321.1 1453.5 1480.7 1650.5 1823.1 7712.6 7882.6 7919.9 7934.4 7961.9 7820.0 7965.4 7968.8 7973.6 7974.4 2005.2 2256.2 2273.9 2283.4 2346.5 2351.9 2356.9 2360.8 2361.2 2363.8 2248.4 2289.6 2294.9 2295.6 2296.4 2283.5 2303.7 2337.8 2356.5 2358.6 2310.1 2314.8 2316.2 2343.9 2355.8 7980.2 8028.6 8051.6 8053.6 8061.7 4798.2 4901.9 4907.3 4940.3 4955.8 3045.8 3135.8 3181.4 3227.6 3237.7 1042.6 1062.0 1085.6 1123.9 1134.9 11213.1 11379.5 11405.8 11417.4 11438.8 4322.2 4338.1 4388.5 4410.9 4428.3 9624.8 9626.8 9639.0 9644.2 9650.0 4333.5 4959.7 4973.1 4983.3 4987.7 4418.0 4478.6 4504.3 4508.3 4533.0 3810.3 3862.1 3875.7 3908.2 3944.9 1208.4 1227.8 1229.1 1233.9 1243.2 1339.1 1351.2 1373.4 1382.9 1383.6 7729.8 7837.6 7863.4 7889.6 7891.3 473.8 474.0 476.8 482.5 484.4 5959.0 5965.3 5984.5 6032.1 6033.6 9321.2 9798.0 9822.1 9890.8 9891.0 9685.9 9696.7 9701.1 9752.2 9759.1 7357.6 7623.1 7681.1 7696.4 7699.8 7225.3 7301.8 7305.9 7322.3 7385.6 8440.5 8645.7 8754.0 8766.9 8907.6 8727.7 8772.3 8895.5 8910.0 8924.3 6336.8 6559.7 6742.2 6966.0 7070.8 7299.0 7322.5 7328.3 7370.3 7379.4 6390.7 6652.9 6665.9 6714.5 6810.7 6542.1 6546.4 6620.4 6644.5 6700.7 7314.6 7326.3 7350.9 7354.3 7363.8 6365.0 6429.4 6430.5 6435.9 6440.4 6637.0 6645.6 6661.0 6661.6 6667.8 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#4] prototype.html Cycles:180 Average:5242.18 Median:5933.47 stddev:1558.04 (26.3%) stddev-sans-first:1518.44 04:35:33 INFO - PROCESS | 5043 | Values: 344.9 345.1 345.1 348.5 353.6 5870.8 5911.2 5927.5 5927.7 5933.2 5806.1 5833.6 5861.0 5869.1 5900.6 4311.6 4417.6 4502.1 4536.3 4552.8 4530.7 4533.4 4543.3 4546.0 4548.3 4485.5 4494.6 4495.0 4496.9 4504.2 4285.9 4390.3 4482.1 4483.6 4485.6 3964.2 3964.4 3967.0 3970.2 3972.2 5674.0 5678.2 5682.8 5690.2 5695.5 5268.7 5271.9 5282.4 5286.4 5291.0 6204.7 6205.4 6212.5 6217.5 6221.8 4390.0 4456.6 4462.5 4478.1 4492.8 6373.0 6503.2 6520.6 6523.9 6531.7 4606.8 4607.1 4608.9 4609.5 4614.0 4662.9 4663.7 4664.5 4666.6 4668.5 5309.8 5310.5 5317.2 5319.4 5323.1 6152.8 6296.3 6296.5 6315.0 6315.7 1634.0 1639.1 1650.2 1651.7 1656.2 1023.2 1116.1 1117.1 1120.7 1149.7 5933.8 5957.7 5974.3 5990.3 5997.9 6330.9 6378.2 6406.4 6408.8 6410.0 5949.9 5950.4 5954.6 5955.3 5956.4 3391.4 3414.3 3421.7 3432.6 3441.6 6467.3 6517.6 6594.9 6599.5 6606.3 6473.7 6475.0 6517.9 6526.6 6527.0 6540.2 6542.7 6550.4 6556.6 6559.9 6364.3 6391.2 6394.3 6417.6 6431.5 6275.2 6290.6 6292.7 6302.0 6328.5 6717.2 6761.8 6774.2 6789.7 6796.8 4366.2 4393.1 4396.5 4406.2 4410.1 6522.3 6525.4 6528.0 6535.8 6538.3 6332.2 6336.6 6351.1 6351.4 6354.4 6078.0 6304.2 6308.1 6316.3 6356.1 6153.8 6157.9 6184.5 6191.4 6218.7 6314.0 6320.6 6337.7 6338.1 6348.9 5924.0 6058.2 6152.0 6197.6 6202.2 04:35:33 INFO - PROCESS | 5043 | 04:35:33 INFO - PROCESS | 5043 | [#5] yui.html Cycles:180 Average:14825.79 Median:23951.74 stddev:17323.79 (72.3%) stddev-sans-first:17340.17 04:35:33 INFO - PROCESS | 5043 | Values: 757.3 785.2 827.4 867.1 873.9 12658.9 12683.0 12745.0 12770.7 12858.9 11754.7 12437.5 12438.6 12441.6 12457.0 650.9 801.6 816.4 824.8 832.6 828.1 832.5 834.0 835.3 837.5 868.2 871.4 871.5 872.0 872.2 669.8 858.1 873.3 876.0 883.7 641.1 643.6 643.6 643.6 643.9 11770.1 11814.6 11819.6 11822.2 11826.3 13149.0 13336.0 13352.9 13897.7 13918.7 12190.3 12388.3 12574.0 12608.3 12807.2 3801.6 3829.7 3856.3 3890.2 3915.8 53955.2 55062.4 55841.7 55949.7 56314.7 10710.2 10727.5 10943.3 10948.0 11357.8 18670.3 18717.3 18845.0 18867.6 18875.7 7603.5 7704.0 7740.2 7753.4 7853.5 4363.9 4398.1 4477.9 4496.1 4559.1 3222.6 3232.8 3247.5 3268.9 3286.5 574.6 577.1 584.5 588.2 675.1 713.2 719.2 760.1 763.4 794.2 9629.1 9905.1 10027.5 10034.9 10042.2 693.8 752.8 756.5 769.6 788.7 4466.8 4687.2 4744.4 4770.4 4810.4 61438.4 61882.7 62017.7 62104.0 62733.0 55275.7 56217.2 56580.0 57061.4 57249.0 47874.0 48195.8 48272.8 48873.0 49794.3 10205.1 10213.2 10230.3 10257.0 10273.8 37582.0 37782.8 37822.0 37897.6 39476.8 43539.6 46505.8 46711.3 46772.5 47101.3 10709.4 10825.9 11491.5 11549.8 11570.9 12844.2 13178.4 13383.9 13501.9 13887.4 11957.4 12384.9 12517.3 12861.2 13170.8 11628.7 11966.5 12331.4 12543.6 12744.9 12203.8 12447.4 12548.4 12910.3 13008.9 9874.4 9912.2 9953.4 10237.5 10630.2 10771.7 10973.6 11143.7 11156.3 11505.3 04:35:33 INFO - PROCESS | 5043 | -------- Summary: end -------- 04:35:33 INFO - PROCESS | 5043 | 04:35:34 INFO - TEST-INFO | 5043: exit 0 04:35:34 INFO - TEST-OK | dromaeo_css | took 1111484ms 04:35:34 INFO - TEST-START | kraken 04:35:34 INFO - operating with platform_type : linux_ 04:35:34 INFO - Initialising browser for kraken test... 04:35:34 INFO - TEST-INFO | started process 5225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxwz3hA/profile http://localhost:44786/getInfo.html) 04:35:38 INFO - PROCESS | 5225 | __metrics Screen width/height:1600/1200 04:35:38 INFO - PROCESS | 5225 | colorDepth:24 04:35:38 INFO - PROCESS | 5225 | Browser inner width/height: 1024/697 04:35:38 INFO - PROCESS | 5225 | __metrics 04:35:38 ERROR - PROCESS | 5225 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:35:38 INFO - PROCESS | 5225 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:35:39 INFO - TEST-INFO | 5225: exit 0 04:35:39 INFO - Browser initialized. 04:35:39 INFO - Running cycle 1/1 for kraken test... 04:35:39 INFO - TEST-INFO | started process 5309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxwz3hA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:51 INFO - PROCESS | 5309 | RSS: Main: 155951104 04:35:51 INFO - PROCESS | 5309 | 04:35:53 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44786/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:54 INFO - PROCESS | 5309 | RSS: Main: 196915200 04:35:54 INFO - PROCESS | 5309 | 04:35:57 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44786/tests/kraken/driver.html?testName=audio-dft) 04:35:57 INFO - PROCESS | 5309 | RSS: Main: 186322944 04:35:57 INFO - PROCESS | 5309 | 04:36:00 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44786/tests/kraken/driver.html?testName=audio-fft) 04:36:01 INFO - PROCESS | 5309 | RSS: Main: 171118592 04:36:01 INFO - PROCESS | 5309 | 04:36:03 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44786/tests/kraken/driver.html?testName=audio-oscillator) 04:36:03 INFO - PROCESS | 5309 | RSS: Main: 173035520 04:36:03 INFO - PROCESS | 5309 | 04:36:05 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:36:06 INFO - PROCESS | 5309 | RSS: Main: 174657536 04:36:06 INFO - PROCESS | 5309 | 04:36:09 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44786/tests/kraken/driver.html?testName=imaging-darkroom) 04:36:10 INFO - PROCESS | 5309 | RSS: Main: 174403584 04:36:10 INFO - PROCESS | 5309 | 04:36:13 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44786/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:13 INFO - PROCESS | 5309 | RSS: Main: 175828992 04:36:13 INFO - PROCESS | 5309 | 04:36:16 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44786/tests/kraken/driver.html?testName=json-parse-financial) 04:36:17 INFO - PROCESS | 5309 | RSS: Main: 177152000 04:36:17 INFO - PROCESS | 5309 | 04:36:18 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:19 INFO - PROCESS | 5309 | RSS: Main: 187338752 04:36:19 INFO - PROCESS | 5309 | 04:36:21 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:21 INFO - PROCESS | 5309 | RSS: Main: 184762368 04:36:21 INFO - PROCESS | 5309 | 04:36:23 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:24 INFO - PROCESS | 5309 | RSS: Main: 196517888 04:36:24 INFO - PROCESS | 5309 | 04:36:26 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:27 INFO - PROCESS | 5309 | RSS: Main: 204042240 04:36:27 INFO - PROCESS | 5309 | 04:36:29 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:30 INFO - PROCESS | 5309 | RSS: Main: 202444800 04:36:30 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | Cycle 1(1): loaded http://localhost:44786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44786/tests/kraken/driver.html?testName=ai-astar) 04:36:32 INFO - PROCESS | 5309 | RSS: Main: 263106560 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | __start_tp_report 04:36:32 INFO - PROCESS | 5309 | _x_x_mozilla_page_load 04:36:32 INFO - PROCESS | 5309 | _x_x_mozilla_page_load_details 04:36:32 INFO - PROCESS | 5309 | |i|pagename|runs| 04:36:32 INFO - PROCESS | 5309 | |0;ai-astar;109;109;105;108;109;109;100;108;109;109 04:36:32 INFO - PROCESS | 5309 | |1;audio-beat-detection;149;121;155;171;122;146;151;127;178;130 04:36:32 INFO - PROCESS | 5309 | |2;audio-dft;160;160;160;161;162;162;162;164;161;161 04:36:32 INFO - PROCESS | 5309 | |3;audio-fft;73;72;97;100;70;71;76;111;96;75 04:36:32 INFO - PROCESS | 5309 | |4;audio-oscillator;93;93;136;92;93;93;135;92;93;141 04:36:32 INFO - PROCESS | 5309 | |5;imaging-gaussian-blur;117;117;116;117;117;118;117;117;116;117 04:36:32 INFO - PROCESS | 5309 | |6;imaging-darkroom;146;147;147;145;147;145;146;145;145;145 04:36:32 INFO - PROCESS | 5309 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;96 04:36:32 INFO - PROCESS | 5309 | |8;json-parse-financial;55;56;55;55;55;54;57;65;52;54 04:36:32 INFO - PROCESS | 5309 | |9;json-stringify-tinderbox;59;60;59;60;59;59;59;61;61;60 04:36:32 INFO - PROCESS | 5309 | |10;stanford-crypto-aes;84;79;79;77;77;78;78;78;79;77 04:36:32 INFO - PROCESS | 5309 | |11;stanford-crypto-ccm;116;120;116;108;108;115;112;117;123;122 04:36:32 INFO - PROCESS | 5309 | |12;stanford-crypto-pbkdf2;147;141;143;140;140;130;140;140;145;141 04:36:32 INFO - PROCESS | 5309 | |13;stanford-crypto-sha256-iterative;63;63;61;63;62;63;63;63;63;62 04:36:32 INFO - PROCESS | 5309 | __end_tp_report 04:36:32 INFO - PROCESS | 5309 | __start_cc_report 04:36:32 INFO - PROCESS | 5309 | _x_x_mozilla_cycle_collect,1053 04:36:32 INFO - PROCESS | 5309 | __end_cc_report 04:36:32 INFO - PROCESS | 5309 | __startTimestamp1458646592335__endTimestamp 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | ------- Summary: start ------- 04:36:32 INFO - PROCESS | 5309 | Number of tests: 14 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:2.92 (2.7%) stddev-sans-first:3.04 04:36:32 INFO - PROCESS | 5309 | Values: 109.0 109.0 105.0 108.0 109.0 109.0 100.0 108.0 109.0 109.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:150.00 stddev:19.92 (13.3%) stddev-sans-first:21.08 04:36:32 INFO - PROCESS | 5309 | Values: 149.0 121.0 155.0 171.0 122.0 146.0 151.0 127.0 178.0 130.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 04:36:32 INFO - PROCESS | 5309 | Values: 160.0 160.0 160.0 161.0 162.0 162.0 162.0 164.0 161.0 161.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#3] audio-fft Cycles:10 Average:84.10 Median:74.00 stddev:15.18 (20.5%) stddev-sans-first:15.56 04:36:32 INFO - PROCESS | 5309 | Values: 73.0 72.0 97.0 100.0 70.0 71.0 76.0 111.0 96.0 75.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.61 (23.2%) stddev-sans-first:22.39 04:36:32 INFO - PROCESS | 5309 | Values: 93.0 93.0 136.0 92.0 93.0 93.0 135.0 92.0 93.0 141.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:36:32 INFO - PROCESS | 5309 | Values: 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 04:36:32 INFO - PROCESS | 5309 | Values: 146.0 147.0 147.0 145.0 147.0 145.0 146.0 145.0 145.0 145.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:36:32 INFO - PROCESS | 5309 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.49 (6.3%) stddev-sans-first:3.69 04:36:32 INFO - PROCESS | 5309 | Values: 55.0 56.0 55.0 55.0 55.0 54.0 57.0 65.0 52.0 54.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 04:36:32 INFO - PROCESS | 5309 | Values: 59.0 60.0 59.0 60.0 59.0 59.0 59.0 61.0 61.0 60.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.50 stddev:2.07 (2.6%) stddev-sans-first:0.87 04:36:32 INFO - PROCESS | 5309 | Values: 84.0 79.0 79.0 77.0 77.0 78.0 78.0 78.0 79.0 77.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:116.50 stddev:5.23 (4.5%) stddev-sans-first:5.55 04:36:32 INFO - PROCESS | 5309 | Values: 116.0 120.0 116.0 108.0 108.0 115.0 112.0 117.0 123.0 122.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.70 Median:141.00 stddev:4.47 (3.2%) stddev-sans-first:4.12 04:36:32 INFO - PROCESS | 5309 | Values: 147.0 141.0 143.0 140.0 140.0 130.0 140.0 140.0 145.0 141.0 04:36:32 INFO - PROCESS | 5309 | 04:36:32 INFO - PROCESS | 5309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 04:36:32 INFO - PROCESS | 5309 | Values: 63.0 63.0 61.0 63.0 62.0 63.0 63.0 63.0 63.0 62.0 04:36:32 INFO - PROCESS | 5309 | -------- Summary: end -------- 04:36:32 INFO - PROCESS | 5309 | 04:36:33 INFO - TEST-INFO | 5309: exit 0 04:36:33 INFO - TEST-OK | kraken | took 59239ms 04:36:33 INFO - SUITE-END | took 1170s 04:36:33 INFO - Completed test suite (00:19:30) 04:36:33 INFO - javascript benchmark 04:36:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3003.5494675798627, 3028.273214428538, 3092.5051991681335, 3101.5812865263183, 3122.266267427155, 5174.835661976053, 5182.807954170543, 5243.711595862231, 5254.080535906215, 5289.629725919178, 5309.761060752266, 5318.893622127555, 5362.249285100089, 5374.838754837351, 5375.784968601261, 4653.7440440775745, 4701.012787314677, 4795.040991801636, 4850.175470170079, 4883.413990321166, 4685.36747539083, 4818.759062046901, 4843.854684359475, 4884.560389564938, 4901.387326584177, 4737.407824021997, 4763.190257656172, 4766.499517550642, 4809.639277054217, 4813.855584332476, 4644.4658864230705, 4653.371794807692, 4671.69633973794, 4673.299005149221, 4706.552877476668, 4648.976755116203, 4672.0, 4677.836275730333, 4731.976340118312, 4780.330753694486, 5235.816746413895, 5245.423003469616, 5258.684478931276, 5278.208268759717, 5298.046351656701, 5659.320881494205, 5660.2075709400715, 5661.122526008476, 5661.745221465044, 5663.235463212455, 5504.91742623861, 5683.0, 5685.687287199244, 5686.0617998030275, 5777.62445441045, 5366.087765079946, 5371.516563509224, 5380.892382152335, 5421.512063914267, 5430.782768689248, 5859.472647461749, 5860.208871802252, 5862.677552734641, 5864.67744274069, 5865.384134665798, 5477.260569823023, 5484.725763711878, 5564.33228012641, 5576.219329293902, 5635.436456354414, 5701.543876489871, 5707.486326230659, 5710.828675139753, 5712.6286791358425, 5715.514181294553, 5692.57305702074, 5694.402087780806, 5696.174054762037, 5696.430356964353, 5702.429757024347, 5469.671819690831, 5658.717064146858, 5727.31272247333, 5744.310682718101, 5788.392218817048, 4288.957110428918, 4300.247456695129, 4302.204092242945, 4308.202982448257, 4348.652107831366, 3817.9809100954317, 3841.9231615367535, 3854.9229015419533, 3879.0690234343556, 3895.4351619015083, 5273.709945952933, 5286.524212820865, 5307.575393968474, 5312.681239125664, 5333.57331413486, 5652.123920792284, 5690.487856092972, 5691.089425691869, 5692.516136128393, 5713.0, 5280.973595132076, 5371.086915224421, 5377.892442151135, 5379.435159308295, 5436.401995780461, 4820.180569303227, 4837.346958160673, 4839.104765618372, 4866.853994380174, 4870.805167793319, 5737.08206686928, 5759.1937128802, 5790.94209057904, 5803.912941305884, 5808.448197421239, 5455.0726376515295, 5517.117261238182, 5540.445955404427, 5579.637323573955, 5720.3421606515785, 5928.081147422156, 5940.821775346746, 5941.465268125889, 5963.0, 5966.612170208922, 5556.361018482926, 5614.691191984317, 5615.157726341082, 5615.7192140392, 5616.69108199053, 5524.281843360337, 5668.716564171693, 5695.088785794253, 5703.600747947604, 5788.507976822018, 5576.386597474194, 5578.944210558005, 5581.972090139686, 5583.246261754611, 5600.327960644749, 5490.615656904138, 5520.889582208413, 5521.171824226398, 5548.4174161712435, 5549.0, 5348.171033489815, 5516.14499752539, 5523.199136125159, 5623.943760562505, 5630.774769009194, 5523.364813046391, 5560.332760068818, 5570.025245581925, 5593.300837395325, 5593.776248949996, 5458.8362349128, 5480.561555075664, 5484.972575137099, 5485.862853428696, 5514.641548299348], "unit": "score", "name": "dojo.html", "value": 5215.944529920939}, {"lowerIsBetter": false, "replicates": [539.816462402783, 557.4898967444789, 560.319212157229, 582.7872826418358, 594.417470878539, 39877.2024559509, 40630.39054414179, 40630.7968460158, 40643.18713625729, 40683.38974915379, 42271.0, 42671.0, 42725.35911961323, 42743.78628106863, 42823.78588107063, 8613.224809767135, 8791.252743516809, 8794.384393092487, 8800.427972181787, 8803.691870784523, 8621.094785047573, 8718.520481373522, 8730.432521886089, 8730.476171429702, 8731.781705457382, 8929.464232146092, 8997.100289971017, 9007.684731034415, 9009.144131307516, 9009.729708108767, 8874.378793484459, 8942.15049570293, 8942.86585701215, 8956.820863582692, 8960.551972401354, 8825.338099642553, 8928.508932008737, 8940.0, 8942.374033817636, 8947.150020748084, 41052.79473602613, 41267.0, 41404.1719165618, 41420.79289603563, 41541.58458415407, 2003.5892642008353, 3485.721142308609, 3562.358775420423, 4226.5139508956245, 4273.87178384649, 29643.85178074096, 30015.0, 30190.24524386886, 30814.075577732703, 32190.19524511906, 3974.960250397488, 4123.8969025774595, 4126.834926602933, 4142.0680346922, 4249.022724773288, 333430.0, 333528.0, 335702.0, 336824.99999999756, 336887.0, 58861.0, 58888.11667824986, 59214.70392648009, 59429.70285148547, 59523.70238148781, 57237.71381143068, 68221.31778682249, 69184.65407672929, 69202.0, 69495.0, 16321.34714611426, 16399.344026238818, 16520.256588453547, 16521.66956660884, 16530.421435249707, 11579.363135027486, 11581.363025033705, 11585.884141158649, 11659.358735269472, 11691.88308116925, 20639.484012899797, 20948.790512094685, 20978.84616346085, 21231.893840530698, 21945.890270548865, 7954.323882470055, 8128.9187108129345, 8231.711890083818, 8328.250457458858, 8378.49729016261, 957.5355952363099, 988.2489308125876, 1146.4325159046325, 1167.573835550035, 1206.1737709668905, 32328.19179520484, 32434.675653243637, 32452.513212301834, 32857.0, 33405.498917516255, 1132.9320240785414, 1145.1583086431467, 1164.1443538998828, 1233.5744168261936, 1244.7012716948047, 16506.83493165077, 16910.577235568962, 16930.0, 16957.0, 17178.570535736708, 367518.0, 367762.0, 370956.0, 371587.0, 371701.0, 56608.43391566114, 57203.0, 57823.710881445324, 57873.710631447415, 57920.420795791506, 1043.5147656339839, 1268.0806415348798, 1306.4447609765812, 1388.0908005256574, 1433.7634290342185, 29001.56497652579, 30319.0, 30420.0, 30828.22929426782, 30924.536131958488, 40775.59224407718, 52153.47846521486, 52856.20715689345, 52918.735406322725, 52930.0, 266805.0, 271020.0, 271549.0, 271957.0, 272708.0, 38875.6112438872, 39661.80169099136, 45177.77411113055, 45860.0, 48182.27726584174, 45981.77009114933, 46370.53629463797, 46596.30105548352, 46923.53076469192, 47655.76172119117, 41564.58435415607, 42140.78929605455, 42648.78675606602, 42932.35601466043, 43554.34668480039, 42178.578214217465, 42627.57372426236, 42688.65691721367, 42692.78653606712, 42737.786311068245, 45144.77427612841, 45323.09353812971, 45451.54548454473, 45937.540624594665, 46272.30591541062, 38951.6104838948, 38991.6100838988, 39441.0, 40995.590044099175, 42367.0, 32703.836480817445, 33489.0, 33669.83165084159, 34183.658163419044, 34529.654703452645], "unit": "score", "name": "ext.html", "value": 20080.840949614365}, {"lowerIsBetter": false, "replicates": [379.6867584243, 380.4806439210478, 381.4488064746442, 382.3480964954751, 385.7280617164899, 17435.738463923037, 18257.908710456446, 19155.233790648374, 19559.70660440091, 19577.51056223595, 17520.299188032463, 17638.559036024108, 18210.908945455256, 18228.362007329713, 18255.726164107517, 5133.922991155136, 5260.421353651095, 5296.576273898079, 5299.311089558352, 5302.920456193141, 3790.8294126764363, 5263.526282634562, 5593.468620481048, 5841.591088623777, 5860.882782344351, 5795.1017592273265, 5840.474357307841, 5855.79504717335, 5858.677772722499, 5860.501857342131, 5486.753096110665, 5710.486056254916, 5713.685747283918, 5716.1425786131995, 5796.30444346679, 3652.76257043294, 5389.514943655051, 5494.423085575997, 5515.393306736256, 5568.888622227532, 12825.0, 13125.409356578977, 13226.272555009471, 13267.137636053625, 13295.20228786276, 2259.604569200383, 2422.733499315074, 2815.183596756938, 2837.3757773289844, 2958.2604348912773, 9181.586828592663, 9619.807603847954, 9878.407295562289, 10040.146587540068, 10108.837483689396, 1992.22303301711, 2072.585482903425, 2166.945826354354, 2199.7580266170708, 2293.0598454633687, 68275.65862170707, 68652.6567367165, 70417.29582704158, 72515.27484725138, 73545.63227183884, 10716.142708583295, 10906.5092070857, 11055.557777688802, 11256.493457794419, 11277.71805704864, 14495.275236238145, 14534.85465145335, 14684.853151468562, 14798.260086995608, 14822.110673359633, 7998.200179981955, 8078.757637270891, 8088.4742491739025, 8212.876806847902, 8236.258736713604, 7925.643346049442, 8094.231048050426, 8219.095899451055, 8367.707130250412, 8393.0, 4819.734914579662, 4845.055214233191, 4848.3454733610515, 4858.902821943541, 4931.580815630711, 1815.4372144635206, 1907.7996810334714, 1925.1336898395778, 1949.0547084663926, 1996.3212507747435, 978.6623614852864, 981.239539357004, 981.8379967305458, 1029.433811403725, 1065.893410658928, 17462.738058929128, 17527.561810954827, 17641.206145723474, 17691.73462398065, 17917.19372628235, 1023.3399457349967, 1026.2816028779735, 1034.6585626743156, 1035.1304903880775, 1097.2209731091016, 9976.700698979042, 10651.627193048205, 10711.357318560755, 10759.462026898624, 10808.459577021118, 430694.0, 440003.0, 446460.0, 447628.0, 447645.0, 73990.0, 77016.22983770202, 79090.20909790829, 82490.58754706188, 86653.0, 488.4919683529161, 501.7541404711738, 504.8031267805559, 504.8207886200419, 505.24970418927865, 10285.228607854291, 10485.633002844865, 10877.728056798644, 11000.614978475714, 11162.720931976766, 26380.4723905517, 36618.63381366152, 36659.252780207426, 36989.63010369862, 37072.0, 52509.737451312496, 53212.46787532075, 53320.20019699785, 53619.731901340245, 54519.45480545144, 8125.228103330174, 8161.591920403837, 8414.0, 8512.97844258693, 8546.658133674584, 8897.866532001895, 10401.58393664245, 11418.714532136763, 12121.0, 13336.866631333562, 11058.502367393326, 11323.094152467947, 11335.829962550404, 11642.708932276422, 11771.705707357041, 11191.888081119085, 11245.606403775828, 11280.928311810365, 11286.097112230838, 11383.089352851586, 11151.609693661008, 11511.0, 11765.882341176479, 11899.583514576949, 12032.398380081137, 7904.0, 8080.71717489885, 8273.83452330962, 8560.828783424173, 8619.396642234984, 10523.631672891412, 10741.946290268812, 11001.724956876142, 11140.220184587326, 11393.886061139283], "unit": "score", "name": "jquery.html", "value": 8496.737233122527}, {"lowerIsBetter": false, "replicates": [1321.128055483381, 1453.5058080252716, 1480.7408703476892, 1650.537849402168, 1823.1431227323162, 7712.614369281535, 7882.645280962356, 7919.881201781971, 7934.365250779938, 7961.920380796198, 7819.960900195505, 7965.44241903067, 7968.840623187532, 7973.641186146623, 7974.362051035918, 2005.1979208316643, 2256.187772401934, 2273.9090436382608, 2283.4177284792436, 2346.530693861226, 2351.9176828810996, 2356.893939772706, 2360.752121027293, 2361.2207971369494, 2363.8463499872455, 2248.415411992877, 2289.622212334971, 2294.942626434344, 2295.6326987681973, 2296.3799774060994, 2283.5090455552054, 2303.735070466901, 2337.801286890616, 2356.5051339218785, 2358.587247231736, 2310.110607416157, 2314.8148148148107, 2316.1661801751357, 2343.8593684378993, 2355.8350915435926, 7980.241877021674, 8028.638711258008, 8051.59742012897, 8053.557054362008, 8061.717839875576, 4798.208295631217, 4901.8774530636665, 4907.288443175756, 4940.25896115582, 4955.752212389366, 3045.817250964927, 3135.827529485877, 3181.3796309719614, 3227.596550431196, 3237.7086062254275, 1042.5517027678095, 1062.0282441566035, 1085.567051492031, 1123.859517560305, 1134.9489272982735, 11213.10295176384, 11379.487923043484, 11405.771884562262, 11417.42912854354, 11438.828417573743, 4322.200392927319, 4338.0890013097605, 4388.539203383599, 4410.911781764346, 4428.2914733642465, 9624.75938101553, 9626.807463850684, 9639.0, 9644.18024467914, 9649.986751391003, 4333.501647310537, 4959.7272150032095, 4973.05511952735, 4983.302337672729, 4987.650864439527, 4417.977910110493, 4478.619317358061, 4504.346869703874, 4508.346289787963, 4533.0, 3810.2760475509563, 3862.0537968197973, 3875.7093218008763, 3908.179282350681, 3944.8619298324993, 1208.350601429043, 1227.8281040654315, 1229.1211783574608, 1233.890595698834, 1243.160866415166, 1339.1295657822493, 1351.1555277951281, 1373.3613869550707, 1382.9031967762362, 1383.5918404070824, 7729.768106956801, 7837.568933708701, 7863.37093032556, 7889.605519723991, 7891.289783919475, 473.78679594182756, 473.9715617062987, 476.81404252341616, 482.4909720245105, 484.4066019126542, 5959.0, 5965.254343207099, 5984.461398474158, 6032.065029920369, 6033.637981721111, 9321.207697345666, 9798.0, 9822.066903644143, 9890.752731181778, 9890.950545247228, 9685.9031409685, 9696.709098726908, 9701.07839755222, 9752.21982241419, 9759.12167904892, 7357.59533225667, 7623.085229772463, 7681.116671582728, 7696.4227682924, 7699.846003079907, 7225.349718525358, 7301.780946571611, 7305.926940730737, 7322.2677732228485, 7385.630718463948, 8440.451370660887, 8645.740627781177, 8754.0, 8766.91233087661, 8907.554622268732, 8727.65089396417, 8772.342074344577, 8895.4662720237, 8909.955450222968, 8924.286057115285, 6336.841578960379, 6559.704813283318, 6742.224644165984, 6965.965170174117, 7070.787876363717, 7298.96350518244, 7322.524035937647, 7328.267173282629, 7370.262973702587, 7379.409647228316, 6390.712417941111, 6652.869012268023, 6665.933340666531, 6714.496412769159, 6810.693518791765, 6542.149520562297, 6546.443552298108, 6620.3710647488415, 6644.468442524683, 6700.698468569024, 7314.634268286458, 7326.3406293433845, 7350.852982940204, 7354.264573542603, 7363.8159046024275, 6365.045243213555, 6429.421352078335, 6430.549861509649, 6435.935640643721, 6440.355964403522, 6636.966815165893, 6645.60126392418, 6660.966695166493, 6661.566998145299, 6667.766628167991], "unit": "score", "name": "mootools.html", "value": 4512.886140888733}, {"lowerIsBetter": false, "replicates": [344.9137715571107, 345.0786400311169, 345.123386598041, 348.54166770696526, 353.5651149086625, 5870.765169393219, 5911.20198773165, 5927.525797936166, 5927.73325200366, 5933.169356290123, 5806.1000544915605, 5833.620814647055, 5861.032929566627, 5869.090291004901, 5900.586958912878, 4311.6335111515555, 4417.580329868657, 4502.0545685406105, 4536.274196128612, 4552.795124219418, 4530.728156310632, 4533.387992621004, 4543.250363689987, 4546.045330480603, 4548.317752337143, 4485.506594274627, 4494.550544945496, 4495.0, 4496.910061798762, 4504.1892459357305, 4285.892852678692, 4390.253656878338, 4482.148391805546, 4483.574060464251, 4485.573870482299, 3964.207158568298, 3964.3657014877767, 3967.0, 3970.166265084336, 3972.245273398045, 5674.0, 5678.176664383683, 5682.801101961411, 5690.174924635946, 5695.5443564514735, 5268.657537260104, 5271.947280527184, 5282.418933917266, 5286.365636123652, 5291.047611429941, 6204.6587437690905, 6205.410486003822, 6212.502999760053, 6217.502599792051, 6221.813345599594, 4390.012247244376, 4456.554344565518, 4462.531434199394, 4478.104379124188, 4492.775361231926, 6372.968135159341, 6503.154589903283, 6520.608763474207, 6523.93476065238, 6531.673416329165, 4606.792694328763, 4607.101615185074, 4608.861734147981, 4609.492955774862, 4614.0310534787395, 4662.860114196579, 4663.743494107856, 4664.486906440289, 4666.626669866402, 4668.486466488684, 5309.814156504503, 5310.468953104659, 5317.2024196370085, 5319.361676598833, 5323.068463018956, 6152.753889844356, 6296.275928268216, 6296.496280297565, 6314.9684251579365, 6315.684215789192, 1633.991830040866, 1639.0821140161547, 1650.1584192062135, 1651.719207734688, 1656.155360765994, 1023.1814548361281, 1116.0792346314324, 1117.050507069001, 1120.7086157599083, 1149.672343382132, 5933.762649494059, 5957.731902064417, 5974.253218347707, 5990.341062483123, 5997.940020599738, 6330.873382532323, 6378.202724659418, 6406.423421891959, 6408.807735767934, 6409.967950160312, 5949.9107513387335, 5950.375210602911, 5954.642721436728, 5955.34491205967, 5956.374580669054, 3391.406503861814, 3414.2830005698584, 3421.674940880612, 3432.639572844865, 3441.5525981622227, 6467.306050316706, 6517.641529715816, 6594.934050659528, 6599.53803233769, 6606.339366063451, 6473.741050358027, 6474.967625161844, 6517.934820651828, 6526.64103474304, 6527.02094685801, 6540.247871494744, 6542.705578248991, 6550.443212326911, 6556.606603603799, 6559.934400655932, 6364.299927008118, 6391.2330520337855, 6394.296627371078, 6417.614943103242, 6431.549791514736, 6275.184226050585, 6290.622562646256, 6292.653904035139, 6301.991681330965, 6328.525360597881, 6717.16035495563, 6761.797146085625, 6774.187097548326, 6789.660516974032, 6796.796096117125, 4366.170427618742, 4393.121375724804, 4396.472423309224, 4406.2289099406835, 4410.051838854662, 6522.315156908457, 6525.412712855866, 6527.967360163168, 6535.803925882231, 6538.346165383614, 6332.176817013943, 6336.556441049082, 6351.110844481684, 6351.428371446592, 6354.3963323484195, 6077.969610151921, 6304.211973503312, 6308.148399965946, 6316.305206427198, 6356.141920840627, 6153.784617538365, 6157.876842463215, 6184.536159787944, 6191.4118158774845, 6218.689065546614, 6313.979526551643, 6320.5575609706875, 6337.651429171256, 6338.11266422692, 6348.873022539616, 5924.0, 6058.151858739692, 6152.0, 6197.597156184834, 6202.193714817045], "unit": "score", "name": "prototype.html", "value": 4744.006520021431}, {"lowerIsBetter": false, "replicates": [757.257887270475, 785.1598789295456, 827.3835992185826, 867.1025488619279, 873.9169778871009, 12658.936705316471, 12683.0, 12745.0, 12770.744585108292, 12858.871411285885, 11754.706132346695, 12437.502499899992, 12438.564650237244, 12441.564545240919, 12457.0, 650.8600650860064, 801.6312496251732, 816.4121832280748, 824.814416756231, 832.5629044751494, 828.1304630138361, 832.4797001873828, 833.9958300208491, 835.2983493865152, 837.5351679817699, 868.1882439918664, 871.4117970370006, 871.4727589808169, 872.0233338660677, 872.1888643561485, 669.8024082895533, 858.1118542308711, 873.2926329672954, 875.9605817738217, 883.6509578716435, 641.0960545630638, 643.5623775832432, 643.6363454648156, 643.6459947029163, 643.8969764837603, 11770.058395328353, 11814.645560633195, 11819.586314478953, 11822.172447928648, 11826.290422574588, 13149.0, 13336.0, 13352.86647133526, 13897.652558686013, 13918.721625567534, 12190.268583884996, 12388.31864247466, 12574.0, 12608.306543140123, 12807.167534110253, 3801.600831912637, 3829.7319187656876, 3856.325143099946, 3890.2414029264305, 3915.804209789499, 53955.19067214034, 55062.39251289831, 55841.72079139578, 55949.72025139848, 56314.718426407606, 10710.196735244888, 10727.463626818628, 10943.343399395902, 10948.0, 11357.772844543062, 18670.253189872525, 18717.344892928682, 18845.0, 18867.622647547247, 18875.716864247046, 7603.543787372775, 7703.961480192564, 7740.225977402328, 7753.379729621617, 7853.489523180975, 4363.912721745547, 4398.142362239332, 4477.9100423424115, 4496.145732310851, 4559.065391594715, 3222.5971753530807, 3232.8060316381093, 3247.5291082792864, 3268.8692452302116, 3286.5070239463794, 574.6465923457127, 577.0882006429831, 584.5382148103037, 588.2206076948061, 675.1189697444881, 713.1905287498727, 719.1873183302835, 760.1144666463618, 763.3892885691536, 794.213728408871, 9629.133377995873, 9905.10854023127, 10027.498625068863, 10034.899651003543, 10042.19662427004, 693.836948317145, 752.766642340876, 756.4969295418595, 769.5844244108118, 788.6884680551265, 4466.843660471868, 4687.156311863897, 4744.383230180055, 4770.379850619397, 4810.4467986182035, 61438.38561614326, 61882.69058654768, 62017.68991155105, 62104.0, 62733.0, 55275.72362138244, 56217.15674264889, 56580.0, 57061.42938570644, 57249.0, 47874.0, 48195.795105123354, 48272.7586362073, 48873.0, 49794.25308620374, 10205.13256373187, 10213.182945364502, 10230.28388012832, 10257.0, 10273.845892311472, 37582.0, 37782.81108594439, 37822.0, 37897.62102378941, 39476.80261598789, 43539.56460435355, 46505.76747116378, 46711.29933050939, 46772.532274676814, 47101.29348059713, 10709.357438553712, 10825.945870270598, 11491.54033838637, 11549.805536947953, 11570.94214528922, 12844.229346239255, 13178.406971686489, 13383.933080334536, 13501.932490337485, 13887.444502219798, 11957.402129893644, 12384.938075309567, 12517.311547864954, 12861.164024338388, 13170.80243796363, 11628.709282267673, 11966.521339146684, 12331.383430828244, 12543.56097536582, 12744.936275318563, 12203.75592488163, 12447.377631118588, 12548.372581370711, 12910.289934053717, 13008.934955325163, 9874.358166719141, 9912.15746661513, 9953.353032052893, 10237.488125593542, 10630.202734794766, 10771.676849694522, 10973.615923442641, 11143.662760468796, 11156.274842135235, 11505.309681419141], "unit": "score", "name": "yui.html", "value": 6723.180260134199}], "name": "dromaeo_css", "value": 7100.089179785086}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 108.0, 109.0, 109.0, 100.0, 108.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 155.0, 171.0, 122.0, 146.0, 151.0, 127.0, 178.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 162.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 97.0, 100.0, 70.0, 71.0, 76.0, 111.0, 96.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 92.0, 93.0, 93.0, 135.0, 92.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 145.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 54.0, 57.0, 65.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0, 61.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.7}, {"lowerIsBetter": true, "replicates": [84.0, 79.0, 79.0, 77.0, 77.0, 78.0, 78.0, 78.0, 79.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.6}, {"lowerIsBetter": true, "replicates": [116.0, 120.0, 116.0, 108.0, 108.0, 115.0, 112.0, 117.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [147.0, 141.0, 143.0, 140.0, 140.0, 130.0, 140.0, 140.0, 145.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 61.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 62.6}], "name": "kraken", "value": 1475.1}]} 04:36:33 INFO - Return code: 0 04:36:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:33 ERROR - # TBPL SUCCESS # 04:36:33 INFO - Running post-action listener: _resource_record_post_action 04:36:33 INFO - Running post-run listener: _resource_record_post_run 04:36:34 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 2883584; Write bytes: 297054208; Read time: 1664; Write time: 145064 04:36:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 8843264; Read time: 0; Write time: 1128 04:36:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 2846720; Write bytes: 275607552; Read time: 1624; Write time: 141768 04:36:34 INFO - Running post-run listener: _upload_blobber_files 04:36:34 INFO - Blob upload gear active. 04:36:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:36:34 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 04:36:34 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'] 04:36:34 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 04:36:35 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:37 INFO - (blobuploader) - INFO - Done attempting. 04:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:38 INFO - (blobuploader) - INFO - Done attempting. 04:36:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:38 INFO - Return code: 0 04:36:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:36:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d6758841c9a14e7b5a5178eda857ba2055feda000608de011712d340da79cf7ee3102fa13a277264725a76e42e1ed7f2b0d8f62c24b85055cd34e1a931fca5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc126a22785528d57ae1c8de708f6d91a1afdf3d2a05d03456cab2eda843cdd9dac98ca59951a18e2c7014c28e5d8f268abf538eb7e24d52cb59ecb01bcd11a5"} 04:36:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:36:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:36:38 INFO - Contents: 04:36:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d6758841c9a14e7b5a5178eda857ba2055feda000608de011712d340da79cf7ee3102fa13a277264725a76e42e1ed7f2b0d8f62c24b85055cd34e1a931fca5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc126a22785528d57ae1c8de708f6d91a1afdf3d2a05d03456cab2eda843cdd9dac98ca59951a18e2c7014c28e5d8f268abf538eb7e24d52cb59ecb01bcd11a5"} 04:36:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:38 INFO - Copying logs to upload dir... 04:36:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:36:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.771907 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-03-22 04:36:38.528346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 04:36:38.531311) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d6758841c9a14e7b5a5178eda857ba2055feda000608de011712d340da79cf7ee3102fa13a277264725a76e42e1ed7f2b0d8f62c24b85055cd34e1a931fca5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc126a22785528d57ae1c8de708f6d91a1afdf3d2a05d03456cab2eda843cdd9dac98ca59951a18e2c7014c28e5d8f268abf538eb7e24d52cb59ecb01bcd11a5"} build_url:https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/SnTuk4v4ShGKo28CWY8m4Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22d6758841c9a14e7b5a5178eda857ba2055feda000608de011712d340da79cf7ee3102fa13a277264725a76e42e1ed7f2b0d8f62c24b85055cd34e1a931fca5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc126a22785528d57ae1c8de708f6d91a1afdf3d2a05d03456cab2eda843cdd9dac98ca59951a18e2c7014c28e5d8f268abf538eb7e24d52cb59ecb01bcd11a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-22 04:36:38.555291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:36:38.555573) ========= 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=1f5564757af27664ca02d71f000001b0-1458645169.380038-226479894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-22 04:36:38.637773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 04:36:38.638087) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-22 04:36:38.638355) ========= ========= Total master_lag: 0.29 =========