builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-027 starttime: 1456319584.95 results: success (0) buildid: 20160224023048 builduid: 5052a107f0d943c09002c35bb3d00161 revision: ba186717174aec9677487aa47caa84fc1430e334 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:04.950919) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:04.951382) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:04.951666) ========= 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008452 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.025414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.025717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.050017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.050376) ========= 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027136 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.097360) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.097655) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.097997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.098282) ========= 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 05:13:05-- 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% 8.52M=0.001s 2016-02-24 05:13:05 (8.52 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.280211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.280538) ========= 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.164161 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:05.454022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 05:13:05.454388) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba186717174aec9677487aa47caa84fc1430e334 --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 ba186717174aec9677487aa47caa84fc1430e334 --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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 05:13:05,501 truncating revision to first 12 chars 2016-02-24 05:13:05,501 Setting DEBUG logging. 2016-02-24 05:13:05,501 attempt 1/10 2016-02-24 05:13:05,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba186717174a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 05:13:08,386 unpacking tar archive at: fx-team-ba186717174a/testing/mozharness/ program finished with exit code 0 elapsedTime=3.201822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-24 05:13:08.671702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:08.672041) ========= echo ba186717174aec9677487aa47caa84fc1430e334 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ba186717174aec9677487aa47caa84fc1430e334'] 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ba186717174aec9677487aa47caa84fc1430e334 program finished with exit code 0 elapsedTime=0.004076 script_repo_revision: 'ba186717174aec9677487aa47caa84fc1430e334' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:08.720499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:08.720774) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 05:13:08.730546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-24 05:13:08.730810) ========= /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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:13:08 INFO - MultiFileLogger online at 20160224 05:13:08 in /builds/slave/test-pgo 05:13:08 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 05:13:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:13:08 INFO - {'append_to_log': False, 05:13:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:13:08 INFO - 'blob_upload_branch': 'Fx-Team', 05:13:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:13:08 INFO - 'branch': 'Fx-Team', 05:13:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:08 INFO - 'config_files': ('talos/linux_config.py',), 05:13:08 INFO - 'default_actions': ('clobber', 05:13:08 INFO - 'read-buildbot-config', 05:13:08 INFO - 'download-and-extract', 05:13:08 INFO - 'populate-webroot', 05:13:08 INFO - 'create-virtualenv', 05:13:08 INFO - 'install', 05:13:08 INFO - 'run-tests'), 05:13:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:08 INFO - 'download_minidump_stackwalk': True, 05:13:08 INFO - 'download_symbols': 'ondemand', 05:13:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:08 INFO - 'installer_path': 'installer.exe', 05:13:08 INFO - 'log_level': 'info', 05:13:08 INFO - 'log_name': 'talos', 05:13:08 INFO - 'log_to_console': True, 05:13:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:13:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:13:08 INFO - 'opt_config_files': (), 05:13:08 INFO - 'pip_index': False, 05:13:08 INFO - 'sps_profile': False, 05:13:08 INFO - 'sps_profile_interval': 0, 05:13:08 INFO - 'suite': 'dromaeojs', 05:13:08 INFO - 'system_bits': '32', 05:13:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:08 INFO - 'title': 'talos-linux64-ix-027', 05:13:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:08 INFO - 'use_talos_json': True, 05:13:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:13:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:08 INFO - 'work_dir': 'build'} 05:13:08 INFO - ##### 05:13:08 INFO - ##### Running clobber step. 05:13:08 INFO - ##### 05:13:08 INFO - Running pre-action listener: _resource_record_pre_action 05:13:08 INFO - Running main action method: clobber 05:13:08 INFO - rmtree: /builds/slave/test-pgo/build 05:13:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:13:13 INFO - Running post-action listener: _resource_record_post_action 05:13:13 INFO - ##### 05:13:13 INFO - ##### Running read-buildbot-config step. 05:13:13 INFO - ##### 05:13:13 INFO - Running pre-action listener: _resource_record_pre_action 05:13:13 INFO - Running main action method: read_buildbot_config 05:13:13 INFO - Using buildbot properties: 05:13:13 INFO - { 05:13:13 INFO - "project": "", 05:13:13 INFO - "product": "firefox", 05:13:13 INFO - "script_repo_revision": "production", 05:13:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:13:13 INFO - "repository": "", 05:13:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:13:13 INFO - "buildid": "20160224023048", 05:13:13 INFO - "pgo_build": "True", 05:13:13 INFO - "basedir": "/builds/slave/test-pgo", 05:13:13 INFO - "buildnumber": 666, 05:13:13 INFO - "slavename": "talos-linux64-ix-027", 05:13:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:13:13 INFO - "platform": "ubuntu64_hw", 05:13:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:13:13 INFO - "branch": "fx-team", 05:13:13 INFO - "repo_path": "integration/fx-team", 05:13:13 INFO - "revision": "ba186717174aec9677487aa47caa84fc1430e334", 05:13:13 INFO - "stage_platform": "linux64-pgo", 05:13:13 INFO - "builduid": "5052a107f0d943c09002c35bb3d00161", 05:13:13 INFO - "slavebuilddir": "test" 05:13:13 INFO - } 05:13:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:13:13 INFO - Running post-action listener: _resource_record_post_action 05:13:13 INFO - ##### 05:13:13 INFO - ##### Running download-and-extract step. 05:13:13 INFO - ##### 05:13:13 INFO - Running pre-action listener: _resource_record_pre_action 05:13:13 INFO - Running main action method: download_and_extract 05:13:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:13: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')]} 05:13:13 INFO - https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:13:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/test_packages.json 05:13:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/test_packages.json 05:13:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:13:13 INFO - Downloaded 1448 bytes. 05:13:13 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:13:13 INFO - Using the following test package requirements: 05:13:13 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:13:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:13:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'jsshell-linux-x86_64.zip'], 05:13:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:13:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:13:13 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:13:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:13:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:13:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:13:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:13:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:13: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')]} 05:13:13 INFO - https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:13:16 INFO - Downloaded 23367241 bytes. 05:13:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:13:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:13:17 INFO - Return code: 0 05:13:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:13:17 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')]} 05:13:17 INFO - https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:13:18 INFO - Downloaded 23367241 bytes. 05:13:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:13:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:13:20 INFO - Return code: 0 05:13:20 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')]} 05:13:20 INFO - https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:13:21 INFO - Downloaded 10707015 bytes. 05:13:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:13:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:13:21 INFO - Return code: 0 05:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:21 INFO - https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:13:22 INFO - Downloaded 56663237 bytes. 05:13:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:13:22 INFO - mkdir: /builds/slave/test-pgo/properties 05:13:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:13:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:13:22 INFO - Contents: 05:13:22 INFO - build_url:https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:13:23 INFO - Running post-action listener: _resource_record_post_action 05:13:23 INFO - Running post-action listener: set_extra_try_arguments 05:13:23 INFO - ##### 05:13:23 INFO - ##### Running populate-webroot step. 05:13:23 INFO - ##### 05:13:23 INFO - Running pre-action listener: _resource_record_pre_action 05:13:23 INFO - Running main action method: populate_webroot 05:13:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:23 INFO - '--tppagecycles', 05:13:23 INFO - '7'], 05:13:23 INFO - 'tests': ['tsvgm']}}, 05:13:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:13:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:13:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'tests': ['damp', 'tps']}, 05:13:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['damp', 'tps']}, 05:13:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:13:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:23 INFO - 'other': {'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'other_l64': {'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'other_nol64': {'tests': ['a11yr', 05:13:23 INFO - 'ts_paint', 05:13:23 INFO - 'tpaint', 05:13:23 INFO - 'sessionrestore', 05:13:23 INFO - 'sessionrestore_no_auto_restore']}, 05:13:23 INFO - 'svgr': {'tests': ['tsvgx', 05:13:23 INFO - 'tsvgr_opacity', 05:13:23 INFO - 'tart', 05:13:23 INFO - 'tscrollx', 05:13:23 INFO - 'cart']}, 05:13:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['tsvgx', 05:13:23 INFO - 'tsvgr_opacity', 05:13:23 INFO - 'tart', 05:13:23 INFO - 'tscrollx', 05:13:23 INFO - 'cart']}, 05:13:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'tests': ['tp5o']}, 05:13:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'talos_options': ['--e10s'], 05:13:23 INFO - 'tests': ['tp5o']}, 05:13:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'talos_options': ['--xperf_path', 05:13:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:23 INFO - 'tests': ['tp5n']}, 05:13:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:13:23 INFO - 'talos_options': ['--e10s', 05:13:23 INFO - '--xperf_path', 05:13:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:23 INFO - 'tests': ['tp5n']}}, 05:13:23 INFO - 'talos.zip': {'path': '', 05:13:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:23 INFO - Running post-action listener: _resource_record_post_action 05:13:23 INFO - ##### 05:13:23 INFO - ##### Running create-virtualenv step. 05:13:23 INFO - ##### 05:13:23 INFO - Running pre-action listener: _resource_record_pre_action 05:13:23 INFO - Running main action method: create_virtualenv 05:13:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:13:23 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 05:13:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:13:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:23 INFO - Using real prefix '/usr' 05:13:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:13:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:26 INFO - Installing pip.................done. 05:13:26 INFO - Return code: 0 05:13:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:26 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 05:13:26 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 05:13:26 INFO - Using env: {'DISPLAY': ':0', 05:13:26 INFO - 'HOME': '/home/cltbld', 05:13:26 INFO - 'LANG': 'en_US.UTF-8', 05:13:26 INFO - 'LANGUAGE': 'en_US:en', 05:13:26 INFO - 'LOGNAME': 'cltbld', 05:13:26 INFO - 'MAIL': '/var/mail/cltbld', 05:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:26 INFO - 'MOZ_NO_REMOTE': '1', 05:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:26 INFO - 'NO_EM_RESTART': '1', 05:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:26 INFO - 'SHELL': '/bin/bash', 05:13:26 INFO - 'SHLVL': '1', 05:13:26 INFO - 'TERM': 'linux', 05:13:26 INFO - 'TMOUT': '86400', 05:13:26 INFO - 'USER': 'cltbld', 05:13:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:26 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 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 05:13:26 INFO - Cleaning up... 05:13:26 INFO - Return code: 0 05:13:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:26 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:26 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 05:13:26 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 05:13:26 INFO - Using env: {'DISPLAY': ':0', 05:13:26 INFO - 'HOME': '/home/cltbld', 05:13:26 INFO - 'LANG': 'en_US.UTF-8', 05:13:26 INFO - 'LANGUAGE': 'en_US:en', 05:13:26 INFO - 'LOGNAME': 'cltbld', 05:13:26 INFO - 'MAIL': '/var/mail/cltbld', 05:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:26 INFO - 'MOZ_NO_REMOTE': '1', 05:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:26 INFO - 'NO_EM_RESTART': '1', 05:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:26 INFO - 'SHELL': '/bin/bash', 05:13:26 INFO - 'SHLVL': '1', 05:13:26 INFO - 'TERM': 'linux', 05:13:26 INFO - 'TMOUT': '86400', 05:13:26 INFO - 'USER': 'cltbld', 05:13:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:26 INFO - '_': '/tools/buildbot/bin/python'} 05:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:26 INFO - Downloading/unpacking psutil>=0.7.1 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:28 INFO - Installing collected packages: psutil 05:13:28 INFO - Running setup.py install for psutil 05:13:28 INFO - building 'psutil._psutil_linux' extension 05:13:28 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 05:13:28 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 05:13:28 INFO - building 'psutil._psutil_posix' extension 05:13:28 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 05:13:29 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 05:13:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:29 INFO - Successfully installed psutil 05:13:29 INFO - Cleaning up... 05:13:29 INFO - Return code: 0 05:13:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:13:29 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')]} 05:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:29 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')]} 05:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:29 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:29 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 05:13:29 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 05:13:29 INFO - Using env: {'DISPLAY': ':0', 05:13:29 INFO - 'HOME': '/home/cltbld', 05:13:29 INFO - 'LANG': 'en_US.UTF-8', 05:13:29 INFO - 'LANGUAGE': 'en_US:en', 05:13:29 INFO - 'LOGNAME': 'cltbld', 05:13:29 INFO - 'MAIL': '/var/mail/cltbld', 05:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:29 INFO - 'MOZ_NO_REMOTE': '1', 05:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:29 INFO - 'NO_EM_RESTART': '1', 05:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:29 INFO - 'SHELL': '/bin/bash', 05:13:29 INFO - 'SHLVL': '1', 05:13:29 INFO - 'TERM': 'linux', 05:13:29 INFO - 'TMOUT': '86400', 05:13:29 INFO - 'USER': 'cltbld', 05:13:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:29 INFO - '_': '/tools/buildbot/bin/python'} 05:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:13:29 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 05:13:29 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 05:13:29 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 05:13:29 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 05:13:29 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 05:13:29 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 05:13:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:13:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:13:31 INFO - Installing collected packages: mozsystemmonitor 05:13:31 INFO - Running setup.py install for mozsystemmonitor 05:13:31 INFO - Successfully installed mozsystemmonitor 05:13:31 INFO - Cleaning up... 05:13:31 INFO - Return code: 0 05:13:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:13:31 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')]} 05:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:31 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')]} 05:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:31 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:31 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 05:13:31 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 05:13:31 INFO - Using env: {'DISPLAY': ':0', 05:13:31 INFO - 'HOME': '/home/cltbld', 05:13:31 INFO - 'LANG': 'en_US.UTF-8', 05:13:31 INFO - 'LANGUAGE': 'en_US:en', 05:13:31 INFO - 'LOGNAME': 'cltbld', 05:13:31 INFO - 'MAIL': '/var/mail/cltbld', 05:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:31 INFO - 'MOZ_NO_REMOTE': '1', 05:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:31 INFO - 'NO_EM_RESTART': '1', 05:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:31 INFO - 'SHELL': '/bin/bash', 05:13:31 INFO - 'SHLVL': '1', 05:13:31 INFO - 'TERM': 'linux', 05:13:31 INFO - 'TMOUT': '86400', 05:13:31 INFO - 'USER': 'cltbld', 05:13:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:31 INFO - '_': '/tools/buildbot/bin/python'} 05:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:31 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 05:13:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:13:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:33 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 05:13:34 INFO - Downloading docopt-0.6.1.tar.gz 05:13:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:34 INFO - Running setup.py install for blobuploader 05:13:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:13:34 INFO - Running setup.py install for requests 05:13:34 INFO - Running setup.py install for docopt 05:13:34 INFO - Successfully installed blobuploader requests docopt 05:13:34 INFO - Cleaning up... 05:13:34 INFO - Return code: 0 05:13:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13:34 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')]} 05:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 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')]} 05:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:34 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:34 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 05:13:34 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 05:13:34 INFO - Using env: {'DISPLAY': ':0', 05:13:34 INFO - 'HOME': '/home/cltbld', 05:13:34 INFO - 'LANG': 'en_US.UTF-8', 05:13:34 INFO - 'LANGUAGE': 'en_US:en', 05:13:34 INFO - 'LOGNAME': 'cltbld', 05:13:34 INFO - 'MAIL': '/var/mail/cltbld', 05:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:34 INFO - 'MOZ_NO_REMOTE': '1', 05:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:34 INFO - 'NO_EM_RESTART': '1', 05:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:34 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:34 INFO - 'SHELL': '/bin/bash', 05:13:34 INFO - 'SHLVL': '1', 05:13:34 INFO - 'TERM': 'linux', 05:13:34 INFO - 'TMOUT': '86400', 05:13:34 INFO - 'USER': 'cltbld', 05:13:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:34 INFO - '_': '/tools/buildbot/bin/python'} 05:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:35 INFO - Running setup.py (path:/tmp/pip-mbXaeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:35 INFO - Running setup.py (path:/tmp/pip-pWE7A3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:35 INFO - Running setup.py (path:/tmp/pip-JHlT7M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:35 INFO - Running setup.py (path:/tmp/pip-QFLPqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:35 INFO - Running setup.py (path:/tmp/pip-EaGpbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:35 INFO - Running setup.py (path:/tmp/pip-t5x1Z9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:35 INFO - Running setup.py (path:/tmp/pip-4Vp_9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:35 INFO - Running setup.py (path:/tmp/pip-b4Uhoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:35 INFO - Running setup.py (path:/tmp/pip-O1_No5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:35 INFO - Running setup.py (path:/tmp/pip-f0lvjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:35 INFO - Running setup.py (path:/tmp/pip-Cx60GY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:35 INFO - Running setup.py (path:/tmp/pip-HXjdmo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:35 INFO - Running setup.py (path:/tmp/pip-7y02wU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:35 INFO - Running setup.py (path:/tmp/pip-IKSS9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:36 INFO - Running setup.py (path:/tmp/pip-1180bD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:36 INFO - Running setup.py (path:/tmp/pip-cmZmx0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:36 INFO - Running setup.py (path:/tmp/pip-8nHuTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:36 INFO - Running setup.py install for manifestparser 05:13:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:13:36 INFO - Running setup.py install for mozcrash 05:13:36 INFO - Running setup.py install for mozdebug 05:13:36 INFO - Running setup.py install for mozdevice 05:13:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:13:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:13:36 INFO - Running setup.py install for mozfile 05:13:36 INFO - Running setup.py install for mozhttpd 05:13:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:13:36 INFO - Running setup.py install for mozinfo 05:13:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:13:36 INFO - Running setup.py install for mozInstall 05:13:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Running setup.py install for mozleak 05:13:37 INFO - Running setup.py install for mozlog 05:13:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Running setup.py install for moznetwork 05:13:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Running setup.py install for mozprocess 05:13:37 INFO - Running setup.py install for mozprofile 05:13:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Running setup.py install for mozrunner 05:13:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:13:37 INFO - Running setup.py install for mozscreenshot 05:13:37 INFO - Running setup.py install for moztest 05:13:37 INFO - Running setup.py install for mozversion 05:13:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:13:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:38 INFO - Cleaning up... 05:13:38 INFO - Return code: 0 05:13:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:38 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:38 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 05:13:38 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 05:13:38 INFO - Using env: {'DISPLAY': ':0', 05:13:38 INFO - 'HOME': '/home/cltbld', 05:13:38 INFO - 'LANG': 'en_US.UTF-8', 05:13:38 INFO - 'LANGUAGE': 'en_US:en', 05:13:38 INFO - 'LOGNAME': 'cltbld', 05:13:38 INFO - 'MAIL': '/var/mail/cltbld', 05:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:38 INFO - 'MOZ_NO_REMOTE': '1', 05:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:38 INFO - 'NO_EM_RESTART': '1', 05:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:38 INFO - 'SHELL': '/bin/bash', 05:13:38 INFO - 'SHLVL': '1', 05:13:38 INFO - 'TERM': 'linux', 05:13:38 INFO - 'TMOUT': '86400', 05:13:38 INFO - 'USER': 'cltbld', 05:13:38 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:38 INFO - '_': '/tools/buildbot/bin/python'} 05:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:38 INFO - Running setup.py (path:/tmp/pip-AfE0g7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:38 INFO - Running setup.py (path:/tmp/pip-WNHrSI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:38 INFO - Running setup.py (path:/tmp/pip-MJ_Hyp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:38 INFO - Running setup.py (path:/tmp/pip-tsY9K0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:38 INFO - Running setup.py (path:/tmp/pip-11yK61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:38 INFO - Running setup.py (path:/tmp/pip-4uSygN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:38 INFO - Running setup.py (path:/tmp/pip-I8prw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:38 INFO - Running setup.py (path:/tmp/pip-tfdGPm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:38 INFO - Running setup.py (path:/tmp/pip-ecCIKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:38 INFO - Running setup.py (path:/tmp/pip-NSznXt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:13:38 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)) 05:13:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:39 INFO - Running setup.py (path:/tmp/pip-yG53G_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:39 INFO - Running setup.py (path:/tmp/pip-O15LI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:39 INFO - Running setup.py (path:/tmp/pip-7eIP8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:39 INFO - Running setup.py (path:/tmp/pip-TWfREo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:39 INFO - Running setup.py (path:/tmp/pip-YpG79f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:39 INFO - Running setup.py (path:/tmp/pip-e78Yem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:13:39 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)) 05:13:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:39 INFO - Running setup.py (path:/tmp/pip-zmwvtx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:13:39 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)) 05:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:39 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)) 05:13:39 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)) 05:13:39 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)) 05:13:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:39 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 05:13:39 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 05:13:39 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 05:13:39 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 05:13:39 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 05:13:39 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 05:13:41 INFO - Downloading blessings-1.6.tar.gz 05:13:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:41 INFO - Installing collected packages: blessings 05:13:41 INFO - Running setup.py install for blessings 05:13:41 INFO - Successfully installed blessings 05:13:41 INFO - Cleaning up... 05:13:41 INFO - Return code: 0 05:13:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:13:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:13:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:13:41 INFO - Reading from file tmpfile_stdout 05:13:41 INFO - Current package versions: 05:13:41 INFO - argparse == 1.2.1 05:13:41 INFO - blessings == 1.6 05:13:41 INFO - blobuploader == 1.2.4 05:13:41 INFO - docopt == 0.6.1 05:13:41 INFO - manifestparser == 1.1 05:13:41 INFO - mozInstall == 1.12 05:13:41 INFO - mozcrash == 0.16 05:13:41 INFO - mozdebug == 0.1 05:13:41 INFO - mozdevice == 0.48 05:13:41 INFO - mozfile == 1.2 05:13:41 INFO - mozhttpd == 0.7 05:13:41 INFO - mozinfo == 0.9 05:13:41 INFO - mozleak == 0.1 05:13:41 INFO - mozlog == 3.1 05:13:41 INFO - moznetwork == 0.27 05:13:41 INFO - mozprocess == 0.22 05:13:41 INFO - mozprofile == 0.28 05:13:41 INFO - mozrunner == 6.11 05:13:41 INFO - mozscreenshot == 0.1 05:13:41 INFO - mozsystemmonitor == 0.0 05:13:41 INFO - moztest == 0.7 05:13:41 INFO - mozversion == 1.4 05:13:41 INFO - psutil == 3.1.1 05:13:41 INFO - requests == 1.2.3 05:13:41 INFO - wsgiref == 0.1.2 05:13:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:13: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')]} 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:41 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:41 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 05:13:41 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 05:13:41 INFO - Using env: {'DISPLAY': ':0', 05:13:41 INFO - 'HOME': '/home/cltbld', 05:13:41 INFO - 'LANG': 'en_US.UTF-8', 05:13:41 INFO - 'LANGUAGE': 'en_US:en', 05:13:41 INFO - 'LOGNAME': 'cltbld', 05:13:41 INFO - 'MAIL': '/var/mail/cltbld', 05:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:41 INFO - 'MOZ_NO_REMOTE': '1', 05:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:41 INFO - 'NO_EM_RESTART': '1', 05:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:41 INFO - 'SHELL': '/bin/bash', 05:13:41 INFO - 'SHLVL': '1', 05:13:41 INFO - 'TERM': 'linux', 05:13:41 INFO - 'TMOUT': '86400', 05:13:41 INFO - 'USER': 'cltbld', 05:13:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:41 INFO - '_': '/tools/buildbot/bin/python'} 05:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 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)) 05:13:41 INFO - Cleaning up... 05:13:42 INFO - Return code: 0 05:13:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:42 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:42 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 05:13:42 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 05:13:42 INFO - Using env: {'DISPLAY': ':0', 05:13:42 INFO - 'HOME': '/home/cltbld', 05:13:42 INFO - 'LANG': 'en_US.UTF-8', 05:13:42 INFO - 'LANGUAGE': 'en_US:en', 05:13:42 INFO - 'LOGNAME': 'cltbld', 05:13:42 INFO - 'MAIL': '/var/mail/cltbld', 05:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:42 INFO - 'MOZ_NO_REMOTE': '1', 05:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:42 INFO - 'NO_EM_RESTART': '1', 05:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:42 INFO - 'SHELL': '/bin/bash', 05:13:42 INFO - 'SHLVL': '1', 05:13:42 INFO - 'TERM': 'linux', 05:13:42 INFO - 'TMOUT': '86400', 05:13:42 INFO - 'USER': 'cltbld', 05:13:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:42 INFO - '_': '/tools/buildbot/bin/python'} 05:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:42 INFO - Downloading/unpacking jsonschema 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:42 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 05:13:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:44 INFO - Downloading/unpacking functools32 (from jsonschema) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:44 INFO - warning: no files found matching '*.txt' 05:13:44 INFO - no previously-included directories found matching 'build' 05:13:44 INFO - no previously-included directories found matching 'dist' 05:13:44 INFO - no previously-included directories found matching '.git*' 05:13:44 INFO - Installing collected packages: jsonschema, functools32 05:13:44 INFO - Running setup.py install for functools32 05:13:44 INFO - warning: no files found matching '*.txt' 05:13:44 INFO - no previously-included directories found matching 'build' 05:13:44 INFO - no previously-included directories found matching 'dist' 05:13:44 INFO - no previously-included directories found matching '.git*' 05:13:44 INFO - Successfully installed jsonschema functools32 05:13:44 INFO - Cleaning up... 05:13:44 INFO - Return code: 0 05:13:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:13:44 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')]} 05:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:44 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')]} 05:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:44 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 0x7f9a77aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, '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-1456319584.219831-1485914459', '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 05:13:44 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 05:13:44 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 05:13:44 INFO - Using env: {'DISPLAY': ':0', 05:13:44 INFO - 'HOME': '/home/cltbld', 05:13:44 INFO - 'LANG': 'en_US.UTF-8', 05:13:44 INFO - 'LANGUAGE': 'en_US:en', 05:13:44 INFO - 'LOGNAME': 'cltbld', 05:13:44 INFO - 'MAIL': '/var/mail/cltbld', 05:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:44 INFO - 'MOZ_NO_REMOTE': '1', 05:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:13:44 INFO - 'NO_EM_RESTART': '1', 05:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:13:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:13:44 INFO - 'SHELL': '/bin/bash', 05:13:44 INFO - 'SHLVL': '1', 05:13:44 INFO - 'TERM': 'linux', 05:13:44 INFO - 'TMOUT': '86400', 05:13:44 INFO - 'USER': 'cltbld', 05:13:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:44 INFO - '_': '/tools/buildbot/bin/python'} 05:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:44 INFO - Downloading/unpacking flake8 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:13:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:13:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:46 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 05:13:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:13:47 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 05:13:47 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 05:13:47 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 05:13:47 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 05:13:47 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 05:13:47 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 05:13:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:13:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:47 INFO - no previously-included directories found matching 'docs/_build' 05:13:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:13:47 INFO - Running setup.py install for pep8 05:13:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:13:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:13:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:13:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:13:47 INFO - no previously-included directories found matching 'docs/_build' 05:13:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:13:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:13:47 INFO - Cleaning up... 05:13:47 INFO - Return code: 0 05:13:47 INFO - Running post-action listener: _resource_record_post_action 05:13:47 INFO - Running post-action listener: _start_resource_monitoring 05:13:47 INFO - Starting resource monitoring. 05:13:47 INFO - ##### 05:13:47 INFO - ##### Running install step. 05:13:47 INFO - ##### 05:13:47 INFO - Running pre-action listener: _resource_record_pre_action 05:13:47 INFO - Running main action method: install 05:13:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:13:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:13:47 INFO - Reading from file tmpfile_stdout 05:13:47 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:13:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:13:47 INFO - Reading from file tmpfile_stdout 05:13:47 INFO - Output received: 05:13:47 INFO - Usage: mozinstall [options] installer 05:13:47 INFO - Options: 05:13:47 INFO - -h, --help show this help message and exit 05:13:47 INFO - -d DEST, --destination=DEST 05:13:47 INFO - Directory to install application into. [default: 05:13:47 INFO - "/builds/slave/test-pgo"] 05:13:47 INFO - --app=APP Application being installed. [default: firefox] 05:13:47 INFO - mkdir: /builds/slave/test-pgo/build/application 05:13:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:13:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:14:04 INFO - Reading from file tmpfile_stdout 05:14:04 INFO - Output received: 05:14:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:14:04 INFO - Running post-action listener: _resource_record_post_action 05:14:04 INFO - ##### 05:14:04 INFO - ##### Running run-tests step. 05:14:04 INFO - ##### 05:14:04 INFO - Running pre-action listener: _resource_record_pre_action 05:14:04 INFO - Running main action method: run_tests 05:14:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:14:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:14:04 INFO - Python 2.7.3 05:14:04 INFO - Return code: 0 05:14:04 INFO - grabbing minidump binary from tooltool 05:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:04 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 0x20898c0>, '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 0x208a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x208ac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:14:04 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 05:14:04 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 05:14:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:04 INFO - Return code: 0 05:14:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:14:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:14:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:14:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:14:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:14:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:14:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:14:05 INFO - Return code: 0 05:14:05 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/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.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 05:14:05 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/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.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 05:14:05 INFO - Using env: {'DISPLAY': ':0', 05:14:05 INFO - 'HOME': '/home/cltbld', 05:14:05 INFO - 'LANG': 'en_US.UTF-8', 05:14:05 INFO - 'LANGUAGE': 'en_US:en', 05:14:05 INFO - 'LOGNAME': 'cltbld', 05:14:05 INFO - 'MAIL': '/var/mail/cltbld', 05:14:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:14:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:05 INFO - 'MOZ_NO_REMOTE': '1', 05:14:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:14:05 INFO - 'NO_EM_RESTART': '1', 05:14:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:14:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:14:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:14:05 INFO - 'SHELL': '/bin/bash', 05:14:05 INFO - 'SHLVL': '1', 05:14:05 INFO - 'TERM': 'linux', 05:14:05 INFO - 'TMOUT': '86400', 05:14:05 INFO - 'USER': 'cltbld', 05:14:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1456319584.219831-1485914459', 05:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:05 INFO - '_': '/tools/buildbot/bin/python'} 05:14:05 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/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.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 05:14:05 INFO - mozversion application_buildid: 20160224023048 05:14:05 INFO - mozversion application_changeset: ba186717174aec9677487aa47caa84fc1430e334 05:14:05 INFO - mozversion application_display_name: Nightly 05:14:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:05 INFO - mozversion application_name: Firefox 05:14:05 INFO - mozversion application_remotingname: firefox 05:14:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:14:05 INFO - mozversion application_vendor: Mozilla 05:14:05 INFO - mozversion application_version: 47.0a1 05:14:05 INFO - mozversion platform_buildid: 20160224023048 05:14:05 INFO - mozversion platform_changeset: ba186717174aec9677487aa47caa84fc1430e334 05:14:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:14:05 INFO - mozversion platform_version: 47.0a1 05:14:05 INFO - using testdate: 1456319645 05:14:05 INFO - actual date: 1456319645 05:14:05 INFO - starting webserver on 'localhost:55325' 05:14:05 INFO - SUITE-START | Running 2 tests 05:14:05 INFO - TEST-START | dromaeo_css 05:14:05 INFO - operating with platform_type : linux_ 05:14:05 INFO - Initialising browser for dromaeo_css test... 05:14:05 INFO - TEST-INFO | started process 12300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEi2_U6/profile http://localhost:55325/getInfo.html) 05:14:09 INFO - PROCESS | 12300 | __metrics Screen width/height:1600/1200 05:14:09 INFO - PROCESS | 12300 | colorDepth:24 05:14:09 INFO - PROCESS | 12300 | Browser inner width/height: 1024/697 05:14:09 INFO - PROCESS | 12300 | __metrics 05:14:10 INFO - PROCESS | 12300 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:10 INFO - PROCESS | 12300 | 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. 05:14:11 INFO - TEST-INFO | 12300: exit 0 05:14:11 INFO - Browser initialized. 05:14:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:11 INFO - TEST-INFO | started process 12399 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEi2_U6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:23 INFO - PROCESS | 12399 | RSS: Main: 148201472 05:14:23 INFO - PROCESS | 12399 | 05:15:14 INFO - PROCESS | 12399 | 1456319714526 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] 05:17:22 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55325/tests/dromaeo/cssquery-ext.html) 05:17:23 INFO - PROCESS | 12399 | RSS: Main: 276250624 05:17:23 INFO - PROCESS | 12399 | 05:20:26 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-ext.html (next: http://localhost:55325/tests/dromaeo/cssquery-jquery.html) 05:20:26 INFO - PROCESS | 12399 | RSS: Main: 240955392 05:20:26 INFO - PROCESS | 12399 | 05:23:28 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55325/tests/dromaeo/cssquery-mootools.html) 05:23:29 INFO - PROCESS | 12399 | RSS: Main: 235823104 05:23:29 INFO - PROCESS | 12399 | 05:26:30 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55325/tests/dromaeo/cssquery-prototype.html) 05:26:31 INFO - PROCESS | 12399 | RSS: Main: 219521024 05:26:31 INFO - PROCESS | 12399 | 05:29:34 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55325/tests/dromaeo/cssquery-yui.html) 05:29:34 INFO - PROCESS | 12399 | RSS: Main: 191348736 05:29:34 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | Cycle 1(1): loaded http://localhost:55325/tests/dromaeo/cssquery-yui.html (next: http://localhost:55325/tests/dromaeo/cssquery-dojo.html) 05:32:37 INFO - PROCESS | 12399 | RSS: Main: 285634560 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | __start_tp_report 05:32:37 INFO - PROCESS | 12399 | _x_x_mozilla_page_load 05:32:37 INFO - PROCESS | 12399 | _x_x_mozilla_page_load_details 05:32:37 INFO - PROCESS | 12399 | |i|pagename|runs| 05:32:37 INFO - PROCESS | 12399 | |0;dojo.html;3136.372725454909;3160.178353628056;3202.023382868226;3208.9839550802244;3232.9676703232967;5167.483251674836;5182.948170518293;5207.088759467092;5227;5232.424433312332;5137.537621614054;5179.507946745053;5184.040952423804;5195.220716892459;5252.3697156341195;4684.695494792844;4739.170645137105;4799.712017278975;4830.71015739055;4857.077155340492;4694.366260554815;4695.90608187836;4810.759462026902;4815.518448155174;4922.753862306889;4772.832950846704;4775.331453596499;4778.665493415462;4823.1800593899125;4823.300621409893;4771.212749896263;4787.47337792846;4794.5924596408995;4812.205986012304;4837.637177211724;4733.692309999839;4760.595349395306;4799.400074990626;4823.300621409911;4835.927461088087;5078.060558796635;5132.204508301219;5155.561777248939;5165.460031667953;5188.92216616751;5492.47821456961;5682.261306030189;5696.8006119785605;5700.287464066992;5701.629394089371;5701.258836351248;5704;5721.284839395075;5730.971345143289;5776.220210271644;5353.277307563507;5358.11591087474;5363.383210930754;5364.570834333244;5369.140937449989;5547.11246200606;5748.798792042258;5771.076627739625;5811.738471768696;5841.795537156179;5547.195656629766;5556.805511807148;5560.249366335493;5562.02664533705;5569.136783798518;5630.5495560355075;5631.211630371751;5634.6337488063145;5641.971790141023;5645.576581756384;5485.533729632946;5487.176923461433;5492.340919089655;5517.393086760453;5579.525740312119;5446.509814116669;5513.421090785409;5522.889542209134;5525.502704756511;5528.308961379827;4316.784160791948;4320.200762858881;4343.131373725268;4365.585269399402;4401.537838526909;3914.6085391461197;3922.235164143022;3922.764634121962;3935.114599215211;3952.9011774705864;5270.393904701008;5286.894262114736;5288.180332048539;5294.258803767476;5330.893382132335;5601.915971260434;5624.100143976944;5645.463680950304;5689.630174038674;5700.857478563069;5178;5198.98619769149;5208.739563021833;5209.661372010807;5228.424873263938;4710.882227944328;4739.218029025241;4748;4764.213904705684;4806.831760888422;5674.602777805597;5677.517411020027;5735.856603584861;5758.827235182951;5889.411058894077;5597.916031259616;5600.467955544217;5602.971985140048;5605.075162598126;5605.607607467438;5732.3121225453215;5866.765329386777;5869.442402971711;5871.882562348644;5872.119182122716;5528.834134975958;5584.944150558443;5589.077802162597;5591.608587398843;5639.830805075854;5532.253145825262;5536.750846211849;5541.556675465872;5545.639533430314;5559.27729395176;5396.514313711785;5462.562994960314;5498.45015498447;5522.834314970557;5605;5415.377231618414;5429.375621803385;5441.700706461183;5443.618946673695;5456.45435456467;5366.838994830161;5370.409254981871;5373.758180881948;5376.1398176291605;5417.5665946723375;5443.428440013741;5482.698451585201;5490.6980116094;5540.695261760642;5593.944060559343;5288.947110528846;5364.597655175799;5401.648892821954;5466.289382380424;5488.204210389391 05:32:37 INFO - PROCESS | 12399 | |1;ext.html;519.9948000519994;525.1492582017133;527.8231792349562;549.0912539746721;549.5795716277046;27672.723272767267;28150.43699126016;36613.63386366136;37045.81477092611;37113.628863711354;39338.60661393385;39715;39746.8012659937;39814.601853981454;39926.600733992724;8393.286570641487;8585.441946273504;8594.355423343242;8598.828023439528;8599.6130174142;8433.28317093048;8495.235428811406;8520.74437766868;8528.061913189544;8555.529445880475;8527.786805329853;8614.267787238092;8753.212210901018;8773.780655483632;8776.122387761237;8667.17661822126;8675.522846243422;8748.431351962103;8770.298376129895;8772.868406973901;8671.739847804576;8806;8809.515476648781;8822.779430514225;8826.382153249275;38650.420243696084;39123.60876391228;39197.80401098005;39207.80396098001;39220;3191.5850939377965;3237.838108094586;3357.9496307555405;3359.260962588251;3682.852685892561;29119.563206551706;29470;29792.70207297921;30086;30663.846680766677;3128.108489080601;3148.4332820092372;3203.3753418083484;3205.9198520036953;3277.2626159114247;257870.2129787025;261265;262249.6887515569;262567;262807;41410.58589414127;41751.37372939409;42007.789961050614;42013.36979945303;56215;41544;42148.367774483406;42253;42273.57726422758;42283.577164227965;14571.927140364442;14674.55976320712;14771.261436928111;14795.778063329059;14802.777958330633;12120.454579543766;12195.695107622203;12206;12241.755164896653;12344.321062341478;14050;14215.644608884653;14262.429502819978;14270.571882843531;14348.06737562055;5601.327840659065;5691.154422788606;5706.828795136153;5714.514266287329;5770.711464426762;848.6859861851032;891.5809569502323;933.2533972821716;982.1651596143221;992.2805965674972;25519.362015949377;25840.483190336086;25849.612255816177;25889.093881714427;25971.22086337413;928.5885454109715;940.9153176214037;955.3312681123242;961.6105477281712;992.8758905136858;12756.170848894792;12839.679008024874;12855.550055748192;12903.419346129447;13214.339283036003;301541;308341;311552;312231;312713;44943.32585011228;50874.74562627163;51717.2242416364;51884;51946.48053519416;1260.5525038611345;1289.574440434673;1294.0424086176163;1301.3688361144837;1313.1005261395974;25737.485250295264;26454.470910582066;26669.599956001064;27866.721332787223;28779.71220287854;40604.3909341366;40982.180356392106;41155.38266926059;41186.79406602948;41219.38170927379;237927;239756;239811;240417;240472;31992.840035800604;43040.78479607582;43068.35397468978;43493.56506434895;44074.77962610166;39784.60215397809;40215.798921006375;40540.3918941222;41583.37624935689;41748.58251417447;33520.83239583787;33902.491462627586;34041.31917361589;34085;34601.82699086489;34950.475742864386;35390.64609353874;35424.29151417009;38198;39833.40249896312;33497.665023350426;38887.41668874912;39566;39627;39789;27947.301317466412;31464.213394664403;31511.84244078765;31628.683713162573;32380.35239295248;25139.87430062838;25197.408483323587;25319.36701582475;25449.073356564233;25523.106691265715 05:32:37 INFO - PROCESS | 12399 | |2;jquery.html;360.0764040236794;360.29382410475466;362.4943204230098;364.4733360294376;366.5052179557599;17433.82566174338;17769.733453998186;18098.095095245233;18100;18103.366382176628;15979.760303595456;16704.331826726946;17086.658266834656;17095.658086838255;17107.91446042771;5086.79652813888;5231.555317797992;5407.972960135194;5411.621186516945;5414.296141501619;5315.069862773999;5376.8118115865955;5381.327334083239;5382.6232163748555;5385.973070134663;3712.6472985066375;4037.777922214277;5378.731063446831;5526.861828454281;5551.417101204376;5481.643693159952;5494.230807686887;5499.7250137492965;5531.2809334786625;5532.197831314457;5184.585233181337;5226.268322434862;5277.340332458442;5281.39263984639;5284.048871203182;12545.74908501834;12926.224426534438;12981.480740770357;12986.870131298661;15961.441349552826;2022.3326302320347;2025.9797402025938;2035.5928814237063;2098.5068508900395;2232.3191426614876;9536.380135291183;9543.713688589354;9677.225821934227;10013.49932503372;10060.295779295453;1817.818218178185;1867.626474705051;1869.2336142181775;1879.370410912346;1914.9617007659908;58562.7071864638;61655.69172154111;62224.68887655578;62548.37451625471;63495;10036.799264014679;10208.846867296996;10254.53854576546;10268.58925642966;10303.330283531546;13422.127561708458;13469.797953030713;13507;13545.932270338586;13583.117097388837;7438.256174382518;7450.217727138681;7454.142773580999;7457.47797654159;7504.437167212372;7214.639268036577;7216.278372162742;7245.7826265212125;7251.746188883364;7255.854882902312;4302.526722060571;4396.626286765597;4527.456705195397;4556.612687921497;4576.679632425765;1713.8286171382763;1775.4673597920573;1800.4958611588777;1801.5406071451696;1808.6563552925165;684.4353408438059;787.6613056385809;791.5567282321803;846.8433339832151;921.0375157959814;14952.70094598102;16257.837421625632;16306;16326.265318060716;16599.751003734953;761.3756719489965;841.3395484544603;842.3640151685438;869.1482347299682;875.5534677314615;7848.568328741974;8316.334693224528;8326.70856520019;8449.155084491502;8449.32405407566;382067;384104;386050;391877;394892;68660.65669671619;69692;69801;70253.2974670257;71203;999.0359303272231;1008.6469735592484;1008.9747756306004;1024.0680980307884;1024.4570377699831;13098;13287.335633218494;13550.93224533871;13712.588622341345;13734.381952811947;31184;31362.843185783924;31802;31866.20334491656;33038.66961330356;39101.6089839098;39987;40332.3950140754;40648.390274146506;40945;7437.851242975002;7773.766786996399;7775.066991960774;7915.327197188303;8035.83928321442;10251.538680759533;11740.823887641864;11742.17804753659;11962.76074478523;12110.939445302716;9979.550920208463;10072.395656260647;10123.7469063274;10127.442990635585;10152.03555662211;9967.252456065678;9996.800063998533;10398.636047738293;10544;10725.946370268412;8395.664173432995;10021.599136034478;10222.897771022195;10595.576176953144;10597.735056623646;7365.300296471826;7512.098548174254;7573.091229052549;7767.844643107219;7849.136594974434;9509.286803489627;10066.194704423775;10332.793344132924;10378.584856605954;10534.736631583964 05:32:37 INFO - PROCESS | 12399 | |3;mootools.html;1340.4035204334075;1504.7517159668655;1514.9545513634591;1693.7459381092835;1848.935287264946;7489.850202995937;7637.3890088792905;7662.96168519158;7667.92332076679;7678.462507624468;7577.431692623061;7730.5361678299205;7780.260875216845;7781.377489800817;7781.9221807781905;2005.067643545751;2272.6591011348264;2291.46150654596;2316.9073237070497;2325.883705814711;2257.808086312657;2287.897044632987;2289.050044231642;2298.0233400804673;2299.091858715806;2166.122720298282;2171.0447403142643;2181.5091604388963;2185.235167691303;2186.7047948526906;2186.7047948526983;2240.551889622082;2287.885605719724;2293.816494680422;2294.9655755163685;2206.481476852938;2226.7327920649464;2232.7432345280176;2232.8213742900693;2233.4416395901026;7826.178251283647;7868.881966770503;7883.645235964338;7886.329661978739;7904.881426778603;4710.8351207707565;4798.256270278112;4800;4833.661643684944;4837.2260438329695;3093.474109401385;3146.276356438032;3166.335069635379;3194.2333839878493;3203.0711093782775;1017.9643712470028;1022.4580972084807;1026.4170478812066;1035.0736091198335;1068.6740544134036;10576.312539684895;10785.83821242682;10803.729906752316;10810.621628242974;10821.9458902705;4232.91534169321;4235.512916014636;4303.268444364466;4315.331123675773;4319.956800432018;9268;9304.627814887464;9345.15893569582;9348.90651093494;9349.065093490732;4300.182965236595;4732.361131247307;4738.147133516;4774.116788394158;4785.49752276013;4295.6778241632;4343.261645520269;4356.433663623772;4391.560843915647;4400.471943366752;3675.761075530082;3697.7226707997006;3721.7766933983507;3747.756395834262;3775.528058992626;1190.5832958464468;1193.3436609864539;1195.4739914437619;1197.7843988082054;1214.2471667566165;922.0272612393854;930.0141849639268;935.265816334188;948.274569953972;1125.2966895690195;6774.559653622498;6783.18601767791;6793.388595026471;6803.183617965876;6834.555753875982;460.82949308755974;467.64926305271047;472.7258190249647;474.3288247130272;474.4733345985953;4883.780229889592;4889;4914.975425122923;4915.139850526144;4928.433230178575;9249.583768730288;9269.258459323239;9381.718548443558;9492.240620750323;9505.42967421957;9210.631574736935;9233.769155771159;9360.251179905592;9371.109744574254;9375.90624093764;7264.818379540554;7270.200277969419;7382;7450.962745186348;7475.738349157753;6541.116949211986;6546.8363290918105;6567.737290508326;6567.770128045496;6574.3754343337305;8123.18768123183;8397.874031889405;8440.873386899324;8550.786230344042;8598.82802343962;8573.828523429373;8672.869906951528;8674;8840.425372350777;8849.823003539765;5940.851478713067;5983.491403230774;6083.482903953037;6289.96855015722;6462.224533056064;6804.047433359433;6889.173299203927;6891.655417229219;6914.688839002358;6928.891377379595;6147.600405973598;6281.403266689657;6285.654289013965;6346.174997250328;6381.138546296191;6125.234345706786;6205.348438413902;6240.157578726814;6257.030160325156;6319.304876463493;6400;6427.035944608346;6430.035494675836;6448;6506.967465162644;5821.185034095145;5870.765169393177;5879.029960056714;5887.941120588739;5888.17565540816;5855.59010869235;5993.760249589967;6001.399860013964;6013.9699301503215;6034.336223015377 05:32:37 INFO - PROCESS | 12399 | |4;prototype.html;338.53282470191135;343.9208981934155;346.8543211851023;348.07065136086646;352.4044365023109;5809.448102430268;5854.590178687494;5898.410158984099;5905.940940590593;5943.435373639508;5548.167774833777;5613.46672066154;5743.052396354607;5799.623024503415;5833.629097162174;4560.9087818243615;4563.634909207255;4564.338170965208;4568.657350698702;4577.977110114445;4357.433533640622;4569.565891240327;4572.382728331682;4574.130915126132;4580.541945805426;4400.889977750549;4504.662150338721;4514.27771556551;4523.185826551219;4523.592876641102;4502.16709908668;4506.954930450719;4516.864494065183;4520.50274469808;4524.2082635538645;4012.879613611596;4013.819378127962;4013.97993010036;4019.919601607981;4028.2144981728575;5580.804671836466;5582.692951887645;5583.553315734732;5585.078462053756;5596.27248457702;5268.4458084865055;5275.076861549213;5287.180487024518;5289.047971365153;5293.232481290192;5938.524918006549;6186.969065154645;6194.535409844235;6210.441060304549;6221;4305.698601097924;4309.978450107761;4312.956870431287;4318.676099292566;4319.092990472004;6390.808275751735;6427.582207156566;6441.774537891151;6456.386643268882;6458;4406.184855801687;4408.823647054082;4411.625011873963;4416.359627854007;4425.424694789656;4465.0623369092855;4468.374427580141;4469.821207151677;4473.507914129443;4473.977630111829;5037.773300201499;5156.716380599103;5164.690118592896;5170.405403378584;5174.404943431478;6191.4118158774845;6247.781327653511;6250.406211409909;6309.842253943596;6321.715522801393;1477.0768269831356;1527.4501179575343;1539.1073177556991;1573.7482002879485;1575.4564675187041;1025.6410256410197;1032.2825636182931;1038.9896101039044;1043.9269251152346;1045.4093437207953;5879.853003674857;5943.494802941798;5955.13650520672;5957.612755170987;5958.970205148947;6380.840478988062;6411.6153030818305;6448.516361272923;6450.41946224842;6457.3865482779065;5905;5950.613210141327;5952.970235148797;5953;5959.0763431668165;3399.3201359728155;3436.295559410315;3440.7591468597457;3442.535257740223;3442.7417943653827;6519.576227545289;6692.799216023527;6704.664766761643;6842.863142737117;6850.623215723083;6612.371824676648;6623.602583844985;6648.33516648341;6650.135482387259;6656.167979002625;6814.386705196655;6821.69302381394;6823.965880170567;6824.304399762066;6825.385715285648;6474.320196379501;6481.481481481376;6482.319356467691;6484.092227088306;6489.318621544859;6218.844528886814;6365.14070600463;6420.357964203542;6433.935660643521;6434.967825160844;6800.251972283144;6829.692663830239;6830.692618832264;6834.077399550997;6840.828979275558;4380;4383.553427368897;4415.845445409395;4417.0724147929295;4417.801198945991;6214.9689251553455;6296.33888441707;6452.870747619054;6460.095586617971;6486.675666216576;6252.187215662117;6299;6309.779157729457;6314.179156709598;6319.05214217871;6244.0321750128805;6248.875022499616;6250.343713910156;6257.43683068526;6257.780977665942;6194.0708893666315;6195.721192546436;6206.410391012847;6207.441330280297;6210.441060304594;6160.260768707604;6282.780102696383;6283.717232724447;6328.746850125944;6335.841603959938;6132.846678833065;6138.109974053648;6161.6919154041225;6168.1056246844855;6172.845678857885 05:32:37 INFO - PROCESS | 12399 | |5;yui.html;648.2674577727165;671.5131529641008;699.5557820783804;782.2685788787483;801.3869389916715;12975.805362919553;13150.079494435382;13153.539626113088;13168.934155329234;13186.142900711448;12417.068719846002;12492.250464972085;12500.749985000295;13413.061085724003;13806.102603330777;814.8655471847138;826.1985873702529;826.3760860550307;831.2435683527991;832.5545832979358;828.0973738624928;829.7676650537829;830.3274347778289;830.4809494066209;830.5764060329216;854.9615267312955;855.9315254779634;858.2490320969152;858.6136238692582;861.8491763941316;853.4665833853842;854.7350321400355;859.7463748194298;864.5849992003873;870.6909047288248;639.25526761323;641.1120597971797;642.983925401864;643.0964494884695;643.5816719132602;13542.932285338511;13572.96405539167;13574.524891628746;13605.591832245049;13619.319034048358;11890.702732431671;11963.342016189106;12040.939795300967;12398.380080995914;12808.23150610957;9670.854937175947;9745.171660408874;9811.001269951956;9917.900820991843;10264.332818366782;3424.417848965682;3445.155936795501;3476.0962149841225;3482.181687303482;3490.1798077451776;43558.34662480065;44193.55806441959;49295.50704492945;49685.50314496845;52276.47723522754;9850.950745246371;9867.259955503367;9900.158486528582;10022.699319020441;10305.896941030494;16989.575260618338;17348.566285842702;17800.46598602044;17828.910855445898;17833;7594.848103037908;7870.72452464161;7887.329576985906;7916.762497125095;8028.237317454832;4206.26390381682;4249.3625956106835;4285.121550082225;4347.739135651871;4351.543087975717;3020.909372718822;3027.2734543709353;3039.3161538653626;3042.558828969787;3043.223977885625;577.8555361159711;600.207725801946;606.686523676236;614.708013693492;626.9686515674198;585.1398444286891;591.1457943272017;597.172915512019;630.3853742600927;668.4652278177439;8009.519428834288;8109.797255068671;8141.715039973691;8261.215184557457;8317.584120793936;568.590614757374;584.4243420231069;635.6091004032579;668.6644047648491;676.4926305271047;3648.821930558483;3770.547534295847;3844.59631738669;3902.102516421239;3908.2769687607315;59805.401945980855;60038;60655;60689.69655151696;60865.39134608597;42558.36162457566;45397.54602453933;46727.13091476371;50612;50739;41434;42193.57806421958;42197.367039494435;42394;45640.5435945643;8494.957525212334;8763.868541972002;8795.384323097578;8868.246199073152;8937.46375217489;27687;34207.48688769621;34402.82798585991;34890.12774680653;35595.82202088973;40681.38977915393;43971.78014109909;44469.55530444654;46193.76903115463;46313.3053004212;11138.3873886937;11154.498047587716;11325.433728313716;11327.546898123983;11343.489542970421;11570.826437603275;11617.070634349062;11867.287962722265;12248.571300004458;12250.75498490043;10759.946200268949;11153.21927465102;11213.66359009231;11261.099112071179;11308.830367544659;10926.453677315943;10939.835902461311;10941.945290273497;11249.49377278008;11650.70873228176;10894.346339219355;11197.328160310408;11240.83138752903;11375.715607109558;11449.59926402572;9600.863538007132;9809.55856986423;9838.704838854846;9992.150667193078;10000;8889;9142.75441207332;9261.439604078934;9752.122308992224;9810.558524866256 05:32:37 INFO - PROCESS | 12399 | __end_tp_report 05:32:37 INFO - PROCESS | 12399 | __start_cc_report 05:32:37 INFO - PROCESS | 12399 | _x_x_mozilla_cycle_collect,1012 05:32:37 INFO - PROCESS | 12399 | __end_cc_report 05:32:37 INFO - PROCESS | 12399 | __startTimestamp1456320757700__endTimestamp 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | ------- Summary: start ------- 05:32:37 INFO - PROCESS | 12399 | Number of tests: 6 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#0] dojo.html Cycles:165 Average:5215.69 Median:5401.65 stddev:564.97 (10.5%) stddev-sans-first:542.65 05:32:37 INFO - PROCESS | 12399 | Values: 3136.4 3160.2 3202.0 3209.0 3233.0 5167.5 5182.9 5207.1 5227.0 5232.4 5137.5 5179.5 5184.0 5195.2 5252.4 4684.7 4739.2 4799.7 4830.7 4857.1 4694.4 4695.9 4810.8 4815.5 4922.8 4772.8 4775.3 4778.7 4823.2 4823.3 4771.2 4787.5 4794.6 4812.2 4837.6 4733.7 4760.6 4799.4 4823.3 4835.9 5078.1 5132.2 5155.6 5165.5 5188.9 5492.5 5682.3 5696.8 5700.3 5701.6 5701.3 5704.0 5721.3 5731.0 5776.2 5353.3 5358.1 5363.4 5364.6 5369.1 5547.1 5748.8 5771.1 5811.7 5841.8 5547.2 5556.8 5560.2 5562.0 5569.1 5630.5 5631.2 5634.6 5642.0 5645.6 5485.5 5487.2 5492.3 5517.4 5579.5 5446.5 5513.4 5522.9 5525.5 5528.3 4316.8 4320.2 4343.1 4365.6 4401.5 3914.6 3922.2 3922.8 3935.1 3952.9 5270.4 5286.9 5288.2 5294.3 5330.9 5601.9 5624.1 5645.5 5689.6 5700.9 5178.0 5199.0 5208.7 5209.7 5228.4 4710.9 4739.2 4748.0 4764.2 4806.8 5674.6 5677.5 5735.9 5758.8 5889.4 5597.9 5600.5 5603.0 5605.1 5605.6 5732.3 5866.8 5869.4 5871.9 5872.1 5528.8 5584.9 5589.1 5591.6 5639.8 5532.3 5536.8 5541.6 5545.6 5559.3 5396.5 5462.6 5498.5 5522.8 5605.0 5415.4 5429.4 5441.7 5443.6 5456.5 5366.8 5370.4 5373.8 5376.1 5417.6 5443.4 5482.7 5490.7 5540.7 5593.9 5288.9 5364.6 5401.6 5466.3 5488.2 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#1] ext.html Cycles:180 Average:42884.43 Median:38424.21 stddev:70886.91 (184.5%) stddev-sans-first:71014.40 05:32:37 INFO - PROCESS | 12399 | Values: 520.0 525.1 527.8 549.1 549.6 27672.7 28150.4 36613.6 37045.8 37113.6 39338.6 39715.0 39746.8 39814.6 39926.6 8393.3 8585.4 8594.4 8598.8 8599.6 8433.3 8495.2 8520.7 8528.1 8555.5 8527.8 8614.3 8753.2 8773.8 8776.1 8667.2 8675.5 8748.4 8770.3 8772.9 8671.7 8806.0 8809.5 8822.8 8826.4 38650.4 39123.6 39197.8 39207.8 39220.0 3191.6 3237.8 3357.9 3359.3 3682.9 29119.6 29470.0 29792.7 30086.0 30663.8 3128.1 3148.4 3203.4 3205.9 3277.3 257870.2 261265.0 262249.7 262567.0 262807.0 41410.6 41751.4 42007.8 42013.4 56215.0 41544.0 42148.4 42253.0 42273.6 42283.6 14571.9 14674.6 14771.3 14795.8 14802.8 12120.5 12195.7 12206.0 12241.8 12344.3 14050.0 14215.6 14262.4 14270.6 14348.1 5601.3 5691.2 5706.8 5714.5 5770.7 848.7 891.6 933.3 982.2 992.3 25519.4 25840.5 25849.6 25889.1 25971.2 928.6 940.9 955.3 961.6 992.9 12756.2 12839.7 12855.6 12903.4 13214.3 301541.0 308341.0 311552.0 312231.0 312713.0 44943.3 50874.7 51717.2 51884.0 51946.5 1260.6 1289.6 1294.0 1301.4 1313.1 25737.5 26454.5 26669.6 27866.7 28779.7 40604.4 40982.2 41155.4 41186.8 41219.4 237927.0 239756.0 239811.0 240417.0 240472.0 31992.8 43040.8 43068.4 43493.6 44074.8 39784.6 40215.8 40540.4 41583.4 41748.6 33520.8 33902.5 34041.3 34085.0 34601.8 34950.5 35390.6 35424.3 38198.0 39833.4 33497.7 38887.4 39566.0 39627.0 39789.0 27947.3 31464.2 31511.8 31628.7 32380.4 25139.9 25197.4 25319.4 25449.1 25523.1 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#2] jquery.html Cycles:180 Average:23130.26 Median:215489.30 stddev:63664.64 (29.5%) stddev-sans-first:63820.27 05:32:37 INFO - PROCESS | 12399 | Values: 360.1 360.3 362.5 364.5 366.5 17433.8 17769.7 18098.1 18100.0 18103.4 15979.8 16704.3 17086.7 17095.7 17107.9 5086.8 5231.6 5408.0 5411.6 5414.3 5315.1 5376.8 5381.3 5382.6 5386.0 3712.6 4037.8 5378.7 5526.9 5551.4 5481.6 5494.2 5499.7 5531.3 5532.2 5184.6 5226.3 5277.3 5281.4 5284.0 12545.7 12926.2 12981.5 12986.9 15961.4 2022.3 2026.0 2035.6 2098.5 2232.3 9536.4 9543.7 9677.2 10013.5 10060.3 1817.8 1867.6 1869.2 1879.4 1915.0 58562.7 61655.7 62224.7 62548.4 63495.0 10036.8 10208.8 10254.5 10268.6 10303.3 13422.1 13469.8 13507.0 13545.9 13583.1 7438.3 7450.2 7454.1 7457.5 7504.4 7214.6 7216.3 7245.8 7251.7 7255.9 4302.5 4396.6 4527.5 4556.6 4576.7 1713.8 1775.5 1800.5 1801.5 1808.7 684.4 787.7 791.6 846.8 921.0 14952.7 16257.8 16306.0 16326.3 16599.8 761.4 841.3 842.4 869.1 875.6 7848.6 8316.3 8326.7 8449.2 8449.3 382067.0 384104.0 386050.0 391877.0 394892.0 68660.7 69692.0 69801.0 70253.3 71203.0 999.0 1008.6 1009.0 1024.1 1024.5 13098.0 13287.3 13550.9 13712.6 13734.4 31184.0 31362.8 31802.0 31866.2 33038.7 39101.6 39987.0 40332.4 40648.4 40945.0 7437.9 7773.8 7775.1 7915.3 8035.8 10251.5 11740.8 11742.2 11962.8 12110.9 9979.6 10072.4 10123.7 10127.4 10152.0 9967.3 9996.8 10398.6 10544.0 10725.9 8395.7 10021.6 10222.9 10595.6 10597.7 7365.3 7512.1 7573.1 7767.8 7849.1 9509.3 10066.2 10332.8 10378.6 10534.7 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#3] mootools.html Cycles:180 Average:5279.53 Median:5888.06 stddev:2802.67 (47.6%) stddev-sans-first:2794.89 05:32:37 INFO - PROCESS | 12399 | Values: 1340.4 1504.8 1515.0 1693.7 1848.9 7489.9 7637.4 7663.0 7667.9 7678.5 7577.4 7730.5 7780.3 7781.4 7781.9 2005.1 2272.7 2291.5 2316.9 2325.9 2257.8 2287.9 2289.1 2298.0 2299.1 2166.1 2171.0 2181.5 2185.2 2186.7 2186.7 2240.6 2287.9 2293.8 2295.0 2206.5 2226.7 2232.7 2232.8 2233.4 7826.2 7868.9 7883.6 7886.3 7904.9 4710.8 4798.3 4800.0 4833.7 4837.2 3093.5 3146.3 3166.3 3194.2 3203.1 1018.0 1022.5 1026.4 1035.1 1068.7 10576.3 10785.8 10803.7 10810.6 10821.9 4232.9 4235.5 4303.3 4315.3 4320.0 9268.0 9304.6 9345.2 9348.9 9349.1 4300.2 4732.4 4738.1 4774.1 4785.5 4295.7 4343.3 4356.4 4391.6 4400.5 3675.8 3697.7 3721.8 3747.8 3775.5 1190.6 1193.3 1195.5 1197.8 1214.2 922.0 930.0 935.3 948.3 1125.3 6774.6 6783.2 6793.4 6803.2 6834.6 460.8 467.6 472.7 474.3 474.5 4883.8 4889.0 4915.0 4915.1 4928.4 9249.6 9269.3 9381.7 9492.2 9505.4 9210.6 9233.8 9360.3 9371.1 9375.9 7264.8 7270.2 7382.0 7451.0 7475.7 6541.1 6546.8 6567.7 6567.8 6574.4 8123.2 8397.9 8440.9 8550.8 8598.8 8573.8 8672.9 8674.0 8840.4 8849.8 5940.9 5983.5 6083.5 6290.0 6462.2 6804.0 6889.2 6891.7 6914.7 6928.9 6147.6 6281.4 6285.7 6346.2 6381.1 6125.2 6205.3 6240.2 6257.0 6319.3 6400.0 6427.0 6430.0 6448.0 6507.0 5821.2 5870.8 5879.0 5887.9 5888.2 5855.6 5993.8 6001.4 6014.0 6034.3 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#4] prototype.html Cycles:180 Average:5229.82 Median:5922.23 stddev:1583.74 (26.7%) stddev-sans-first:1545.04 05:32:37 INFO - PROCESS | 12399 | Values: 338.5 343.9 346.9 348.1 352.4 5809.4 5854.6 5898.4 5905.9 5943.4 5548.2 5613.5 5743.1 5799.6 5833.6 4560.9 4563.6 4564.3 4568.7 4578.0 4357.4 4569.6 4572.4 4574.1 4580.5 4400.9 4504.7 4514.3 4523.2 4523.6 4502.2 4507.0 4516.9 4520.5 4524.2 4012.9 4013.8 4014.0 4019.9 4028.2 5580.8 5582.7 5583.6 5585.1 5596.3 5268.4 5275.1 5287.2 5289.0 5293.2 5938.5 6187.0 6194.5 6210.4 6221.0 4305.7 4310.0 4313.0 4318.7 4319.1 6390.8 6427.6 6441.8 6456.4 6458.0 4406.2 4408.8 4411.6 4416.4 4425.4 4465.1 4468.4 4469.8 4473.5 4474.0 5037.8 5156.7 5164.7 5170.4 5174.4 6191.4 6247.8 6250.4 6309.8 6321.7 1477.1 1527.5 1539.1 1573.7 1575.5 1025.6 1032.3 1039.0 1043.9 1045.4 5879.9 5943.5 5955.1 5957.6 5959.0 6380.8 6411.6 6448.5 6450.4 6457.4 5905.0 5950.6 5953.0 5953.0 5959.1 3399.3 3436.3 3440.8 3442.5 3442.7 6519.6 6692.8 6704.7 6842.9 6850.6 6612.4 6623.6 6648.3 6650.1 6656.2 6814.4 6821.7 6824.0 6824.3 6825.4 6474.3 6481.5 6482.3 6484.1 6489.3 6218.8 6365.1 6420.4 6433.9 6435.0 6800.3 6829.7 6830.7 6834.1 6840.8 4380.0 4383.6 4415.8 4417.1 4417.8 6215.0 6296.3 6452.9 6460.1 6486.7 6252.2 6299.0 6309.8 6314.2 6319.1 6244.0 6248.9 6250.3 6257.4 6257.8 6194.1 6195.7 6206.4 6207.4 6210.4 6160.3 6282.8 6283.7 6328.7 6335.8 6132.8 6138.1 6161.7 6168.1 6172.8 05:32:37 INFO - PROCESS | 12399 | 05:32:37 INFO - PROCESS | 12399 | [#5] yui.html Cycles:180 Average:13529.07 Median:45917.16 stddev:15668.49 (34.1%) stddev-sans-first:15682.59 05:32:37 INFO - PROCESS | 12399 | Values: 648.3 671.5 699.6 782.3 801.4 12975.8 13150.1 13153.5 13168.9 13186.1 12417.1 12492.3 12500.7 13413.1 13806.1 814.9 826.2 826.4 831.2 832.6 828.1 829.8 830.3 830.5 830.6 855.0 855.9 858.2 858.6 861.8 853.5 854.7 859.7 864.6 870.7 639.3 641.1 643.0 643.1 643.6 13542.9 13573.0 13574.5 13605.6 13619.3 11890.7 11963.3 12040.9 12398.4 12808.2 9670.9 9745.2 9811.0 9917.9 10264.3 3424.4 3445.2 3476.1 3482.2 3490.2 43558.3 44193.6 49295.5 49685.5 52276.5 9851.0 9867.3 9900.2 10022.7 10305.9 16989.6 17348.6 17800.5 17828.9 17833.0 7594.8 7870.7 7887.3 7916.8 8028.2 4206.3 4249.4 4285.1 4347.7 4351.5 3020.9 3027.3 3039.3 3042.6 3043.2 577.9 600.2 606.7 614.7 627.0 585.1 591.1 597.2 630.4 668.5 8009.5 8109.8 8141.7 8261.2 8317.6 568.6 584.4 635.6 668.7 676.5 3648.8 3770.5 3844.6 3902.1 3908.3 59805.4 60038.0 60655.0 60689.7 60865.4 42558.4 45397.5 46727.1 50612.0 50739.0 41434.0 42193.6 42197.4 42394.0 45640.5 8495.0 8763.9 8795.4 8868.2 8937.5 27687.0 34207.5 34402.8 34890.1 35595.8 40681.4 43971.8 44469.6 46193.8 46313.3 11138.4 11154.5 11325.4 11327.5 11343.5 11570.8 11617.1 11867.3 12248.6 12250.8 10759.9 11153.2 11213.7 11261.1 11308.8 10926.5 10939.8 10941.9 11249.5 11650.7 10894.3 11197.3 11240.8 11375.7 11449.6 9600.9 9809.6 9838.7 9992.2 10000.0 8889.0 9142.8 9261.4 9752.1 9810.6 05:32:37 INFO - PROCESS | 12399 | -------- Summary: end -------- 05:32:37 INFO - PROCESS | 12399 | 05:32:38 INFO - TEST-INFO | 12399: exit 0 05:32:38 INFO - TEST-OK | dromaeo_css | took 1112840ms 05:32:38 INFO - TEST-START | kraken 05:32:38 INFO - operating with platform_type : linux_ 05:32:38 INFO - Initialising browser for kraken test... 05:32:38 INFO - TEST-INFO | started process 12586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWaZb7I/profile http://localhost:55325/getInfo.html) 05:32:42 INFO - PROCESS | 12586 | __metrics Screen width/height:1600/1200 05:32:42 INFO - PROCESS | 12586 | colorDepth:24 05:32:42 INFO - PROCESS | 12586 | Browser inner width/height: 1024/697 05:32:42 INFO - PROCESS | 12586 | __metrics 05:32:43 INFO - PROCESS | 12586 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:44 INFO - TEST-INFO | 12586: exit 0 05:32:44 INFO - Browser initialized. 05:32:44 INFO - Running cycle 1/1 for kraken test... 05:32:44 INFO - TEST-INFO | started process 12672 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWaZb7I/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:56 INFO - PROCESS | 12672 | RSS: Main: 147365888 05:32:56 INFO - PROCESS | 12672 | 05:32:58 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55325/tests/kraken/driver.html?testName=audio-beat-detection) 05:32:59 INFO - PROCESS | 12672 | RSS: Main: 191066112 05:32:59 INFO - PROCESS | 12672 | 05:33:01 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55325/tests/kraken/driver.html?testName=audio-dft) 05:33:02 INFO - PROCESS | 12672 | RSS: Main: 180109312 05:33:02 INFO - PROCESS | 12672 | 05:33:05 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55325/tests/kraken/driver.html?testName=audio-fft) 05:33:05 INFO - PROCESS | 12672 | RSS: Main: 165666816 05:33:05 INFO - PROCESS | 12672 | 05:33:07 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55325/tests/kraken/driver.html?testName=audio-oscillator) 05:33:08 INFO - PROCESS | 12672 | RSS: Main: 168148992 05:33:08 INFO - PROCESS | 12672 | 05:33:10 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55325/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:11 INFO - PROCESS | 12672 | RSS: Main: 171188224 05:33:11 INFO - PROCESS | 12672 | 05:33:14 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55325/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:14 INFO - PROCESS | 12672 | RSS: Main: 168468480 05:33:14 INFO - PROCESS | 12672 | 05:33:18 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55325/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:18 INFO - PROCESS | 12672 | RSS: Main: 171249664 05:33:18 INFO - PROCESS | 12672 | 05:33:21 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55325/tests/kraken/driver.html?testName=json-parse-financial) 05:33:22 INFO - PROCESS | 12672 | RSS: Main: 169955328 05:33:22 INFO - PROCESS | 12672 | 05:33:23 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55325/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:24 INFO - PROCESS | 12672 | RSS: Main: 181825536 05:33:24 INFO - PROCESS | 12672 | 05:33:26 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:26 INFO - PROCESS | 12672 | RSS: Main: 180797440 05:33:26 INFO - PROCESS | 12672 | 05:33:28 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:29 INFO - PROCESS | 12672 | RSS: Main: 193216512 05:33:29 INFO - PROCESS | 12672 | 05:33:31 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:32 INFO - PROCESS | 12672 | RSS: Main: 198647808 05:33:32 INFO - PROCESS | 12672 | 05:33:35 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:35 INFO - PROCESS | 12672 | RSS: Main: 195555328 05:33:35 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | Cycle 1(1): loaded http://localhost:55325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55325/tests/kraken/driver.html?testName=ai-astar) 05:33:37 INFO - PROCESS | 12672 | RSS: Main: 255963136 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | __start_tp_report 05:33:37 INFO - PROCESS | 12672 | _x_x_mozilla_page_load 05:33:37 INFO - PROCESS | 12672 | _x_x_mozilla_page_load_details 05:33:37 INFO - PROCESS | 12672 | |i|pagename|runs| 05:33:37 INFO - PROCESS | 12672 | |0;ai-astar;110;111;105;111;113;111;101;111;110;110 05:33:37 INFO - PROCESS | 12672 | |1;audio-beat-detection;154;124;149;160;126;153;157;140;171;130 05:33:37 INFO - PROCESS | 12672 | |2;audio-dft;160;161;170;160;161;160;161;162;163;161 05:33:37 INFO - PROCESS | 12672 | |3;audio-fft;75;73;98;101;73;75;75;115;96;73 05:33:37 INFO - PROCESS | 12672 | |4;audio-oscillator;97;97;144;97;97;96;135;96;97;140 05:33:37 INFO - PROCESS | 12672 | |5;imaging-gaussian-blur;119;114;114;115;114;114;115;115;115;115 05:33:37 INFO - PROCESS | 12672 | |6;imaging-darkroom;152;145;145;145;145;145;145;144;145;153 05:33:37 INFO - PROCESS | 12672 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;95 05:33:37 INFO - PROCESS | 12672 | |8;json-parse-financial;55;56;57;56;57;55;57;69;56;57 05:33:37 INFO - PROCESS | 12672 | |9;json-stringify-tinderbox;69;69;68;67;68;68;69;68;68;68 05:33:37 INFO - PROCESS | 12672 | |10;stanford-crypto-aes;83;82;82;84;83;83;90;83;84;83 05:33:37 INFO - PROCESS | 12672 | |11;stanford-crypto-ccm;117;132;117;117;117;119;116;119;133;123 05:33:37 INFO - PROCESS | 12672 | |12;stanford-crypto-pbkdf2;151;138;155;160;149;140;145;148;161;149 05:33:37 INFO - PROCESS | 12672 | |13;stanford-crypto-sha256-iterative;68;68;69;70;69;70;67;70;66;68 05:33:37 INFO - PROCESS | 12672 | __end_tp_report 05:33:37 INFO - PROCESS | 12672 | __start_cc_report 05:33:37 INFO - PROCESS | 12672 | _x_x_mozilla_cycle_collect,948 05:33:37 INFO - PROCESS | 12672 | __end_cc_report 05:33:37 INFO - PROCESS | 12672 | __startTimestamp1456320817525__endTimestamp 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | ------- Summary: start ------- 05:33:37 INFO - PROCESS | 12672 | Number of tests: 14 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.56 (3.2%) stddev-sans-first:3.77 05:33:37 INFO - PROCESS | 12672 | Values: 110.0 111.0 105.0 111.0 113.0 111.0 101.0 111.0 110.0 110.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:15.77 (10.3%) stddev-sans-first:16.49 05:33:37 INFO - PROCESS | 12672 | Values: 154.0 124.0 149.0 160.0 126.0 153.0 157.0 140.0 171.0 130.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.00 stddev:3.00 (1.9%) stddev-sans-first:3.10 05:33:37 INFO - PROCESS | 12672 | Values: 160.0 161.0 170.0 160.0 161.0 160.0 161.0 162.0 163.0 161.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:15.55 (20.7%) stddev-sans-first:16.03 05:33:37 INFO - PROCESS | 12672 | Values: 75.0 73.0 98.0 101.0 73.0 75.0 75.0 115.0 96.0 73.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:97.00 stddev:20.86 (21.5%) stddev-sans-first:21.62 05:33:37 INFO - PROCESS | 12672 | Values: 97.0 97.0 144.0 97.0 97.0 96.0 135.0 96.0 97.0 140.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 05:33:37 INFO - PROCESS | 12672 | Values: 119.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 115.0 115.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:145.00 stddev:3.24 (2.2%) stddev-sans-first:2.73 05:33:37 INFO - PROCESS | 12672 | Values: 152.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 153.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:33:37 INFO - PROCESS | 12672 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:4.12 (7.2%) stddev-sans-first:4.27 05:33:37 INFO - PROCESS | 12672 | Values: 55.0 56.0 57.0 56.0 57.0 55.0 57.0 69.0 56.0 57.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:33:37 INFO - PROCESS | 12672 | Values: 69.0 69.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.31 (2.8%) stddev-sans-first:2.44 05:33:37 INFO - PROCESS | 12672 | Values: 83.0 82.0 82.0 84.0 83.0 83.0 90.0 83.0 84.0 83.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:119.00 stddev:6.38 (5.4%) stddev-sans-first:6.60 05:33:37 INFO - PROCESS | 12672 | Values: 117.0 132.0 117.0 117.0 117.0 119.0 116.0 119.0 133.0 123.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.00 stddev:7.60 (5.1%) stddev-sans-first:8.05 05:33:37 INFO - PROCESS | 12672 | Values: 151.0 138.0 155.0 160.0 149.0 140.0 145.0 148.0 161.0 149.0 05:33:37 INFO - PROCESS | 12672 | 05:33:37 INFO - PROCESS | 12672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 05:33:37 INFO - PROCESS | 12672 | Values: 68.0 68.0 69.0 70.0 69.0 70.0 67.0 70.0 66.0 68.0 05:33:37 INFO - PROCESS | 12672 | -------- Summary: end -------- 05:33:37 INFO - PROCESS | 12672 | 05:33:38 INFO - TEST-INFO | 12672: exit 0 05:33:38 INFO - TEST-OK | kraken | took 60080ms 05:33:38 INFO - SUITE-END | took 1172s 05:33:38 INFO - Completed test suite (00:19:33) 05:33:38 INFO - Working with test: dromaeo_css 05:33:38 INFO - Generating results file: dromaeo_css 05:33:38 INFO - Working with test: kraken 05:33:38 INFO - Generating results file: kraken 05:33:38 INFO - javascript benchmark 05:33:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:33:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:33:38 INFO - process_Request line: dromaeo_css 6676.49 graph.html#tests=[[72,64,35]] 05:33:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:33:38 INFO - process_Request line: kraken 1518.50 graph.html#tests=[[232,64,35]] 05:33:38 INFO - RETURN: dromaeo_css: 6676.49 05:33:38 INFO - RETURN: kraken: 1518.50 05:33:38 INFO - javascript benchmark 05:33:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3136.372725454909, 3160.178353628056, 3202.023382868226, 3208.9839550802244, 3232.9676703232967, 5167.483251674836, 5182.948170518293, 5207.088759467092, 5227.0, 5232.424433312332, 5137.537621614054, 5179.507946745053, 5184.040952423804, 5195.220716892459, 5252.3697156341195, 4684.695494792844, 4739.170645137105, 4799.712017278975, 4830.71015739055, 4857.077155340492, 4694.366260554815, 4695.90608187836, 4810.759462026902, 4815.518448155174, 4922.753862306889, 4772.832950846704, 4775.331453596499, 4778.665493415462, 4823.1800593899125, 4823.300621409893, 4771.212749896263, 4787.47337792846, 4794.5924596408995, 4812.205986012304, 4837.637177211724, 4733.692309999839, 4760.595349395306, 4799.400074990626, 4823.300621409911, 4835.927461088087, 5078.060558796635, 5132.204508301219, 5155.561777248939, 5165.460031667953, 5188.92216616751, 5492.47821456961, 5682.261306030189, 5696.8006119785605, 5700.287464066992, 5701.629394089371, 5701.258836351248, 5704.0, 5721.284839395075, 5730.971345143289, 5776.220210271644, 5353.277307563507, 5358.11591087474, 5363.383210930754, 5364.570834333244, 5369.140937449989, 5547.11246200606, 5748.798792042258, 5771.076627739625, 5811.738471768696, 5841.795537156179, 5547.195656629766, 5556.805511807148, 5560.249366335493, 5562.02664533705, 5569.136783798518, 5630.5495560355075, 5631.211630371751, 5634.6337488063145, 5641.971790141023, 5645.576581756384, 5485.533729632946, 5487.176923461433, 5492.340919089655, 5517.393086760453, 5579.525740312119, 5446.509814116669, 5513.421090785409, 5522.889542209134, 5525.502704756511, 5528.308961379827, 4316.784160791948, 4320.200762858881, 4343.131373725268, 4365.585269399402, 4401.537838526909, 3914.6085391461197, 3922.235164143022, 3922.764634121962, 3935.114599215211, 3952.9011774705864, 5270.393904701008, 5286.894262114736, 5288.180332048539, 5294.258803767476, 5330.893382132335, 5601.915971260434, 5624.100143976944, 5645.463680950304, 5689.630174038674, 5700.857478563069, 5178.0, 5198.98619769149, 5208.739563021833, 5209.661372010807, 5228.424873263938, 4710.882227944328, 4739.218029025241, 4748.0, 4764.213904705684, 4806.831760888422, 5674.602777805597, 5677.517411020027, 5735.856603584861, 5758.827235182951, 5889.411058894077, 5597.916031259616, 5600.467955544217, 5602.971985140048, 5605.075162598126, 5605.607607467438, 5732.3121225453215, 5866.765329386777, 5869.442402971711, 5871.882562348644, 5872.119182122716, 5528.834134975958, 5584.944150558443, 5589.077802162597, 5591.608587398843, 5639.830805075854, 5532.253145825262, 5536.750846211849, 5541.556675465872, 5545.639533430314, 5559.27729395176, 5396.514313711785, 5462.562994960314, 5498.45015498447, 5522.834314970557, 5605.0, 5415.377231618414, 5429.375621803385, 5441.700706461183, 5443.618946673695, 5456.45435456467, 5366.838994830161, 5370.409254981871, 5373.758180881948, 5376.1398176291605, 5417.5665946723375, 5443.428440013741, 5482.698451585201, 5490.6980116094, 5540.695261760642, 5593.944060559343, 5288.947110528846, 5364.597655175799, 5401.648892821954, 5466.289382380424, 5488.204210389391], "unit": "score", "name": "dojo.html", "value": 5180.1746383676755}, {"lowerIsBetter": false, "replicates": [519.9948000519994, 525.1492582017133, 527.8231792349562, 549.0912539746721, 549.5795716277046, 27672.723272767267, 28150.43699126016, 36613.63386366136, 37045.81477092611, 37113.628863711354, 39338.60661393385, 39715.0, 39746.8012659937, 39814.601853981454, 39926.600733992724, 8393.286570641487, 8585.441946273504, 8594.355423343242, 8598.828023439528, 8599.6130174142, 8433.28317093048, 8495.235428811406, 8520.74437766868, 8528.061913189544, 8555.529445880475, 8527.786805329853, 8614.267787238092, 8753.212210901018, 8773.780655483632, 8776.122387761237, 8667.17661822126, 8675.522846243422, 8748.431351962103, 8770.298376129895, 8772.868406973901, 8671.739847804576, 8806.0, 8809.515476648781, 8822.779430514225, 8826.382153249275, 38650.420243696084, 39123.60876391228, 39197.80401098005, 39207.80396098001, 39220.0, 3191.5850939377965, 3237.838108094586, 3357.9496307555405, 3359.260962588251, 3682.852685892561, 29119.563206551706, 29470.0, 29792.70207297921, 30086.0, 30663.846680766677, 3128.108489080601, 3148.4332820092372, 3203.3753418083484, 3205.9198520036953, 3277.2626159114247, 257870.2129787025, 261265.0, 262249.6887515569, 262567.0, 262807.0, 41410.58589414127, 41751.37372939409, 42007.789961050614, 42013.36979945303, 56215.0, 41544.0, 42148.367774483406, 42253.0, 42273.57726422758, 42283.577164227965, 14571.927140364442, 14674.55976320712, 14771.261436928111, 14795.778063329059, 14802.777958330633, 12120.454579543766, 12195.695107622203, 12206.0, 12241.755164896653, 12344.321062341478, 14050.0, 14215.644608884653, 14262.429502819978, 14270.571882843531, 14348.06737562055, 5601.327840659065, 5691.154422788606, 5706.828795136153, 5714.514266287329, 5770.711464426762, 848.6859861851032, 891.5809569502323, 933.2533972821716, 982.1651596143221, 992.2805965674972, 25519.362015949377, 25840.483190336086, 25849.612255816177, 25889.093881714427, 25971.22086337413, 928.5885454109715, 940.9153176214037, 955.3312681123242, 961.6105477281712, 992.8758905136858, 12756.170848894792, 12839.679008024874, 12855.550055748192, 12903.419346129447, 13214.339283036003, 301541.0, 308341.0, 311552.0, 312231.0, 312713.0, 44943.32585011228, 50874.74562627163, 51717.2242416364, 51884.0, 51946.48053519416, 1260.5525038611345, 1289.574440434673, 1294.0424086176163, 1301.3688361144837, 1313.1005261395974, 25737.485250295264, 26454.470910582066, 26669.599956001064, 27866.721332787223, 28779.71220287854, 40604.3909341366, 40982.180356392106, 41155.38266926059, 41186.79406602948, 41219.38170927379, 237927.0, 239756.0, 239811.0, 240417.0, 240472.0, 31992.840035800604, 43040.78479607582, 43068.35397468978, 43493.56506434895, 44074.77962610166, 39784.60215397809, 40215.798921006375, 40540.3918941222, 41583.37624935689, 41748.58251417447, 33520.83239583787, 33902.491462627586, 34041.31917361589, 34085.0, 34601.82699086489, 34950.475742864386, 35390.64609353874, 35424.29151417009, 38198.0, 39833.40249896312, 33497.665023350426, 38887.41668874912, 39566.0, 39627.0, 39789.0, 27947.301317466412, 31464.213394664403, 31511.84244078765, 31628.683713162573, 32380.35239295248, 25139.87430062838, 25197.408483323587, 25319.36701582475, 25449.073356564233, 25523.106691265715], "unit": "score", "name": "ext.html", "value": 17212.204688153757}, {"lowerIsBetter": false, "replicates": [360.0764040236794, 360.29382410475466, 362.4943204230098, 364.4733360294376, 366.5052179557599, 17433.82566174338, 17769.733453998186, 18098.095095245233, 18100.0, 18103.366382176628, 15979.760303595456, 16704.331826726946, 17086.658266834656, 17095.658086838255, 17107.91446042771, 5086.79652813888, 5231.555317797992, 5407.972960135194, 5411.621186516945, 5414.296141501619, 5315.069862773999, 5376.8118115865955, 5381.327334083239, 5382.6232163748555, 5385.973070134663, 3712.6472985066375, 4037.777922214277, 5378.731063446831, 5526.861828454281, 5551.417101204376, 5481.643693159952, 5494.230807686887, 5499.7250137492965, 5531.2809334786625, 5532.197831314457, 5184.585233181337, 5226.268322434862, 5277.340332458442, 5281.39263984639, 5284.048871203182, 12545.74908501834, 12926.224426534438, 12981.480740770357, 12986.870131298661, 15961.441349552826, 2022.3326302320347, 2025.9797402025938, 2035.5928814237063, 2098.5068508900395, 2232.3191426614876, 9536.380135291183, 9543.713688589354, 9677.225821934227, 10013.49932503372, 10060.295779295453, 1817.818218178185, 1867.626474705051, 1869.2336142181775, 1879.370410912346, 1914.9617007659908, 58562.7071864638, 61655.69172154111, 62224.68887655578, 62548.37451625471, 63495.0, 10036.799264014679, 10208.846867296996, 10254.53854576546, 10268.58925642966, 10303.330283531546, 13422.127561708458, 13469.797953030713, 13507.0, 13545.932270338586, 13583.117097388837, 7438.256174382518, 7450.217727138681, 7454.142773580999, 7457.47797654159, 7504.437167212372, 7214.639268036577, 7216.278372162742, 7245.7826265212125, 7251.746188883364, 7255.854882902312, 4302.526722060571, 4396.626286765597, 4527.456705195397, 4556.612687921497, 4576.679632425765, 1713.8286171382763, 1775.4673597920573, 1800.4958611588777, 1801.5406071451696, 1808.6563552925165, 684.4353408438059, 787.6613056385809, 791.5567282321803, 846.8433339832151, 921.0375157959814, 14952.70094598102, 16257.837421625632, 16306.0, 16326.265318060716, 16599.751003734953, 761.3756719489965, 841.3395484544603, 842.3640151685438, 869.1482347299682, 875.5534677314615, 7848.568328741974, 8316.334693224528, 8326.70856520019, 8449.155084491502, 8449.32405407566, 382067.0, 384104.0, 386050.0, 391877.0, 394892.0, 68660.65669671619, 69692.0, 69801.0, 70253.2974670257, 71203.0, 999.0359303272231, 1008.6469735592484, 1008.9747756306004, 1024.0680980307884, 1024.4570377699831, 13098.0, 13287.335633218494, 13550.93224533871, 13712.588622341345, 13734.381952811947, 31184.0, 31362.843185783924, 31802.0, 31866.20334491656, 33038.66961330356, 39101.6089839098, 39987.0, 40332.3950140754, 40648.390274146506, 40945.0, 7437.851242975002, 7773.766786996399, 7775.066991960774, 7915.327197188303, 8035.83928321442, 10251.538680759533, 11740.823887641864, 11742.17804753659, 11962.76074478523, 12110.939445302716, 9979.550920208463, 10072.395656260647, 10123.7469063274, 10127.442990635585, 10152.03555662211, 9967.252456065678, 9996.800063998533, 10398.636047738293, 10544.0, 10725.946370268412, 8395.664173432995, 10021.599136034478, 10222.897771022195, 10595.576176953144, 10597.735056623646, 7365.300296471826, 7512.098548174254, 7573.091229052549, 7767.844643107219, 7849.136594974434, 9509.286803489627, 10066.194704423775, 10332.793344132924, 10378.584856605954, 10534.736631583964], "unit": "score", "name": "jquery.html", "value": 7945.407691952559}, {"lowerIsBetter": false, "replicates": [1340.4035204334075, 1504.7517159668655, 1514.9545513634591, 1693.7459381092835, 1848.935287264946, 7489.850202995937, 7637.3890088792905, 7662.96168519158, 7667.92332076679, 7678.462507624468, 7577.431692623061, 7730.5361678299205, 7780.260875216845, 7781.377489800817, 7781.9221807781905, 2005.067643545751, 2272.6591011348264, 2291.46150654596, 2316.9073237070497, 2325.883705814711, 2257.808086312657, 2287.897044632987, 2289.050044231642, 2298.0233400804673, 2299.091858715806, 2166.122720298282, 2171.0447403142643, 2181.5091604388963, 2185.235167691303, 2186.7047948526906, 2186.7047948526983, 2240.551889622082, 2287.885605719724, 2293.816494680422, 2294.9655755163685, 2206.481476852938, 2226.7327920649464, 2232.7432345280176, 2232.8213742900693, 2233.4416395901026, 7826.178251283647, 7868.881966770503, 7883.645235964338, 7886.329661978739, 7904.881426778603, 4710.8351207707565, 4798.256270278112, 4800.0, 4833.661643684944, 4837.2260438329695, 3093.474109401385, 3146.276356438032, 3166.335069635379, 3194.2333839878493, 3203.0711093782775, 1017.9643712470028, 1022.4580972084807, 1026.4170478812066, 1035.0736091198335, 1068.6740544134036, 10576.312539684895, 10785.83821242682, 10803.729906752316, 10810.621628242974, 10821.9458902705, 4232.91534169321, 4235.512916014636, 4303.268444364466, 4315.331123675773, 4319.956800432018, 9268.0, 9304.627814887464, 9345.15893569582, 9348.90651093494, 9349.065093490732, 4300.182965236595, 4732.361131247307, 4738.147133516, 4774.116788394158, 4785.49752276013, 4295.6778241632, 4343.261645520269, 4356.433663623772, 4391.560843915647, 4400.471943366752, 3675.761075530082, 3697.7226707997006, 3721.7766933983507, 3747.756395834262, 3775.528058992626, 1190.5832958464468, 1193.3436609864539, 1195.4739914437619, 1197.7843988082054, 1214.2471667566165, 922.0272612393854, 930.0141849639268, 935.265816334188, 948.274569953972, 1125.2966895690195, 6774.559653622498, 6783.18601767791, 6793.388595026471, 6803.183617965876, 6834.555753875982, 460.82949308755974, 467.64926305271047, 472.7258190249647, 474.3288247130272, 474.4733345985953, 4883.780229889592, 4889.0, 4914.975425122923, 4915.139850526144, 4928.433230178575, 9249.583768730288, 9269.258459323239, 9381.718548443558, 9492.240620750323, 9505.42967421957, 9210.631574736935, 9233.769155771159, 9360.251179905592, 9371.109744574254, 9375.90624093764, 7264.818379540554, 7270.200277969419, 7382.0, 7450.962745186348, 7475.738349157753, 6541.116949211986, 6546.8363290918105, 6567.737290508326, 6567.770128045496, 6574.3754343337305, 8123.18768123183, 8397.874031889405, 8440.873386899324, 8550.786230344042, 8598.82802343962, 8573.828523429373, 8672.869906951528, 8674.0, 8840.425372350777, 8849.823003539765, 5940.851478713067, 5983.491403230774, 6083.482903953037, 6289.96855015722, 6462.224533056064, 6804.047433359433, 6889.173299203927, 6891.655417229219, 6914.688839002358, 6928.891377379595, 6147.600405973598, 6281.403266689657, 6285.654289013965, 6346.174997250328, 6381.138546296191, 6125.234345706786, 6205.348438413902, 6240.157578726814, 6257.030160325156, 6319.304876463493, 6400.0, 6427.035944608346, 6430.035494675836, 6448.0, 6506.967465162644, 5821.185034095145, 5870.765169393177, 5879.029960056714, 5887.941120588739, 5888.17565540816, 5855.59010869235, 5993.760249589967, 6001.399860013964, 6013.9699301503215, 6034.336223015377], "unit": "score", "name": "mootools.html", "value": 4258.049006306642}, {"lowerIsBetter": false, "replicates": [338.53282470191135, 343.9208981934155, 346.8543211851023, 348.07065136086646, 352.4044365023109, 5809.448102430268, 5854.590178687494, 5898.410158984099, 5905.940940590593, 5943.435373639508, 5548.167774833777, 5613.46672066154, 5743.052396354607, 5799.623024503415, 5833.629097162174, 4560.9087818243615, 4563.634909207255, 4564.338170965208, 4568.657350698702, 4577.977110114445, 4357.433533640622, 4569.565891240327, 4572.382728331682, 4574.130915126132, 4580.541945805426, 4400.889977750549, 4504.662150338721, 4514.27771556551, 4523.185826551219, 4523.592876641102, 4502.16709908668, 4506.954930450719, 4516.864494065183, 4520.50274469808, 4524.2082635538645, 4012.879613611596, 4013.819378127962, 4013.97993010036, 4019.919601607981, 4028.2144981728575, 5580.804671836466, 5582.692951887645, 5583.553315734732, 5585.078462053756, 5596.27248457702, 5268.4458084865055, 5275.076861549213, 5287.180487024518, 5289.047971365153, 5293.232481290192, 5938.524918006549, 6186.969065154645, 6194.535409844235, 6210.441060304549, 6221.0, 4305.698601097924, 4309.978450107761, 4312.956870431287, 4318.676099292566, 4319.092990472004, 6390.808275751735, 6427.582207156566, 6441.774537891151, 6456.386643268882, 6458.0, 4406.184855801687, 4408.823647054082, 4411.625011873963, 4416.359627854007, 4425.424694789656, 4465.0623369092855, 4468.374427580141, 4469.821207151677, 4473.507914129443, 4473.977630111829, 5037.773300201499, 5156.716380599103, 5164.690118592896, 5170.405403378584, 5174.404943431478, 6191.4118158774845, 6247.781327653511, 6250.406211409909, 6309.842253943596, 6321.715522801393, 1477.0768269831356, 1527.4501179575343, 1539.1073177556991, 1573.7482002879485, 1575.4564675187041, 1025.6410256410197, 1032.2825636182931, 1038.9896101039044, 1043.9269251152346, 1045.4093437207953, 5879.853003674857, 5943.494802941798, 5955.13650520672, 5957.612755170987, 5958.970205148947, 6380.840478988062, 6411.6153030818305, 6448.516361272923, 6450.41946224842, 6457.3865482779065, 5905.0, 5950.613210141327, 5952.970235148797, 5953.0, 5959.0763431668165, 3399.3201359728155, 3436.295559410315, 3440.7591468597457, 3442.535257740223, 3442.7417943653827, 6519.576227545289, 6692.799216023527, 6704.664766761643, 6842.863142737117, 6850.623215723083, 6612.371824676648, 6623.602583844985, 6648.33516648341, 6650.135482387259, 6656.167979002625, 6814.386705196655, 6821.69302381394, 6823.965880170567, 6824.304399762066, 6825.385715285648, 6474.320196379501, 6481.481481481376, 6482.319356467691, 6484.092227088306, 6489.318621544859, 6218.844528886814, 6365.14070600463, 6420.357964203542, 6433.935660643521, 6434.967825160844, 6800.251972283144, 6829.692663830239, 6830.692618832264, 6834.077399550997, 6840.828979275558, 4380.0, 4383.553427368897, 4415.845445409395, 4417.0724147929295, 4417.801198945991, 6214.9689251553455, 6296.33888441707, 6452.870747619054, 6460.095586617971, 6486.675666216576, 6252.187215662117, 6299.0, 6309.779157729457, 6314.179156709598, 6319.05214217871, 6244.0321750128805, 6248.875022499616, 6250.343713910156, 6257.43683068526, 6257.780977665942, 6194.0708893666315, 6195.721192546436, 6206.410391012847, 6207.441330280297, 6210.441060304594, 6160.260768707604, 6282.780102696383, 6283.717232724447, 6328.746850125944, 6335.841603959938, 6132.846678833065, 6138.109974053648, 6161.6919154041225, 6168.1056246844855, 6172.845678857885], "unit": "score", "name": "prototype.html", "value": 4716.557652283285}, {"lowerIsBetter": false, "replicates": [648.2674577727165, 671.5131529641008, 699.5557820783804, 782.2685788787483, 801.3869389916715, 12975.805362919553, 13150.079494435382, 13153.539626113088, 13168.934155329234, 13186.142900711448, 12417.068719846002, 12492.250464972085, 12500.749985000295, 13413.061085724003, 13806.102603330777, 814.8655471847138, 826.1985873702529, 826.3760860550307, 831.2435683527991, 832.5545832979358, 828.0973738624928, 829.7676650537829, 830.3274347778289, 830.4809494066209, 830.5764060329216, 854.9615267312955, 855.9315254779634, 858.2490320969152, 858.6136238692582, 861.8491763941316, 853.4665833853842, 854.7350321400355, 859.7463748194298, 864.5849992003873, 870.6909047288248, 639.25526761323, 641.1120597971797, 642.983925401864, 643.0964494884695, 643.5816719132602, 13542.932285338511, 13572.96405539167, 13574.524891628746, 13605.591832245049, 13619.319034048358, 11890.702732431671, 11963.342016189106, 12040.939795300967, 12398.380080995914, 12808.23150610957, 9670.854937175947, 9745.171660408874, 9811.001269951956, 9917.900820991843, 10264.332818366782, 3424.417848965682, 3445.155936795501, 3476.0962149841225, 3482.181687303482, 3490.1798077451776, 43558.34662480065, 44193.55806441959, 49295.50704492945, 49685.50314496845, 52276.47723522754, 9850.950745246371, 9867.259955503367, 9900.158486528582, 10022.699319020441, 10305.896941030494, 16989.575260618338, 17348.566285842702, 17800.46598602044, 17828.910855445898, 17833.0, 7594.848103037908, 7870.72452464161, 7887.329576985906, 7916.762497125095, 8028.237317454832, 4206.26390381682, 4249.3625956106835, 4285.121550082225, 4347.739135651871, 4351.543087975717, 3020.909372718822, 3027.2734543709353, 3039.3161538653626, 3042.558828969787, 3043.223977885625, 577.8555361159711, 600.207725801946, 606.686523676236, 614.708013693492, 626.9686515674198, 585.1398444286891, 591.1457943272017, 597.172915512019, 630.3853742600927, 668.4652278177439, 8009.519428834288, 8109.797255068671, 8141.715039973691, 8261.215184557457, 8317.584120793936, 568.590614757374, 584.4243420231069, 635.6091004032579, 668.6644047648491, 676.4926305271047, 3648.821930558483, 3770.547534295847, 3844.59631738669, 3902.102516421239, 3908.2769687607315, 59805.401945980855, 60038.0, 60655.0, 60689.69655151696, 60865.39134608597, 42558.36162457566, 45397.54602453933, 46727.13091476371, 50612.0, 50739.0, 41434.0, 42193.57806421958, 42197.367039494435, 42394.0, 45640.5435945643, 8494.957525212334, 8763.868541972002, 8795.384323097578, 8868.246199073152, 8937.46375217489, 27687.0, 34207.48688769621, 34402.82798585991, 34890.12774680653, 35595.82202088973, 40681.38977915393, 43971.78014109909, 44469.55530444654, 46193.76903115463, 46313.3053004212, 11138.3873886937, 11154.498047587716, 11325.433728313716, 11327.546898123983, 11343.489542970421, 11570.826437603275, 11617.070634349062, 11867.287962722265, 12248.571300004458, 12250.75498490043, 10759.946200268949, 11153.21927465102, 11213.66359009231, 11261.099112071179, 11308.830367544659, 10926.453677315943, 10939.835902461311, 10941.945290273497, 11249.49377278008, 11650.70873228176, 10894.346339219355, 11197.328160310408, 11240.83138752903, 11375.715607109558, 11449.59926402572, 9600.863538007132, 9809.55856986423, 9838.704838854846, 9992.150667193078, 10000.0, 8889.0, 9142.75441207332, 9261.439604078934, 9752.122308992224, 9810.558524866256], "unit": "score", "name": "yui.html", "value": 6224.7124033721475}], "name": "dromaeo_css", "value": 6676.490608058411}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 111.0, 113.0, 111.0, 101.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 149.0, 160.0, 126.0, 153.0, 157.0, 140.0, 171.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 170.0, 160.0, 161.0, 160.0, 161.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 98.0, 101.0, 73.0, 75.0, 75.0, 115.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 144.0, 97.0, 97.0, 96.0, 135.0, 96.0, 97.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [152.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 57.0, 56.0, 57.0, 55.0, 57.0, 69.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 82.0, 84.0, 83.0, 83.0, 90.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [117.0, 132.0, 117.0, 117.0, 117.0, 119.0, 116.0, 119.0, 133.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 155.0, 160.0, 149.0, 140.0, 145.0, 148.0, 161.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 70.0, 69.0, 70.0, 67.0, 70.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1518.5}]} 05:33:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1518.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6676.49"}}} 05:33:38 INFO - Return code: 0 05:33:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:33:38 INFO - # TBPL SUCCESS # 05:33:38 INFO - Running post-action listener: _resource_record_post_action 05:33:38 INFO - Running post-run listener: _resource_record_post_run 05:33:39 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 20480; Write bytes: 539688960; Read time: 36; Write time: 445192 05:33:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 240762880; Read time: 0; Write time: 237720 05:33:39 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 20480; Write bytes: 298926080; Read time: 36; Write time: 207472 05:33:39 INFO - Running post-run listener: _upload_blobber_files 05:33:39 INFO - Blob upload gear active. 05:33:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:33:39 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 05:33:39 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'] 05:33:39 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 05:33:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:41 INFO - (blobuploader) - INFO - Done attempting. 05:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:33:41 INFO - (blobuploader) - INFO - Done attempting. 05:33:41 INFO - (blobuploader) - INFO - Iteration through files over. 05:33:41 INFO - Return code: 0 05:33:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:33:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:33:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42376e3fde8c6f8a0a310886e6c3a7086c5062d4752f0be8085db090b4feb0ac039a98330864c4e0502ae9973ad56749d5977f65581a8c3483adf5d46d45a058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee79e516cb18af2ebe28c31f3d99ae65d16357a5ede99760bcb1863decc6247fecb4cd85459f3a064f79816a9b1ebe2790d74e6109e073e9ca515a25da42ae64"} 05:33:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:33:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:33:41 INFO - Contents: 05:33:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42376e3fde8c6f8a0a310886e6c3a7086c5062d4752f0be8085db090b4feb0ac039a98330864c4e0502ae9973ad56749d5977f65581a8c3483adf5d46d45a058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee79e516cb18af2ebe28c31f3d99ae65d16357a5ede99760bcb1863decc6247fecb4cd85459f3a064f79816a9b1ebe2790d74e6109e073e9ca515a25da42ae64"} 05:33:41 INFO - Running post-run listener: copy_logs_to_upload_dir 05:33:41 INFO - Copying logs to upload dir... 05:33:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:33:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.211478 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-24 05:33:41.959202) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 05:33:41.962629) ========= 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-1456319584.219831-1485914459 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/42376e3fde8c6f8a0a310886e6c3a7086c5062d4752f0be8085db090b4feb0ac039a98330864c4e0502ae9973ad56749d5977f65581a8c3483adf5d46d45a058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee79e516cb18af2ebe28c31f3d99ae65d16357a5ede99760bcb1863decc6247fecb4cd85459f3a064f79816a9b1ebe2790d74e6109e073e9ca515a25da42ae64"} build_url:https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/fo2WYlVBRxuui64WuGVjuA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42376e3fde8c6f8a0a310886e6c3a7086c5062d4752f0be8085db090b4feb0ac039a98330864c4e0502ae9973ad56749d5977f65581a8c3483adf5d46d45a058", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee79e516cb18af2ebe28c31f3d99ae65d16357a5ede99760bcb1863decc6247fecb4cd85459f3a064f79816a9b1ebe2790d74e6109e073e9ca515a25da42ae64"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 05:33:41.986930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:33:41.987267) ========= 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-1456319584.219831-1485914459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 05:33:42.072278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 05:33:42.072615) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 05:33:42.072955) ========= ========= Total master_lag: 0.28 =========