builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1455721523.44 results: success (0) buildid: 20160217043011 builduid: 63b3119717ef4d0d93612e6a3c47f549 revision: c007ec81b75ae1c51da2c2d2bab21180290fab6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.435789) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.436235) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.436532) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004343 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.490637) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.490973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.503275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.503595) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.553056) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.555375) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.555757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.556055) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 07:05:23-- 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% 222M=0s 2016-02-17 07:05:24 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167176 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.736393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.736752) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018697 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.786157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:23.786510) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c007ec81b75ae1c51da2c2d2bab21180290fab6b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c007ec81b75ae1c51da2c2d2bab21180290fab6b --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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 07:05:24,177 truncating revision to first 12 chars 2016-02-17 07:05:24,177 Setting DEBUG logging. 2016-02-17 07:05:24,177 attempt 1/10 2016-02-17 07:05:24,177 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c007ec81b75a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 07:05:24,541 unpacking tar archive at: mozilla-central-c007ec81b75a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696840 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:24.497395) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:24.497697) ========= echo c007ec81b75ae1c51da2c2d2bab21180290fab6b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c007ec81b75ae1c51da2c2d2bab21180290fab6b'] 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c007ec81b75ae1c51da2c2d2bab21180290fab6b program finished with exit code 0 elapsedTime=0.004712 script_repo_revision: 'c007ec81b75ae1c51da2c2d2bab21180290fab6b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:24.549233) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:24.549557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 07:05:24.560064) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-17 07:05:24.560498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:25 INFO - MultiFileLogger online at 20160217 07:05:25 in /builds/slave/test-pgo 07:05:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:05:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:05:25 INFO - {'append_to_log': False, 07:05:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:05:25 INFO - 'blob_upload_branch': 'Firefox', 07:05:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:05:25 INFO - 'branch': 'Firefox', 07:05:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:25 INFO - 'config_files': ('talos/linux_config.py',), 07:05:25 INFO - 'default_actions': ('clobber', 07:05:25 INFO - 'read-buildbot-config', 07:05:25 INFO - 'download-and-extract', 07:05:25 INFO - 'populate-webroot', 07:05:25 INFO - 'create-virtualenv', 07:05:25 INFO - 'install', 07:05:25 INFO - 'run-tests'), 07:05:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:25 INFO - 'download_minidump_stackwalk': True, 07:05:25 INFO - 'download_symbols': 'ondemand', 07:05:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:25 INFO - 'installer_path': 'installer.exe', 07:05:25 INFO - 'log_level': 'info', 07:05:25 INFO - 'log_name': 'talos', 07:05:25 INFO - 'log_to_console': True, 07:05:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:25 INFO - 'opt_config_files': (), 07:05:25 INFO - 'pip_index': False, 07:05:25 INFO - 'sps_profile': False, 07:05:25 INFO - 'sps_profile_interval': 0, 07:05:25 INFO - 'suite': 'dromaeojs', 07:05:25 INFO - 'system_bits': '32', 07:05:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:25 INFO - 'title': 'talos-linux64-ix-047', 07:05:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:25 INFO - 'use_talos_json': True, 07:05:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:05:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:25 INFO - 'work_dir': 'build'} 07:05:25 INFO - ##### 07:05:25 INFO - ##### Running clobber step. 07:05:25 INFO - ##### 07:05:25 INFO - Running pre-action listener: _resource_record_pre_action 07:05:25 INFO - Running main action method: clobber 07:05:25 INFO - rmtree: /builds/slave/test-pgo/build 07:05:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:05:26 INFO - Running post-action listener: _resource_record_post_action 07:05:26 INFO - ##### 07:05:26 INFO - ##### Running read-buildbot-config step. 07:05:26 INFO - ##### 07:05:26 INFO - Running pre-action listener: _resource_record_pre_action 07:05:26 INFO - Running main action method: read_buildbot_config 07:05:26 INFO - Using buildbot properties: 07:05:26 INFO - { 07:05:26 INFO - "project": "", 07:05:26 INFO - "product": "firefox", 07:05:26 INFO - "script_repo_revision": "production", 07:05:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:05:26 INFO - "repository": "", 07:05:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:05:26 INFO - "buildid": "20160217043011", 07:05:26 INFO - "pgo_build": "True", 07:05:26 INFO - "basedir": "/builds/slave/test-pgo", 07:05:26 INFO - "buildnumber": 677, 07:05:26 INFO - "slavename": "talos-linux64-ix-047", 07:05:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:05:26 INFO - "platform": "ubuntu64_hw", 07:05:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:05:26 INFO - "branch": "mozilla-central", 07:05:26 INFO - "repo_path": "mozilla-central", 07:05:26 INFO - "revision": "c007ec81b75ae1c51da2c2d2bab21180290fab6b", 07:05:26 INFO - "stage_platform": "linux64-pgo", 07:05:26 INFO - "builduid": "63b3119717ef4d0d93612e6a3c47f549", 07:05:26 INFO - "slavebuilddir": "test" 07:05:26 INFO - } 07:05:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 07:05:26 INFO - Running post-action listener: _resource_record_post_action 07:05:26 INFO - ##### 07:05:26 INFO - ##### Running download-and-extract step. 07:05:26 INFO - ##### 07:05:26 INFO - Running pre-action listener: _resource_record_pre_action 07:05:26 INFO - Running main action method: download_and_extract 07:05:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:05: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')]} 07:05:26 INFO - https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:05:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/test_packages.json 07:05:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/test_packages.json 07:05:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:05:28 INFO - Downloaded 1448 bytes. 07:05:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:05:28 INFO - Using the following test package requirements: 07:05:28 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:05:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'jsshell-linux-x86_64.zip'], 07:05:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:05:28 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:05:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:28 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:28 INFO - https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:31 INFO - Downloaded 23346387 bytes. 07:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:05:32 INFO - Return code: 0 07:05:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:32 INFO - https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:34 INFO - Downloaded 23346387 bytes. 07:05:34 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'] 07:05:34 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 07:05:35 INFO - Return code: 0 07:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:35 INFO - https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:05:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:36 INFO - Downloaded 10707071 bytes. 07:05:36 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'] 07:05:36 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 07:05:36 INFO - Return code: 0 07:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:36 INFO - https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:05:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:05:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:05:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3Biz1efSimhoQMivPEflA/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 07:05:37 INFO - Downloaded 56588872 bytes. 07:05:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:05:37 INFO - mkdir: /builds/slave/test-pgo/properties 07:05:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:05:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:05:37 INFO - Contents: 07:05:37 INFO - build_url:https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:05:38 INFO - Running post-action listener: _resource_record_post_action 07:05:38 INFO - Running post-action listener: set_extra_try_arguments 07:05:38 INFO - ##### 07:05:38 INFO - ##### Running populate-webroot step. 07:05:38 INFO - ##### 07:05:38 INFO - Running pre-action listener: _resource_record_pre_action 07:05:38 INFO - Running main action method: populate_webroot 07:05:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:38 INFO - '--tppagecycles', 07:05:38 INFO - '7'], 07:05:38 INFO - 'tests': ['tsvgm']}}, 07:05:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:05:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:05:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'tests': ['damp', 'tps']}, 07:05:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['damp', 'tps']}, 07:05:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:05:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:38 INFO - 'other': {'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'other_l64': {'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'other_nol64': {'tests': ['a11yr', 07:05:38 INFO - 'ts_paint', 07:05:38 INFO - 'tpaint', 07:05:38 INFO - 'sessionrestore', 07:05:38 INFO - 'sessionrestore_no_auto_restore']}, 07:05:38 INFO - 'svgr': {'tests': ['tsvgx', 07:05:38 INFO - 'tsvgr_opacity', 07:05:38 INFO - 'tart', 07:05:38 INFO - 'tscrollx', 07:05:38 INFO - 'cart']}, 07:05:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['tsvgx', 07:05:38 INFO - 'tsvgr_opacity', 07:05:38 INFO - 'tart', 07:05:38 INFO - 'tscrollx', 07:05:38 INFO - 'cart']}, 07:05:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'tests': ['tp5o']}, 07:05:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'talos_options': ['--e10s'], 07:05:38 INFO - 'tests': ['tp5o']}, 07:05:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'talos_options': ['--xperf_path', 07:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:38 INFO - 'tests': ['tp5n']}, 07:05:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:38 INFO - 'talos_options': ['--e10s', 07:05:38 INFO - '--xperf_path', 07:05:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:38 INFO - 'tests': ['tp5n']}}, 07:05:38 INFO - 'talos.zip': {'path': '', 07:05:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:38 INFO - Running post-action listener: _resource_record_post_action 07:05:38 INFO - ##### 07:05:38 INFO - ##### Running create-virtualenv step. 07:05:38 INFO - ##### 07:05:38 INFO - Running pre-action listener: _resource_record_pre_action 07:05:38 INFO - Running main action method: create_virtualenv 07:05:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:05:38 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 07:05:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:05:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:38 INFO - Using real prefix '/usr' 07:05:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:05:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:41 INFO - Installing pip.................done. 07:05:41 INFO - Return code: 0 07:05:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:05: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')]} 07:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:41 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:41 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 07:05:41 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 07:05:41 INFO - Using env: {'DISPLAY': ':0', 07:05:41 INFO - 'HOME': '/home/cltbld', 07:05:41 INFO - 'LANG': 'en_US.UTF-8', 07:05:41 INFO - 'LANGUAGE': 'en_US:en', 07:05:41 INFO - 'LOGNAME': 'cltbld', 07:05:41 INFO - 'MAIL': '/var/mail/cltbld', 07:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:41 INFO - 'MOZ_NO_REMOTE': '1', 07:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:41 INFO - 'NO_EM_RESTART': '1', 07:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:41 INFO - 'SHELL': '/bin/bash', 07:05:41 INFO - 'SHLVL': '1', 07:05:41 INFO - 'TERM': 'linux', 07:05:41 INFO - 'TMOUT': '86400', 07:05:41 INFO - 'USER': 'cltbld', 07:05:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:41 INFO - '_': '/tools/buildbot/bin/python'} 07:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:41 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 07:05:41 INFO - Cleaning up... 07:05:41 INFO - Return code: 0 07:05:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:05: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')]} 07:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:41 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:41 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 07:05:41 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 07:05:41 INFO - Using env: {'DISPLAY': ':0', 07:05:41 INFO - 'HOME': '/home/cltbld', 07:05:41 INFO - 'LANG': 'en_US.UTF-8', 07:05:41 INFO - 'LANGUAGE': 'en_US:en', 07:05:41 INFO - 'LOGNAME': 'cltbld', 07:05:41 INFO - 'MAIL': '/var/mail/cltbld', 07:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:41 INFO - 'MOZ_NO_REMOTE': '1', 07:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:41 INFO - 'NO_EM_RESTART': '1', 07:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:41 INFO - 'SHELL': '/bin/bash', 07:05:41 INFO - 'SHLVL': '1', 07:05:41 INFO - 'TERM': 'linux', 07:05:41 INFO - 'TMOUT': '86400', 07:05:41 INFO - 'USER': 'cltbld', 07:05:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:41 INFO - '_': '/tools/buildbot/bin/python'} 07:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:41 INFO - Downloading/unpacking psutil>=0.7.1 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:41 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 07:05:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:43 INFO - Installing collected packages: psutil 07:05:43 INFO - Running setup.py install for psutil 07:05:43 INFO - building 'psutil._psutil_linux' extension 07:05:43 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 07:05:43 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 07:05:43 INFO - building 'psutil._psutil_posix' extension 07:05:43 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 07:05:43 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 07:05:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:44 INFO - Successfully installed psutil 07:05:44 INFO - Cleaning up... 07:05:44 INFO - Return code: 0 07:05:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:05: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')]} 07:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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', '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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:05: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 mozsystemmonitor==0.0.0 07:05:44 INFO - Using env: {'DISPLAY': ':0', 07:05:44 INFO - 'HOME': '/home/cltbld', 07:05:44 INFO - 'LANG': 'en_US.UTF-8', 07:05:44 INFO - 'LANGUAGE': 'en_US:en', 07:05:44 INFO - 'LOGNAME': 'cltbld', 07:05:44 INFO - 'MAIL': '/var/mail/cltbld', 07:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:44 INFO - 'MOZ_NO_REMOTE': '1', 07:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:44 INFO - 'NO_EM_RESTART': '1', 07:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:44 INFO - 'SHELL': '/bin/bash', 07:05:44 INFO - 'SHLVL': '1', 07:05:44 INFO - 'TERM': 'linux', 07:05:44 INFO - 'TMOUT': '86400', 07:05:44 INFO - 'USER': 'cltbld', 07:05:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:44 INFO - '_': '/tools/buildbot/bin/python'} 07:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:05:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:05:46 INFO - Installing collected packages: mozsystemmonitor 07:05:46 INFO - Running setup.py install for mozsystemmonitor 07:05:46 INFO - Successfully installed mozsystemmonitor 07:05:46 INFO - Cleaning up... 07:05:46 INFO - Return code: 0 07:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:05:46 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')]} 07:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:46 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')]} 07:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:46 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:46 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 07:05:46 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 07:05:46 INFO - Using env: {'DISPLAY': ':0', 07:05:46 INFO - 'HOME': '/home/cltbld', 07:05:46 INFO - 'LANG': 'en_US.UTF-8', 07:05:46 INFO - 'LANGUAGE': 'en_US:en', 07:05:46 INFO - 'LOGNAME': 'cltbld', 07:05:46 INFO - 'MAIL': '/var/mail/cltbld', 07:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:46 INFO - 'MOZ_NO_REMOTE': '1', 07:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:46 INFO - 'NO_EM_RESTART': '1', 07:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:46 INFO - 'SHELL': '/bin/bash', 07:05:46 INFO - 'SHLVL': '1', 07:05:46 INFO - 'TERM': 'linux', 07:05:46 INFO - 'TMOUT': '86400', 07:05:46 INFO - 'USER': 'cltbld', 07:05:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:46 INFO - '_': '/tools/buildbot/bin/python'} 07:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05: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 07:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:05:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:48 INFO - Downloading docopt-0.6.1.tar.gz 07:05:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:05:49 INFO - Running setup.py install for blobuploader 07:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:05:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:05:49 INFO - Running setup.py install for requests 07:05:49 INFO - Running setup.py install for docopt 07:05:49 INFO - Successfully installed blobuploader requests docopt 07:05:49 INFO - Cleaning up... 07:05:49 INFO - Return code: 0 07:05:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:05:49 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')]} 07:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 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')]} 07:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:49 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:49 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 07:05:49 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 07:05:49 INFO - Using env: {'DISPLAY': ':0', 07:05:49 INFO - 'HOME': '/home/cltbld', 07:05:49 INFO - 'LANG': 'en_US.UTF-8', 07:05:49 INFO - 'LANGUAGE': 'en_US:en', 07:05:49 INFO - 'LOGNAME': 'cltbld', 07:05:49 INFO - 'MAIL': '/var/mail/cltbld', 07:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:49 INFO - 'MOZ_NO_REMOTE': '1', 07:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:49 INFO - 'NO_EM_RESTART': '1', 07:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:49 INFO - 'SHELL': '/bin/bash', 07:05:49 INFO - 'SHLVL': '1', 07:05:49 INFO - 'TERM': 'linux', 07:05:49 INFO - 'TMOUT': '86400', 07:05:49 INFO - 'USER': 'cltbld', 07:05:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:49 INFO - '_': '/tools/buildbot/bin/python'} 07:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:05:49 INFO - Running setup.py (path:/tmp/pip-Q2sFI8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:05:49 INFO - Running setup.py (path:/tmp/pip-IW42d1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:05:49 INFO - Running setup.py (path:/tmp/pip-0HvQwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:05:50 INFO - Running setup.py (path:/tmp/pip-szJFKF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:05:50 INFO - Running setup.py (path:/tmp/pip-x7qk0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:05:50 INFO - Running setup.py (path:/tmp/pip-CYkOcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:05:50 INFO - Running setup.py (path:/tmp/pip-YiXw_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:05:50 INFO - Running setup.py (path:/tmp/pip-ZRPNem-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:05:50 INFO - Running setup.py (path:/tmp/pip-eNcWyb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:05:50 INFO - Running setup.py (path:/tmp/pip-aN3lqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:05:50 INFO - Running setup.py (path:/tmp/pip-gjWXML-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:05:50 INFO - Running setup.py (path:/tmp/pip-dqRv7L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:05:50 INFO - Running setup.py (path:/tmp/pip-ZIUvsT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:05:50 INFO - Running setup.py (path:/tmp/pip-J1S2vr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:05:50 INFO - Running setup.py (path:/tmp/pip-vRkjYf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:05:50 INFO - Running setup.py (path:/tmp/pip-fBlbhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:05:50 INFO - Running setup.py (path:/tmp/pip-NxvLDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:05:51 INFO - Running setup.py install for manifestparser 07:05:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Running setup.py install for mozcrash 07:05:51 INFO - Running setup.py install for mozdebug 07:05:51 INFO - Running setup.py install for mozdevice 07:05:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Running setup.py install for mozfile 07:05:51 INFO - Running setup.py install for mozhttpd 07:05:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Running setup.py install for mozinfo 07:05:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Running setup.py install for mozInstall 07:05:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:05:51 INFO - Running setup.py install for mozleak 07:05:51 INFO - Running setup.py install for mozlog 07:05:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Running setup.py install for moznetwork 07:05:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Running setup.py install for mozprocess 07:05:52 INFO - Running setup.py install for mozprofile 07:05:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Running setup.py install for mozrunner 07:05:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Running setup.py install for mozscreenshot 07:05:52 INFO - Running setup.py install for moztest 07:05:52 INFO - Running setup.py install for mozversion 07:05:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:05:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:05:52 INFO - Cleaning up... 07:05:52 INFO - Return code: 0 07:05:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:05:52 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')]} 07:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:52 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')]} 07:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:52 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:52 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 07:05:52 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 07:05:52 INFO - Using env: {'DISPLAY': ':0', 07:05:52 INFO - 'HOME': '/home/cltbld', 07:05:52 INFO - 'LANG': 'en_US.UTF-8', 07:05:52 INFO - 'LANGUAGE': 'en_US:en', 07:05:52 INFO - 'LOGNAME': 'cltbld', 07:05:52 INFO - 'MAIL': '/var/mail/cltbld', 07:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:52 INFO - 'MOZ_NO_REMOTE': '1', 07:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:52 INFO - 'NO_EM_RESTART': '1', 07:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:52 INFO - 'SHELL': '/bin/bash', 07:05:52 INFO - 'SHLVL': '1', 07:05:52 INFO - 'TERM': 'linux', 07:05:52 INFO - 'TMOUT': '86400', 07:05:52 INFO - 'USER': 'cltbld', 07:05:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:52 INFO - '_': '/tools/buildbot/bin/python'} 07:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:05:53 INFO - Running setup.py (path:/tmp/pip-WJw3bH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:05:53 INFO - Running setup.py (path:/tmp/pip-tKW2Co-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:05:53 INFO - Running setup.py (path:/tmp/pip-JLZM9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:05:53 INFO - Running setup.py (path:/tmp/pip-TMoLOz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:05:53 INFO - Running setup.py (path:/tmp/pip-dMm6l5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:05:53 INFO - Running setup.py (path:/tmp/pip-ZjhnWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:05:53 INFO - Running setup.py (path:/tmp/pip-u39ITV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:05:53 INFO - Running setup.py (path:/tmp/pip-i8CCg6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:05:53 INFO - Running setup.py (path:/tmp/pip-To8lqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:05:53 INFO - Running setup.py (path:/tmp/pip-ceIj_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:05:53 INFO - Running setup.py (path:/tmp/pip-63Gpeg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:05:53 INFO - Running setup.py (path:/tmp/pip-mjhBFX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:05:53 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)) 07:05:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:05:53 INFO - Running setup.py (path:/tmp/pip-mbKbS_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:05:54 INFO - Running setup.py (path:/tmp/pip-XWkvKV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:05:54 INFO - Running setup.py (path:/tmp/pip-iDhdHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:05:54 INFO - Running setup.py (path:/tmp/pip-xSSpwO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:05:54 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)) 07:05:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:05:54 INFO - Running setup.py (path:/tmp/pip-rwd0T5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 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)) 07:05:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:05:54 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 07:05:54 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 07:05:54 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 07:05:54 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 07:05:54 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 07:05:54 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 07:05:56 INFO - Downloading blessings-1.6.tar.gz 07:05:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:05:56 INFO - Installing collected packages: blessings 07:05:56 INFO - Running setup.py install for blessings 07:05:56 INFO - Successfully installed blessings 07:05:56 INFO - Cleaning up... 07:05:56 INFO - Return code: 0 07:05:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:05:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:05:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:05:56 INFO - Reading from file tmpfile_stdout 07:05:56 INFO - Current package versions: 07:05:56 INFO - argparse == 1.2.1 07:05:56 INFO - blessings == 1.6 07:05:56 INFO - blobuploader == 1.2.4 07:05:56 INFO - docopt == 0.6.1 07:05:56 INFO - manifestparser == 1.1 07:05:56 INFO - mozInstall == 1.12 07:05:56 INFO - mozcrash == 0.16 07:05:56 INFO - mozdebug == 0.1 07:05:56 INFO - mozdevice == 0.48 07:05:56 INFO - mozfile == 1.2 07:05:56 INFO - mozhttpd == 0.7 07:05:56 INFO - mozinfo == 0.9 07:05:56 INFO - mozleak == 0.1 07:05:56 INFO - mozlog == 3.1 07:05:56 INFO - moznetwork == 0.27 07:05:56 INFO - mozprocess == 0.22 07:05:56 INFO - mozprofile == 0.28 07:05:56 INFO - mozrunner == 6.11 07:05:56 INFO - mozscreenshot == 0.1 07:05:56 INFO - mozsystemmonitor == 0.0 07:05:56 INFO - moztest == 0.7 07:05:56 INFO - mozversion == 1.4 07:05:56 INFO - psutil == 3.1.1 07:05:56 INFO - requests == 1.2.3 07:05:56 INFO - wsgiref == 0.1.2 07:05:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:56 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 07:05:56 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 07:05:56 INFO - Using env: {'DISPLAY': ':0', 07:05:56 INFO - 'HOME': '/home/cltbld', 07:05:56 INFO - 'LANG': 'en_US.UTF-8', 07:05:56 INFO - 'LANGUAGE': 'en_US:en', 07:05:56 INFO - 'LOGNAME': 'cltbld', 07:05:56 INFO - 'MAIL': '/var/mail/cltbld', 07:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:56 INFO - 'MOZ_NO_REMOTE': '1', 07:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:56 INFO - 'NO_EM_RESTART': '1', 07:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:56 INFO - 'SHELL': '/bin/bash', 07:05:56 INFO - 'SHLVL': '1', 07:05:56 INFO - 'TERM': 'linux', 07:05:56 INFO - 'TMOUT': '86400', 07:05:56 INFO - 'USER': 'cltbld', 07:05:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:56 INFO - '_': '/tools/buildbot/bin/python'} 07:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 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)) 07:05:56 INFO - Cleaning up... 07:05:56 INFO - Return code: 0 07:05:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:56 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 07:05:56 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 07:05:56 INFO - Using env: {'DISPLAY': ':0', 07:05:56 INFO - 'HOME': '/home/cltbld', 07:05:56 INFO - 'LANG': 'en_US.UTF-8', 07:05:56 INFO - 'LANGUAGE': 'en_US:en', 07:05:56 INFO - 'LOGNAME': 'cltbld', 07:05:56 INFO - 'MAIL': '/var/mail/cltbld', 07:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:56 INFO - 'MOZ_NO_REMOTE': '1', 07:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:56 INFO - 'NO_EM_RESTART': '1', 07:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:56 INFO - 'SHELL': '/bin/bash', 07:05:56 INFO - 'SHLVL': '1', 07:05:56 INFO - 'TERM': 'linux', 07:05:56 INFO - 'TMOUT': '86400', 07:05:56 INFO - 'USER': 'cltbld', 07:05:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:56 INFO - '_': '/tools/buildbot/bin/python'} 07:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:57 INFO - Downloading/unpacking jsonschema 07:05:57 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 07:05:57 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 07:05:57 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 07:05:57 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 07:05:57 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 07:05:57 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 07:05:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:05:58 INFO - Downloading/unpacking functools32 (from jsonschema) 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:05:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:05:59 INFO - warning: no files found matching '*.txt' 07:05:59 INFO - no previously-included directories found matching 'build' 07:05:59 INFO - no previously-included directories found matching 'dist' 07:05:59 INFO - no previously-included directories found matching '.git*' 07:05:59 INFO - Installing collected packages: jsonschema, functools32 07:05:59 INFO - Running setup.py install for functools32 07:05:59 INFO - warning: no files found matching '*.txt' 07:05:59 INFO - no previously-included directories found matching 'build' 07:05:59 INFO - no previously-included directories found matching 'dist' 07:05:59 INFO - no previously-included directories found matching '.git*' 07:05:59 INFO - Successfully installed jsonschema functools32 07:05:59 INFO - Cleaning up... 07:05:59 INFO - Return code: 0 07:05:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 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 0x7fbedf097f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c61670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, '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': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', '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 07:05:59 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 07:05:59 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 07:05:59 INFO - Using env: {'DISPLAY': ':0', 07:05:59 INFO - 'HOME': '/home/cltbld', 07:05:59 INFO - 'LANG': 'en_US.UTF-8', 07:05:59 INFO - 'LANGUAGE': 'en_US:en', 07:05:59 INFO - 'LOGNAME': 'cltbld', 07:05:59 INFO - 'MAIL': '/var/mail/cltbld', 07:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:59 INFO - 'MOZ_NO_REMOTE': '1', 07:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:59 INFO - 'NO_EM_RESTART': '1', 07:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:05:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:05:59 INFO - 'SHELL': '/bin/bash', 07:05:59 INFO - 'SHLVL': '1', 07:05:59 INFO - 'TERM': 'linux', 07:05:59 INFO - 'TMOUT': '86400', 07:05:59 INFO - 'USER': 'cltbld', 07:05:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:59 INFO - '_': '/tools/buildbot/bin/python'} 07:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:59 INFO - Downloading/unpacking flake8 07:05:59 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 07:05:59 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 07:05:59 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 07:05:59 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 07:05:59 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 07:05:59 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 07:06:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:06:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:06:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:01 INFO - no previously-included directories found matching 'docs/_build' 07:06:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:06:02 INFO - Running setup.py install for pep8 07:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:06:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:06:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:06:02 INFO - no previously-included directories found matching 'docs/_build' 07:06:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:06:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:06:02 INFO - Cleaning up... 07:06:02 INFO - Return code: 0 07:06:02 INFO - Running post-action listener: _resource_record_post_action 07:06:02 INFO - Running post-action listener: _start_resource_monitoring 07:06:02 INFO - Starting resource monitoring. 07:06:02 INFO - ##### 07:06:02 INFO - ##### Running install step. 07:06:02 INFO - ##### 07:06:02 INFO - Running pre-action listener: _resource_record_pre_action 07:06:02 INFO - Running main action method: install 07:06:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:06:02 INFO - Reading from file tmpfile_stdout 07:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:06:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:06:02 INFO - Reading from file tmpfile_stdout 07:06:02 INFO - Output received: 07:06:02 INFO - Usage: mozinstall [options] installer 07:06:02 INFO - Options: 07:06:02 INFO - -h, --help show this help message and exit 07:06:02 INFO - -d DEST, --destination=DEST 07:06:02 INFO - Directory to install application into. [default: 07:06:02 INFO - "/builds/slave/test-pgo"] 07:06:02 INFO - --app=APP Application being installed. [default: firefox] 07:06:02 INFO - mkdir: /builds/slave/test-pgo/build/application 07:06:02 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'] 07:06:02 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 07:06:18 INFO - Reading from file tmpfile_stdout 07:06:18 INFO - Output received: 07:06:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:06:18 INFO - Running post-action listener: _resource_record_post_action 07:06:18 INFO - ##### 07:06:18 INFO - ##### Running run-tests step. 07:06:18 INFO - ##### 07:06:18 INFO - Running pre-action listener: _resource_record_pre_action 07:06:18 INFO - Running main action method: run_tests 07:06:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:06:18 INFO - Python 2.7.3 07:06:18 INFO - Return code: 0 07:06:18 INFO - grabbing minidump binary from tooltool 07:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:18 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 0x1cf08c0>, '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 0x1cf17c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf1c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:06:18 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 07:06:18 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 07:06:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:18 INFO - Return code: 0 07:06:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:06:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:06:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:06:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:06:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:06:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:06:19 INFO - Return code: 0 07:06:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 07:06:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 07:06:19 INFO - Using env: {'DISPLAY': ':0', 07:06:19 INFO - 'HOME': '/home/cltbld', 07:06:19 INFO - 'LANG': 'en_US.UTF-8', 07:06:19 INFO - 'LANGUAGE': 'en_US:en', 07:06:19 INFO - 'LOGNAME': 'cltbld', 07:06:19 INFO - 'MAIL': '/var/mail/cltbld', 07:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:19 INFO - 'MOZ_NO_REMOTE': '1', 07:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:19 INFO - 'NO_EM_RESTART': '1', 07:06:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:06:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:06:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:06:19 INFO - 'SHELL': '/bin/bash', 07:06:19 INFO - 'SHLVL': '1', 07:06:19 INFO - 'TERM': 'linux', 07:06:19 INFO - 'TMOUT': '86400', 07:06:19 INFO - 'USER': 'cltbld', 07:06:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027', 07:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:19 INFO - '_': '/tools/buildbot/bin/python'} 07:06:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 07:06:20 INFO - mozversion application_buildid: 20160217043011 07:06:20 INFO - mozversion application_changeset: c007ec81b75ae1c51da2c2d2bab21180290fab6b 07:06:20 INFO - mozversion application_display_name: Nightly 07:06:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:20 INFO - mozversion application_name: Firefox 07:06:20 INFO - mozversion application_remotingname: firefox 07:06:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:06:20 INFO - mozversion application_vendor: Mozilla 07:06:20 INFO - mozversion application_version: 47.0a1 07:06:20 INFO - mozversion platform_buildid: 20160217043011 07:06:20 INFO - mozversion platform_changeset: c007ec81b75ae1c51da2c2d2bab21180290fab6b 07:06:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:06:20 INFO - mozversion platform_version: 47.0a1 07:06:20 INFO - using testdate: 1455721580 07:06:20 INFO - actual date: 1455721580 07:06:20 INFO - starting webserver on 'localhost:44198' 07:06:20 INFO - SUITE-START | Running 2 tests 07:06:20 INFO - TEST-START | dromaeo_css 07:06:20 INFO - operating with platform_type : linux_ 07:06:20 INFO - Initialising browser for dromaeo_css test... 07:06:20 INFO - TEST-INFO | started process 26588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyAeH4a/profile http://localhost:44198/getInfo.html) 07:06:24 INFO - PROCESS | 26588 | __metrics Screen width/height:1600/1200 07:06:24 INFO - PROCESS | 26588 | colorDepth:24 07:06:24 INFO - PROCESS | 26588 | Browser inner width/height: 1024/697 07:06:24 INFO - PROCESS | 26588 | __metrics 07:06:25 INFO - PROCESS | 26588 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:26 INFO - TEST-INFO | 26588: exit 0 07:06:26 INFO - Browser initialized. 07:06:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:26 INFO - TEST-INFO | started process 26684 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyAeH4a/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:37 INFO - PROCESS | 26684 | RSS: Main: 148066304 07:06:37 INFO - PROCESS | 26684 | 07:07:29 INFO - PROCESS | 26684 | 1455721649102 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] 07:09:37 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44198/tests/dromaeo/cssquery-ext.html) 07:09:38 INFO - PROCESS | 26684 | RSS: Main: 265318400 07:09:38 INFO - PROCESS | 26684 | 07:12:40 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-ext.html (next: http://localhost:44198/tests/dromaeo/cssquery-jquery.html) 07:12:41 INFO - PROCESS | 26684 | RSS: Main: 235716608 07:12:41 INFO - PROCESS | 26684 | 07:15:43 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44198/tests/dromaeo/cssquery-mootools.html) 07:15:43 INFO - PROCESS | 26684 | RSS: Main: 235847680 07:15:43 INFO - PROCESS | 26684 | 07:18:45 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44198/tests/dromaeo/cssquery-prototype.html) 07:18:46 INFO - PROCESS | 26684 | RSS: Main: 218918912 07:18:46 INFO - PROCESS | 26684 | 07:21:48 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44198/tests/dromaeo/cssquery-yui.html) 07:21:49 INFO - PROCESS | 26684 | RSS: Main: 221454336 07:21:49 INFO - PROCESS | 26684 | 07:24:51 INFO - PROCESS | 26684 | Cycle 1(1): loaded http://localhost:44198/tests/dromaeo/cssquery-yui.html (next: http://localhost:44198/tests/dromaeo/cssquery-dojo.html) 07:24:52 INFO - PROCESS | 26684 | RSS: Main: 265994240 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | __start_tp_report 07:24:52 INFO - PROCESS | 26684 | _x_x_mozilla_page_load 07:24:52 INFO - PROCESS | 26684 | _x_x_mozilla_page_load_details 07:24:52 INFO - PROCESS | 26684 | |i|pagename|runs| 07:24:52 INFO - PROCESS | 26684 | |0;dojo.html;3003.2341752853017;3051.6643169251392;3087.7529797616194;3093.2266933266696;3123.281645221599;4967.751612419383;4995.925875936673;5003.274525193845;5007.799688012479;5039.59683225342;4975.6019518438525;5049.343585333911;5056.418511871136;5088.26220198071;5094.439611642716;4646.931205822662;4651.139539185253;4668.439787225538;4763.952360476385;4779.091972525226;4553.2942393929;4627.467841198255;4711.199096153662;4750.928736068961;4785;4642.558956899073;4651.069786042771;4662.160811054009;4680.976595117037;4689.320048592969;4634.698744581625;4644.489106198315;4652.185867473212;4666.066786642685;4686.156491831503;4577.679562430598;4600.654950878664;4614.423197100363;4641.930371044437;4649.651276154268;4894.559489645913;4951.950480495185;4973.403191616993;4996;5013.548780609726;5357.08929481989;5458.099413596752;5462.672239665632;5464.23500709901;5464.9453505464835;5356.35723713153;5442.2380866678695;5454.563634909197;5513.862153446155;5557.027520183992;5102.69383836971;5112.284280200774;5113.054084994325;5117.462666420047;5121.667091639031;5527.53015993645;5556;5572.749226284745;5579;5628.605997580212;5337.146056630921;5355.678659280377;5375.569954403638;5392.083345831218;5397.568194544427;5371.704556249444;5441.918371224435;5455.263539422207;5458.945410545924;5480.588955828329;5231.659942103827;5411.485908838654;5412.052890744104;5414.648047876875;5492.956338295711;5373.489518495737;5404.162354835007;5405.891882162335;5407.0267351876255;5413.729313534308;4226.852060177879;4231.809568569361;4233.174530966494;4264.424302719093;4270.210011147886;3686.889393318205;3766.7928263945196;3770.1517158639635;3792.715546334036;3805.82873770681;5013;5046.142155833517;5050.292958985745;5073.213651883964;5107.565856902205;5350.170723537858;5406.2701535292235;5421.26812880264;5424.945750542523;5447.291852059287;5000.924986125211;5019.924701129486;5027.773750181177;5038.370203724535;5052.242163675404;4625.098105869391;4655.906881862344;4669.906601868011;4678.251479763221;4710.387649605529;5557.3886872444;5613.691246981373;5636.098224284095;5655.264815573949;5683;5405.297311349499;5417.6478528895495;5424.376196737426;5430.864228394322;5451.155070964007;5607.775688972559;5610.046292130429;5616;5618.803341883015;5695.373508914099;5250.264962905273;5267.657602255841;5308.230306605444;5338.8932221356135;5377.300950876361;5387.542058925035;5403.081476149143;5408;5422.403535611158;5428.941356435457;5172.250023746611;5264.52619264268;5280.341371440004;5281.841544753664;5330.706811125426;5274.7890084396195;5292.894142117213;5308.761105750328;5315.123004704181;5373.462653734595;5180.036644626831;5185.533302002837;5190.688558686491;5195.74021298926;5229.50319719626;5192.039472697563;5225.947740522698;5258;5275.894482110413;5329.7068661224;5195.76619052136;5211.739413029258;5214.661047031931;5215.817446389358;5240 07:24:52 INFO - PROCESS | 26684 | |1;ext.html;519.0371860199327;546.9316335458068;551.2282804074296;552.4061633743726;570.7089384413947;28679.283017924536;29094.563581546292;29104;29126.98055568058;35738.821305893434;39091.80454097725;39547.80226098873;39565.604343956555;39590.40614390779;39611.40582891259;8573.871391929126;8783.560821958908;8787.0773568775;8795.648174073029;8800.779980500474;8801.119888011179;8973.865392019092;8991.190792828644;8996;9005.819883602324;8968.551572421353;9036.8644470333;9049.592768325441;9062.093790620951;9064.637414503444;8872.778180545474;8954.194122529003;8956.68651597191;8968.058353872815;8974.102589741038;8745.300375969908;8778.429402088908;8864.689735859278;8903.910960890373;8904.688335908211;37887.81056094702;38353.808230958944;38363.616363836285;38401;38495.807520962495;3333.3666603345287;3350.79895206286;3504.4217704078796;3621.3119507293795;4010.9197816043516;29148.708512915022;29231.2692182695;29685.257868553457;29732.40535189284;29744;3364.2262279675565;3388.4917262410836;3541.097020259843;3556.2176321209295;3560.732945029133;263336;264113;264311.9999999981;264519;264551;49860.50139498631;50070.248946265834;50369;50386.74806625943;55244.17133742997;58704;58869;58912.11631825526;58943.41056589465;59090;13941.58175254744;14117.152970821784;14122.788158177636;14137.43450261978;14138.50515231962;10593.364398136137;10612.25714200014;10626.415547144981;10631.255812093079;10646.467676616137;18473.353432629792;18878;18930.810691892904;18972.430827075208;18977.715334269997;6369;7232.168300645493;7467.103947526223;7517.511361761468;7673;923.4643906534194;980.6665733650593;997.1424574865609;1074.8172810622214;1140.0822338017808;26184.476310473685;27107.45785084287;27160.592591111148;27229.319267018484;28105.71894281031;1014.2899970021015;1032.3754128751998;1056.7675111475462;1065.5524679634573;1094.5129417409175;14678.559643210721;14723.558293251219;14784.63038424048;14899.851001490064;15008.24958752058;292770;316095;319841;320897;321500;44854.32718509225;45270.77364613156;45481;45495.77252113718;45531.08937821225;1329.0762919770666;1330.8935285177163;1332.7601031814368;1345.4147445861277;1346.8249127613544;26875.596866046635;27787.44425111527;28191;28549.28626784347;28776.280592985342;42751;43316;43324.56675433331;43341;43355.78322108495;238478;240887;271438;377234;392818;29156.27109322284;29217.707822922348;29245.415091698473;29260.707392925797;29526;39803.40294895637;40473.595264046984;40661.1867762649;40958.59041409548;41361;34552.654473454946;34767.47848782321;34823.65176348204;34988;35136.29727405489;32598.34803303968;34399.828000860834;34441.55170521958;34653.65346346605;34738.65261347354;34806.47790283097;35325;35531.64468355283;35586.64413355833;35841.46237806487;30742.231444214074;31211.375772484877;31759.364812703156;31805;31813.20466988344;24638.384040399134;24688.876555617106;24730.752692472845;26135.346616334744;26368.8681556591 07:24:52 INFO - PROCESS | 26684 | |2;jquery.html;363.25713915043735;363.28614272953655;365.4098630711401;366.433859686784;373.9981300093499;13271.800922986164;13894.930525347385;16167;16806;17836.10819459025;11124.944375278132;11478.598249061284;15720;15998.840011599881;16000.679986400264;4937.407511098673;5103.336566246383;5103.795848166069;5104.5405913467785;5109.105906466353;3623.836927338276;3787.0532366908274;4984.476629953857;6572.178477690289;6867.107276054106;6138.754449822001;6389.488840892741;6721.663916804165;6850.314968503159;6860.622665753382;6325.4307112359875;6333.7466501339895;6336;6347.238331400238;6647.933520664828;6266.780662676784;6453.935460645381;6475.773347932847;6482.286948435668;6495.090687303781;21628.783712162993;22176.77823221763;22189.11243550256;22827.20104796341;22919.083236670514;2283.5889539882814;2378.4410663494064;2398.3404563744934;2444.767747064026;2939.8236105833716;12948.676283092998;13318.467261309535;13484.190948543119;13511.324433778273;13673.179609223378;1913.4546654203625;1952.8616165298974;1966.8328192103688;1987.3541099142838;2077.6779599162155;60761;61342.399320050725;63621.04568431477;64056;64167.35832641661;14872.256387180598;15144.242787860563;15154.16652084146;15180.620484487976;15186.924065379824;23237.651435228487;23329.533409331718;23356.065757369855;24435.900384482742;24503;8459.959340500991;8680.522571258642;8686.695965641173;8709.608067636971;8769.517676527725;7495.737649182362;7506.061742282215;7545.584992825447;7570.205128461543;7595.430342724318;6900.3099690031595;7306.775283131291;7706.842084216316;7785.844283114419;7854.646540905673;2966.144012783373;2981.2844917219713;2987.731104200589;3028.787984841084;3072.1705139612627;471.22718741264356;472.09593628202293;877.7630039889194;894.0969620683027;967.2455484721928;9888.87389211323;10313.896861031293;11063.336199827874;11112.94427029447;11125.054370378446;892.8839250897341;894.7673604862653;918.9248579162396;926.3376685669779;995.3331268050424;8834.690785822466;9170.770730731785;9171.220446262143;9339.159475647224;9348.719538413858;384027;386668;392746;393017;442699;70938;71099.2890071103;72975.63512182511;74881;75241.62379188069;992.8163289791412;1097.7530055737395;1144.4392247798685;1153.7173392518887;1155.1971379891063;15214.847851521343;15475.071495710294;15523.534293971199;15642.139682317582;15729.842701572838;33483.33033339271;34116.829415852764;34288.48567271443;34369.484457733655;35392.823035884656;46519.767401162775;46960;47157.52842471531;47999.5200047995;48080;7907.84184316322;8017.679292828221;8021.8395632088195;8030.5181689098845;8091.635876385694;10435.37387756737;11330.830037549278;11954.043676505684;12148;12268.938655306667;10502.05481506668;10504.632337868137;10551.841722374324;10615.1507879371;10694.679159625224;10511.316764410289;10646;10785.838212426977;10788.622398216025;10883.183761218099;10025.498725063571;10305.53625086888;10447.425391603534;10593.09958653523;10898.18263630215;8102.959485202772;8124.918750812416;8158.265756081743;8213.466124701876;8218.137095605114;10231.539580718736;10580;10806;10820.4048777318;10878.184136189975 07:24:52 INFO - PROCESS | 26684 | |3;mootools.html;1303.6675647709833;1441.2577522575873;1448.3916754962918;1601.7036848183086;1774.2016092758254;7133.607651579161;7730.381569474443;7954.642041108143;7959.084705258882;7960.084590272106;7690.96154519228;7906.802329941755;7921.207879212076;7926.841463170747;7931.801704957365;2010.879347239163;2162.653975363942;2202.592520383734;2250.2574150530368;2309.8614083155067;2303.5738388398117;2304.9884750576225;2309.053288151858;2313.27131953435;2316.119874447716;2271.454850835804;2343.660169275454;2346.038124369009;2346.1905642553293;2351.247600767755;2257.6162052451123;2288.0504590594965;2337.5208082343165;2337.649352597107;2339.9883000584887;2257.808086312665;2267.331137314496;2269.6708977198377;2310.3761984264324;2370.9644355334685;8026.117127116013;8082.3534117271065;8092.190780921861;8124.5937703114605;8137.064237612691;4677.625789936831;4750.71495710255;4770.403699537558;4778.856634300976;4788.0663270662235;3043.3152540678393;3058.480058390079;3135.3572517634057;3192.6488086310487;3203.743700503954;993.1260490768078;997.3218211616098;1025.2157099818644;1029.1663752360612;1030.1449796668746;11183.888161118366;11189.104871610252;11240.887591124148;11282.999999999918;11295.265807722553;4374.103308821747;4418.160549495586;4504.864854054318;4506.932396014063;4522.479914809774;9516.095970882894;9567.61729530825;9574.952125239468;9621.51892405377;9622.085901839455;4943.8022479101155;4951.876203094879;4955.108080545464;4975.203967365204;4975.303457515951;4526.7283962961665;4527.162474942146;4534.070515544306;4534.093181363674;4537.8411755588395;3398.5411969384313;3709.740318177756;3831;3831.6934645228316;3847.3267178243696;1242.1801610936739;1263.6588121207405;1265.0322503284995;1270.4219580091037;1270.688681273094;1273.2678709741751;1279.6033229698824;1297.9221246725037;1298.8766067223598;1299.2139755448006;7389.298016688406;7517.962410188024;7553.773386798405;7565.6973721050545;7760.068791745027;1094.8029354716068;1108.778244351133;1111.5776005118003;1118.8992990630882;1130.9943450282697;5833.154192642043;5927.081302398135;5945.702714864239;5952.345242023374;5953.583249172516;9395.342326037111;9405.90594094064;9427.151556359824;9573.234141268682;9640.662576809778;9394.154526092685;9453.574589143505;9453.810923781624;9462.337636365388;9465.05349465048;7378.229224985965;7414.14737305206;7496.812579685551;7504.812379690551;7577.242275772489;7449.478536502393;7451.105867295959;7501.887471688038;7576.848463030598;7598.924010760043;8548.016978047604;8649.654013839629;8861.069587693199;8866.512341821262;8877.24543413817;8963.372563920462;8979.955100224719;9016.09839016093;9086.591103400495;9099;6691.397774200345;7664.6550905210515;7807.51657185133;7815.29662330393;7820.217978202134;7465.328120469184;7625.618719063914;7639.350655194148;7678.308952194329;7696.576688282198;6979.965100174467;7056.788296351117;7261.891071634035;7269.0550228472075;7481.7755467336065;7241.565506069653;7261.564306141649;7302.56184628924;7398;7406.44451666138;7187.820304492429;7188.60462674537;7190.209077001421;7207.9639601801655;7295.598742069024;6666.6000039995815;6703.966480167763;6716.932830671631;6717.429018533479;6724.562903411263;6505.154329937078;6508.284088750328;6636.5113082594025;6669.799906002828;6713.261541230363 07:24:52 INFO - PROCESS | 26684 | |4;prototype.html;339.6298035141695;344.68633543475437;346.98785542506016;351.4885841101198;352.6315000824137;5805.564582656302;5828.154917536955;5873.647581145135;5875.941240587593;5886.146508756227;5734.741936612852;5768.826935191941;5790.565707571928;5795.3335366432875;5797.71011449428;4549.954500455003;4552.635789136861;4559.042601053783;4562.703424277412;4566;4459.9331010034875;4533.478649955265;4554.817807287721;4558.977205113986;4567.885802854938;4508.819647214107;4513.435820522434;4519.909601807962;4524.479684836237;4525.230710779159;4271.487421509439;4355.346697995326;4517.960869000132;4527.253003254459;4531.750753708545;3893.7274390792654;3950.1902110067367;3972.761634301922;3986.8405263789414;3997.420374045776;5474.562035037187;5497.45025497451;5536.501714845643;5541.861453463655;5571.275734154575;4928.778204980748;5081.314022606938;5234.685918844882;5237.319148510707;5264.184051472028;6105.847353816146;6110.480609148183;6115.694215289218;6123.510119190454;6132.172156758825;4390.385346051524;4392.78036098197;4393.51671316155;4396.1867054595;4401.361802538614;6255.40573645503;6411.262704788963;6416.550841441101;6423.454006409461;6426.389492998158;4536.97731511347;4537.500874903758;4540.636749060067;4542.295944128666;4547.931781023287;4587.9541204588195;4596.724196548218;4600.35595016698;4602.05657840142;4608.907821843544;5221.347331583552;5228.934570844571;5236.581073514109;5237.711925844039;5240.973795131;6021.367756385516;6169.198004259418;6185.969070154621;6191.907121393093;6195.597286176384;1597.8402159784162;1611.8791090668012;1612.3953517430964;1612.6290953080857;1613.572403313123;1101.2841652925663;1111.2332490581473;1121.52895783771;1125.7635896461834;1128.3173679923693;5830.125481177857;5842.298924129132;5854.941450585525;5858.091995740667;5870.14882841994;6289.308176100625;6306.49548036156;6336.271328797156;6402.423781859655;6411.487081033506;5793.507551858055;5824.155497452845;5841.182234487175;5856.648601083949;5865.178874957509;3292.0782180989363;3390.627031026585;3412.351653185887;3413.419718647836;3417.572803399575;6540.05169250456;6551.181102362205;6567.802965911031;6568.835779105465;6569.770058047945;6223.097650840603;6437.259715132726;6438.8390290243115;6442.452391546771;6453.870922581522;6615.338466153346;6622.039804228456;6631.23740769808;6640.767573135014;6641.767538136142;6322.652254125883;6326.588771729823;6338.080978258219;6342.841428964312;6349.079383489276;6029.336772954884;6174.876502469836;6253.656048917172;6325.905111423241;6333.493320534254;6605.405513503808;6614.603123812587;6644.169478815148;6669.699863506251;6670.599764014175;4575.656825738017;4576.725396476222;4577.176108300538;4577.267637178035;4579.313103034571;6199.1011303359855;6392.968035159794;6403.0715546246465;6404.103425520338;6411.96794016027;6188.628682279078;6227.408396202353;6231.4391704746795;6238.500919926304;6240.095186198067;6223.3465486125115;6227.128202051807;6228.252609686867;6229.906551401823;6232.657203853832;6014.097885317237;6060.151578779062;6112.510999120149;6117.938820611737;6126.693665316806;6235.501159907287;6248.250209974832;6280;6313.43179113882;6316.210473690789;6106.542009349406;6121.755129794758;6127.509799216141;6135.049067394561;6141.048137538689 07:24:52 INFO - PROCESS | 26684 | |5;yui.html;617.3209469583456;658.2035736758519;665.4809248785947;744.7616762635955;763.8739607964679;13812.93093534532;13882.375293111809;13900.652483687913;13961.232132232723;13968.371423285938;12974.675633109176;13068.346582670853;13142.540011099614;13144.47422103117;13238.536651217186;804;819.1194465949128;819.3404309530825;819.8278361544083;819.8524265632213;807.7657479331016;813.7396033269356;814.1207495904409;814.5357146426539;815.4536460571402;844.9493030418164;849.8725191221305;849.9970035358275;850.2475309351207;850.6469815026757;832.6169961817571;836.2181360427988;836.782436566491;836.8661014237754;837.2381133168848;617.1699064757894;618.8514756458462;619.164128426625;619.863630001399;620.221621864557;12712.364381780966;12745.681357966032;12753.234805911583;12757;12778.041646876522;10702;10725.195610329178;10815.513301901434;10898.50956706942;10931.453427328603;9857.55640996157;9956.402615843073;9964.352317099365;10040.648577299833;10051.296409251356;3208.181913612014;3320.684534969174;3349.7822641528223;3459.9827000865084;3583.552055993001;42910.57089429097;45696.08607827858;45973;46084.308735369;47818.760906195595;10030.29787914839;10193.592256309812;10261.486925653688;10274;10413.271071025107;17218.05300708473;17908.91045544764;17939.103044847707;19114.80885191158;19272.22911083541;6544.640044797487;7462.850742985219;7886;7900.683972641145;8083.797905052303;4037.212743515045;4217.8523751668545;4248.830046798155;4262.46719160105;4378.693491455631;3305.3554556861664;3342;3342.364950659367;3343.281194543185;3351.0449521886144;600.2406955201674;607.5959486941223;619.5632079384023;621.2265729167216;640.4940097323063;567.5714835299406;576.573335731564;577.6216578141324;577.9479846813807;596.6062398816847;7559.28186822251;7729.149793522708;7846.293833555007;7955.4033447491665;7975.8404831903035;485.5605676862445;534.8502419322596;601.8555546668767;610.1366566308712;612.0727098445858;3604.3151801157696;3721.6092310307567;3747.2505498900327;3791.75353602015;3821.796134217768;57202.427975720544;57586.424135758105;57970;58004;58226.708866455396;42413.36379954303;49991.50008499941;50427.24359134616;50786.23820642693;50820;41373.172536549704;41523;41583.58416415797;42107;42121.36817947733;7988.201179882198;8017.398695097774;8139.226773456512;8177.79555511117;8308.6676532938;32571.674283256863;33177.66822331746;34648.82675586606;35408.11479713028;35762;38341.424878627404;38346.233075338896;38778.4183237246;40051.79974100227;40273.798631006655;10018.248631352531;10423.895761042293;10499.737506562396;11085;11221.326720396803;11395.088392928712;11484.598039068593;11516.596919107791;11750.647480575597;11991.64025079249;10608.939106089329;10649.201309901944;10686.465676715978;10712.678619641423;10727.088197503299;11466.770664586495;11658.6502404928;11662.650120496399;11663.533458661559;11671.416429178676;10238.744031398977;10477.9476102619;10496.737581560523;10519.842202367123;11249.71875703114;9073.092690730875;9107.908920910972;9672.419654820733;9907.507291541777;10143.137833284254;9133.954330228305;9280.95359523198;9344.392614480037;9347.859782103409;9464.242860571276 07:24:52 INFO - PROCESS | 26684 | __end_tp_report 07:24:52 INFO - PROCESS | 26684 | __start_cc_report 07:24:52 INFO - PROCESS | 26684 | _x_x_mozilla_cycle_collect,924 07:24:52 INFO - PROCESS | 26684 | __end_cc_report 07:24:52 INFO - PROCESS | 26684 | __startTimestamp1455722692163__endTimestamp 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | ------- Summary: start ------- 07:24:52 INFO - PROCESS | 26684 | Number of tests: 6 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#0] dojo.html Cycles:165 Average:5043.71 Median:5211.74 stddev:541.27 (10.4%) stddev-sans-first:518.72 07:24:52 INFO - PROCESS | 26684 | Values: 3003.2 3051.7 3087.8 3093.2 3123.3 4967.8 4995.9 5003.3 5007.8 5039.6 4975.6 5049.3 5056.4 5088.3 5094.4 4646.9 4651.1 4668.4 4764.0 4779.1 4553.3 4627.5 4711.2 4750.9 4785.0 4642.6 4651.1 4662.2 4681.0 4689.3 4634.7 4644.5 4652.2 4666.1 4686.2 4577.7 4600.7 4614.4 4641.9 4649.7 4894.6 4952.0 4973.4 4996.0 5013.5 5357.1 5458.1 5462.7 5464.2 5464.9 5356.4 5442.2 5454.6 5513.9 5557.0 5102.7 5112.3 5113.1 5117.5 5121.7 5527.5 5556.0 5572.7 5579.0 5628.6 5337.1 5355.7 5375.6 5392.1 5397.6 5371.7 5441.9 5455.3 5458.9 5480.6 5231.7 5411.5 5412.1 5414.6 5493.0 5373.5 5404.2 5405.9 5407.0 5413.7 4226.9 4231.8 4233.2 4264.4 4270.2 3686.9 3766.8 3770.2 3792.7 3805.8 5013.0 5046.1 5050.3 5073.2 5107.6 5350.2 5406.3 5421.3 5424.9 5447.3 5000.9 5019.9 5027.8 5038.4 5052.2 4625.1 4655.9 4669.9 4678.3 4710.4 5557.4 5613.7 5636.1 5655.3 5683.0 5405.3 5417.6 5424.4 5430.9 5451.2 5607.8 5610.0 5616.0 5618.8 5695.4 5250.3 5267.7 5308.2 5338.9 5377.3 5387.5 5403.1 5408.0 5422.4 5428.9 5172.3 5264.5 5280.3 5281.8 5330.7 5274.8 5292.9 5308.8 5315.1 5373.5 5180.0 5185.5 5190.7 5195.7 5229.5 5192.0 5225.9 5258.0 5275.9 5329.7 5195.8 5211.7 5214.7 5215.8 5240.0 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#1] ext.html Cycles:180 Average:45175.96 Median:34815.06 stddev:77983.13 (224.0%) stddev-sans-first:78129.81 07:24:52 INFO - PROCESS | 26684 | Values: 519.0 546.9 551.2 552.4 570.7 28679.3 29094.6 29104.0 29127.0 35738.8 39091.8 39547.8 39565.6 39590.4 39611.4 8573.9 8783.6 8787.1 8795.6 8800.8 8801.1 8973.9 8991.2 8996.0 9005.8 8968.6 9036.9 9049.6 9062.1 9064.6 8872.8 8954.2 8956.7 8968.1 8974.1 8745.3 8778.4 8864.7 8903.9 8904.7 37887.8 38353.8 38363.6 38401.0 38495.8 3333.4 3350.8 3504.4 3621.3 4010.9 29148.7 29231.3 29685.3 29732.4 29744.0 3364.2 3388.5 3541.1 3556.2 3560.7 263336.0 264113.0 264312.0 264519.0 264551.0 49860.5 50070.2 50369.0 50386.7 55244.2 58704.0 58869.0 58912.1 58943.4 59090.0 13941.6 14117.2 14122.8 14137.4 14138.5 10593.4 10612.3 10626.4 10631.3 10646.5 18473.4 18878.0 18930.8 18972.4 18977.7 6369.0 7232.2 7467.1 7517.5 7673.0 923.5 980.7 997.1 1074.8 1140.1 26184.5 27107.5 27160.6 27229.3 28105.7 1014.3 1032.4 1056.8 1065.6 1094.5 14678.6 14723.6 14784.6 14899.9 15008.2 292770.0 316095.0 319841.0 320897.0 321500.0 44854.3 45270.8 45481.0 45495.8 45531.1 1329.1 1330.9 1332.8 1345.4 1346.8 26875.6 27787.4 28191.0 28549.3 28776.3 42751.0 43316.0 43324.6 43341.0 43355.8 238478.0 240887.0 271438.0 377234.0 392818.0 29156.3 29217.7 29245.4 29260.7 29526.0 39803.4 40473.6 40661.2 40958.6 41361.0 34552.7 34767.5 34823.7 34988.0 35136.3 32598.3 34399.8 34441.6 34653.7 34738.7 34806.5 35325.0 35531.6 35586.6 35841.5 30742.2 31211.4 31759.4 31805.0 31813.2 24638.4 24688.9 24730.8 26135.3 26368.9 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#2] jquery.html Cycles:180 Average:24755.50 Median:364.35 stddev:65681.81 (18027.2%) stddev-sans-first:65840.53 07:24:52 INFO - PROCESS | 26684 | Values: 363.3 363.3 365.4 366.4 374.0 13271.8 13894.9 16167.0 16806.0 17836.1 11124.9 11478.6 15720.0 15998.8 16000.7 4937.4 5103.3 5103.8 5104.5 5109.1 3623.8 3787.1 4984.5 6572.2 6867.1 6138.8 6389.5 6721.7 6850.3 6860.6 6325.4 6333.7 6336.0 6347.2 6647.9 6266.8 6453.9 6475.8 6482.3 6495.1 21628.8 22176.8 22189.1 22827.2 22919.1 2283.6 2378.4 2398.3 2444.8 2939.8 12948.7 13318.5 13484.2 13511.3 13673.2 1913.5 1952.9 1966.8 1987.4 2077.7 60761.0 61342.4 63621.0 64056.0 64167.4 14872.3 15144.2 15154.2 15180.6 15186.9 23237.7 23329.5 23356.1 24435.9 24503.0 8460.0 8680.5 8686.7 8709.6 8769.5 7495.7 7506.1 7545.6 7570.2 7595.4 6900.3 7306.8 7706.8 7785.8 7854.6 2966.1 2981.3 2987.7 3028.8 3072.2 471.2 472.1 877.8 894.1 967.2 9888.9 10313.9 11063.3 11112.9 11125.1 892.9 894.8 918.9 926.3 995.3 8834.7 9170.8 9171.2 9339.2 9348.7 384027.0 386668.0 392746.0 393017.0 442699.0 70938.0 71099.3 72975.6 74881.0 75241.6 992.8 1097.8 1144.4 1153.7 1155.2 15214.8 15475.1 15523.5 15642.1 15729.8 33483.3 34116.8 34288.5 34369.5 35392.8 46519.8 46960.0 47157.5 47999.5 48080.0 7907.8 8017.7 8021.8 8030.5 8091.6 10435.4 11330.8 11954.0 12148.0 12268.9 10502.1 10504.6 10551.8 10615.2 10694.7 10511.3 10646.0 10785.8 10788.6 10883.2 10025.5 10305.5 10447.4 10593.1 10898.2 8103.0 8124.9 8158.3 8213.5 8218.1 10231.5 10580.0 10806.0 10820.4 10878.2 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#3] mootools.html Cycles:180 Average:5643.28 Median:6651.56 stddev:2935.48 (44.1%) stddev-sans-first:2925.59 07:24:52 INFO - PROCESS | 26684 | Values: 1303.7 1441.3 1448.4 1601.7 1774.2 7133.6 7730.4 7954.6 7959.1 7960.1 7691.0 7906.8 7921.2 7926.8 7931.8 2010.9 2162.7 2202.6 2250.3 2309.9 2303.6 2305.0 2309.1 2313.3 2316.1 2271.5 2343.7 2346.0 2346.2 2351.2 2257.6 2288.1 2337.5 2337.6 2340.0 2257.8 2267.3 2269.7 2310.4 2371.0 8026.1 8082.4 8092.2 8124.6 8137.1 4677.6 4750.7 4770.4 4778.9 4788.1 3043.3 3058.5 3135.4 3192.6 3203.7 993.1 997.3 1025.2 1029.2 1030.1 11183.9 11189.1 11240.9 11283.0 11295.3 4374.1 4418.2 4504.9 4506.9 4522.5 9516.1 9567.6 9575.0 9621.5 9622.1 4943.8 4951.9 4955.1 4975.2 4975.3 4526.7 4527.2 4534.1 4534.1 4537.8 3398.5 3709.7 3831.0 3831.7 3847.3 1242.2 1263.7 1265.0 1270.4 1270.7 1273.3 1279.6 1297.9 1298.9 1299.2 7389.3 7518.0 7553.8 7565.7 7760.1 1094.8 1108.8 1111.6 1118.9 1131.0 5833.2 5927.1 5945.7 5952.3 5953.6 9395.3 9405.9 9427.2 9573.2 9640.7 9394.2 9453.6 9453.8 9462.3 9465.1 7378.2 7414.1 7496.8 7504.8 7577.2 7449.5 7451.1 7501.9 7576.8 7598.9 8548.0 8649.7 8861.1 8866.5 8877.2 8963.4 8980.0 9016.1 9086.6 9099.0 6691.4 7664.7 7807.5 7815.3 7820.2 7465.3 7625.6 7639.4 7678.3 7696.6 6980.0 7056.8 7261.9 7269.1 7481.8 7241.6 7261.6 7302.6 7398.0 7406.4 7187.8 7188.6 7190.2 7208.0 7295.6 6666.6 6704.0 6716.9 6717.4 6724.6 6505.2 6508.3 6636.5 6669.8 6713.3 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#4] prototype.html Cycles:180 Average:5192.00 Median:5841.74 stddev:1531.15 (26.2%) stddev-sans-first:1491.50 07:24:52 INFO - PROCESS | 26684 | Values: 339.6 344.7 347.0 351.5 352.6 5805.6 5828.2 5873.6 5875.9 5886.1 5734.7 5768.8 5790.6 5795.3 5797.7 4550.0 4552.6 4559.0 4562.7 4566.0 4459.9 4533.5 4554.8 4559.0 4567.9 4508.8 4513.4 4519.9 4524.5 4525.2 4271.5 4355.3 4518.0 4527.3 4531.8 3893.7 3950.2 3972.8 3986.8 3997.4 5474.6 5497.5 5536.5 5541.9 5571.3 4928.8 5081.3 5234.7 5237.3 5264.2 6105.8 6110.5 6115.7 6123.5 6132.2 4390.4 4392.8 4393.5 4396.2 4401.4 6255.4 6411.3 6416.6 6423.5 6426.4 4537.0 4537.5 4540.6 4542.3 4547.9 4588.0 4596.7 4600.4 4602.1 4608.9 5221.3 5228.9 5236.6 5237.7 5241.0 6021.4 6169.2 6186.0 6191.9 6195.6 1597.8 1611.9 1612.4 1612.6 1613.6 1101.3 1111.2 1121.5 1125.8 1128.3 5830.1 5842.3 5854.9 5858.1 5870.1 6289.3 6306.5 6336.3 6402.4 6411.5 5793.5 5824.2 5841.2 5856.6 5865.2 3292.1 3390.6 3412.4 3413.4 3417.6 6540.1 6551.2 6567.8 6568.8 6569.8 6223.1 6437.3 6438.8 6442.5 6453.9 6615.3 6622.0 6631.2 6640.8 6641.8 6322.7 6326.6 6338.1 6342.8 6349.1 6029.3 6174.9 6253.7 6325.9 6333.5 6605.4 6614.6 6644.2 6669.7 6670.6 4575.7 4576.7 4577.2 4577.3 4579.3 6199.1 6393.0 6403.1 6404.1 6412.0 6188.6 6227.4 6231.4 6238.5 6240.1 6223.3 6227.1 6228.3 6229.9 6232.7 6014.1 6060.2 6112.5 6117.9 6126.7 6235.5 6248.3 6280.0 6313.4 6316.2 6106.5 6121.8 6127.5 6135.0 6141.0 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - PROCESS | 26684 | [#5] yui.html Cycles:180 Average:13203.90 Median:23331.10 stddev:15160.66 (65.0%) stddev-sans-first:15173.73 07:24:52 INFO - PROCESS | 26684 | Values: 617.3 658.2 665.5 744.8 763.9 13812.9 13882.4 13900.7 13961.2 13968.4 12974.7 13068.3 13142.5 13144.5 13238.5 804.0 819.1 819.3 819.8 819.9 807.8 813.7 814.1 814.5 815.5 844.9 849.9 850.0 850.2 850.6 832.6 836.2 836.8 836.9 837.2 617.2 618.9 619.2 619.9 620.2 12712.4 12745.7 12753.2 12757.0 12778.0 10702.0 10725.2 10815.5 10898.5 10931.5 9857.6 9956.4 9964.4 10040.6 10051.3 3208.2 3320.7 3349.8 3460.0 3583.6 42910.6 45696.1 45973.0 46084.3 47818.8 10030.3 10193.6 10261.5 10274.0 10413.3 17218.1 17908.9 17939.1 19114.8 19272.2 6544.6 7462.9 7886.0 7900.7 8083.8 4037.2 4217.9 4248.8 4262.5 4378.7 3305.4 3342.0 3342.4 3343.3 3351.0 600.2 607.6 619.6 621.2 640.5 567.6 576.6 577.6 577.9 596.6 7559.3 7729.1 7846.3 7955.4 7975.8 485.6 534.9 601.9 610.1 612.1 3604.3 3721.6 3747.3 3791.8 3821.8 57202.4 57586.4 57970.0 58004.0 58226.7 42413.4 49991.5 50427.2 50786.2 50820.0 41373.2 41523.0 41583.6 42107.0 42121.4 7988.2 8017.4 8139.2 8177.8 8308.7 32571.7 33177.7 34648.8 35408.1 35762.0 38341.4 38346.2 38778.4 40051.8 40273.8 10018.2 10423.9 10499.7 11085.0 11221.3 11395.1 11484.6 11516.6 11750.6 11991.6 10608.9 10649.2 10686.5 10712.7 10727.1 11466.8 11658.7 11662.7 11663.5 11671.4 10238.7 10477.9 10496.7 10519.8 11249.7 9073.1 9107.9 9672.4 9907.5 10143.1 9134.0 9281.0 9344.4 9347.9 9464.2 07:24:52 INFO - PROCESS | 26684 | -------- Summary: end -------- 07:24:52 INFO - PROCESS | 26684 | 07:24:52 INFO - TEST-INFO | 26684: exit 0 07:24:52 INFO - TEST-OK | dromaeo_css | took 1112719ms 07:24:52 INFO - TEST-START | kraken 07:24:52 INFO - operating with platform_type : linux_ 07:24:52 INFO - Initialising browser for kraken test... 07:24:52 INFO - TEST-INFO | started process 26874 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEFE6EX/profile http://localhost:44198/getInfo.html) 07:24:56 INFO - PROCESS | 26874 | __metrics Screen width/height:1600/1200 07:24:56 INFO - PROCESS | 26874 | colorDepth:24 07:24:56 INFO - PROCESS | 26874 | Browser inner width/height: 1024/697 07:24:56 INFO - PROCESS | 26874 | __metrics 07:24:57 INFO - PROCESS | 26874 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:57 INFO - PROCESS | 26874 | 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. 07:24:58 INFO - TEST-INFO | 26874: exit 0 07:24:58 INFO - Browser initialized. 07:24:58 INFO - Running cycle 1/1 for kraken test... 07:24:58 INFO - TEST-INFO | started process 26956 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEFE6EX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:10 INFO - PROCESS | 26956 | RSS: Main: 147632128 07:25:10 INFO - PROCESS | 26956 | 07:25:12 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44198/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:13 INFO - PROCESS | 26956 | RSS: Main: 192630784 07:25:13 INFO - PROCESS | 26956 | 07:25:16 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44198/tests/kraken/driver.html?testName=audio-dft) 07:25:16 INFO - PROCESS | 26956 | RSS: Main: 182026240 07:25:16 INFO - PROCESS | 26956 | 07:25:19 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44198/tests/kraken/driver.html?testName=audio-fft) 07:25:20 INFO - PROCESS | 26956 | RSS: Main: 167477248 07:25:20 INFO - PROCESS | 26956 | 07:25:22 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44198/tests/kraken/driver.html?testName=audio-oscillator) 07:25:22 INFO - PROCESS | 26956 | RSS: Main: 167415808 07:25:22 INFO - PROCESS | 26956 | 07:25:25 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:25 INFO - PROCESS | 26956 | RSS: Main: 168214528 07:25:25 INFO - PROCESS | 26956 | 07:25:28 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44198/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:29 INFO - PROCESS | 26956 | RSS: Main: 168603648 07:25:29 INFO - PROCESS | 26956 | 07:25:32 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44198/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:33 INFO - PROCESS | 26956 | RSS: Main: 171823104 07:25:33 INFO - PROCESS | 26956 | 07:25:35 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44198/tests/kraken/driver.html?testName=json-parse-financial) 07:25:36 INFO - PROCESS | 26956 | RSS: Main: 171188224 07:25:36 INFO - PROCESS | 26956 | 07:25:38 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:25:38 INFO - PROCESS | 26956 | RSS: Main: 182648832 07:25:38 INFO - PROCESS | 26956 | 07:25:40 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:25:41 INFO - PROCESS | 26956 | RSS: Main: 178302976 07:25:41 INFO - PROCESS | 26956 | 07:25:43 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:25:43 INFO - PROCESS | 26956 | RSS: Main: 193024000 07:25:43 INFO - PROCESS | 26956 | 07:25:46 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:25:46 INFO - PROCESS | 26956 | RSS: Main: 201379840 07:25:46 INFO - PROCESS | 26956 | 07:25:49 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:25:50 INFO - PROCESS | 26956 | RSS: Main: 199077888 07:25:50 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | Cycle 1(1): loaded http://localhost:44198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44198/tests/kraken/driver.html?testName=ai-astar) 07:25:51 INFO - PROCESS | 26956 | RSS: Main: 261197824 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | __start_tp_report 07:25:51 INFO - PROCESS | 26956 | _x_x_mozilla_page_load 07:25:51 INFO - PROCESS | 26956 | _x_x_mozilla_page_load_details 07:25:51 INFO - PROCESS | 26956 | |i|pagename|runs| 07:25:51 INFO - PROCESS | 26956 | |0;ai-astar;110;113;106;110;111;112;103;112;112;111 07:25:51 INFO - PROCESS | 26956 | |1;audio-beat-detection;150;124;150;166;127;152;154;128;173;131 07:25:51 INFO - PROCESS | 26956 | |2;audio-dft;163;163;162;163;162;162;163;167;165;163 07:25:51 INFO - PROCESS | 26956 | |3;audio-fft;81;73;129;97;74;75;74;121;97;72 07:25:51 INFO - PROCESS | 26956 | |4;audio-oscillator;97;97;140;95;96;97;142;95;96;144 07:25:51 INFO - PROCESS | 26956 | |5;imaging-gaussian-blur;118;115;115;115;115;115;115;115;115;115 07:25:51 INFO - PROCESS | 26956 | |6;imaging-darkroom;146;144;150;145;145;145;146;146;145;145 07:25:51 INFO - PROCESS | 26956 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 07:25:51 INFO - PROCESS | 26956 | |8;json-parse-financial;69;59;59;56;54;56;55;64;53;54 07:25:51 INFO - PROCESS | 26956 | |9;json-stringify-tinderbox;66;68;67;67;67;68;69;67;67;69 07:25:51 INFO - PROCESS | 26956 | |10;stanford-crypto-aes;82;82;82;84;83;83;83;82;82;82 07:25:51 INFO - PROCESS | 26956 | |11;stanford-crypto-ccm;121;118;117;116;114;117;119;125;117;129 07:25:51 INFO - PROCESS | 26956 | |12;stanford-crypto-pbkdf2;158;150;150;163;149;140;149;151;156;155 07:25:51 INFO - PROCESS | 26956 | |13;stanford-crypto-sha256-iterative;68;68;71;71;70;68;68;67;71;68 07:25:51 INFO - PROCESS | 26956 | __end_tp_report 07:25:51 INFO - PROCESS | 26956 | __start_cc_report 07:25:51 INFO - PROCESS | 26956 | _x_x_mozilla_cycle_collect,958 07:25:51 INFO - PROCESS | 26956 | __end_cc_report 07:25:51 INFO - PROCESS | 26956 | __startTimestamp1455722751967__endTimestamp 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | ------- Summary: start ------- 07:25:51 INFO - PROCESS | 26956 | Number of tests: 14 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.13 (2.8%) stddev-sans-first:3.32 07:25:51 INFO - PROCESS | 26956 | Values: 110.0 113.0 106.0 110.0 111.0 112.0 103.0 112.0 112.0 111.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.00 stddev:17.17 (11.4%) stddev-sans-first:18.13 07:25:51 INFO - PROCESS | 26956 | Values: 150.0 124.0 150.0 166.0 127.0 152.0 154.0 128.0 173.0 131.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 07:25:51 INFO - PROCESS | 26956 | Values: 163.0 163.0 162.0 163.0 162.0 162.0 163.0 167.0 165.0 163.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#3] audio-fft Cycles:10 Average:89.30 Median:74.50 stddev:21.10 (28.3%) stddev-sans-first:22.16 07:25:51 INFO - PROCESS | 26956 | Values: 81.0 73.0 129.0 97.0 74.0 75.0 74.0 121.0 97.0 72.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.18 (23.1%) stddev-sans-first:23.03 07:25:51 INFO - PROCESS | 26956 | Values: 97.0 97.0 140.0 95.0 96.0 97.0 142.0 95.0 96.0 144.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.00 07:25:51 INFO - PROCESS | 26956 | Values: 118.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 115.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.64 (1.1%) stddev-sans-first:1.73 07:25:51 INFO - PROCESS | 26956 | Values: 146.0 144.0 150.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:25:51 INFO - PROCESS | 26956 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:5.09 (8.8%) stddev-sans-first:3.46 07:25:51 INFO - PROCESS | 26956 | Values: 69.0 59.0 59.0 56.0 54.0 56.0 55.0 64.0 53.0 54.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 07:25:51 INFO - PROCESS | 26956 | Values: 66.0 68.0 67.0 67.0 67.0 68.0 69.0 67.0 67.0 69.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 07:25:51 INFO - PROCESS | 26956 | Values: 82.0 82.0 82.0 84.0 83.0 83.0 83.0 82.0 82.0 82.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:118.50 stddev:4.55 (3.8%) stddev-sans-first:4.78 07:25:51 INFO - PROCESS | 26956 | Values: 121.0 118.0 117.0 116.0 114.0 117.0 119.0 125.0 117.0 129.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.00 stddev:6.26 (4.1%) stddev-sans-first:6.27 07:25:51 INFO - PROCESS | 26956 | Values: 158.0 150.0 150.0 163.0 149.0 140.0 149.0 151.0 156.0 155.0 07:25:51 INFO - PROCESS | 26956 | 07:25:51 INFO - PROCESS | 26956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.56 (2.3%) stddev-sans-first:1.62 07:25:51 INFO - PROCESS | 26956 | Values: 68.0 68.0 71.0 71.0 70.0 68.0 68.0 67.0 71.0 68.0 07:25:51 INFO - PROCESS | 26956 | -------- Summary: end -------- 07:25:51 INFO - PROCESS | 26956 | 07:25:52 INFO - TEST-INFO | 26956: exit 0 07:25:52 INFO - TEST-OK | kraken | took 60007ms 07:25:52 INFO - SUITE-END | took 1172s 07:25:53 INFO - Completed test suite (00:19:32) 07:25:53 INFO - Working with test: dromaeo_css 07:25:53 INFO - Generating results file: dromaeo_css 07:25:53 INFO - Working with test: kraken 07:25:53 INFO - Generating results file: kraken 07:25:53 INFO - javascript benchmark 07:25:53 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:25:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:25:53 INFO - process_Request line: dromaeo_css 6869.84 graph.html#tests=[[72,1,35]] 07:25:53 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:25:53 INFO - process_Request line: kraken 1523.20 graph.html#tests=[[232,1,35]] 07:25:53 INFO - RETURN: dromaeo_css: 6869.84 07:25:53 INFO - RETURN: kraken: 1523.20 07:25:53 INFO - javascript benchmark 07:25:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3003.2341752853017, 3051.6643169251392, 3087.7529797616194, 3093.2266933266696, 3123.281645221599, 4967.751612419383, 4995.925875936673, 5003.274525193845, 5007.799688012479, 5039.59683225342, 4975.6019518438525, 5049.343585333911, 5056.418511871136, 5088.26220198071, 5094.439611642716, 4646.931205822662, 4651.139539185253, 4668.439787225538, 4763.952360476385, 4779.091972525226, 4553.2942393929, 4627.467841198255, 4711.199096153662, 4750.928736068961, 4785.0, 4642.558956899073, 4651.069786042771, 4662.160811054009, 4680.976595117037, 4689.320048592969, 4634.698744581625, 4644.489106198315, 4652.185867473212, 4666.066786642685, 4686.156491831503, 4577.679562430598, 4600.654950878664, 4614.423197100363, 4641.930371044437, 4649.651276154268, 4894.559489645913, 4951.950480495185, 4973.403191616993, 4996.0, 5013.548780609726, 5357.08929481989, 5458.099413596752, 5462.672239665632, 5464.23500709901, 5464.9453505464835, 5356.35723713153, 5442.2380866678695, 5454.563634909197, 5513.862153446155, 5557.027520183992, 5102.69383836971, 5112.284280200774, 5113.054084994325, 5117.462666420047, 5121.667091639031, 5527.53015993645, 5556.0, 5572.749226284745, 5579.0, 5628.605997580212, 5337.146056630921, 5355.678659280377, 5375.569954403638, 5392.083345831218, 5397.568194544427, 5371.704556249444, 5441.918371224435, 5455.263539422207, 5458.945410545924, 5480.588955828329, 5231.659942103827, 5411.485908838654, 5412.052890744104, 5414.648047876875, 5492.956338295711, 5373.489518495737, 5404.162354835007, 5405.891882162335, 5407.0267351876255, 5413.729313534308, 4226.852060177879, 4231.809568569361, 4233.174530966494, 4264.424302719093, 4270.210011147886, 3686.889393318205, 3766.7928263945196, 3770.1517158639635, 3792.715546334036, 3805.82873770681, 5013.0, 5046.142155833517, 5050.292958985745, 5073.213651883964, 5107.565856902205, 5350.170723537858, 5406.2701535292235, 5421.26812880264, 5424.945750542523, 5447.291852059287, 5000.924986125211, 5019.924701129486, 5027.773750181177, 5038.370203724535, 5052.242163675404, 4625.098105869391, 4655.906881862344, 4669.906601868011, 4678.251479763221, 4710.387649605529, 5557.3886872444, 5613.691246981373, 5636.098224284095, 5655.264815573949, 5683.0, 5405.297311349499, 5417.6478528895495, 5424.376196737426, 5430.864228394322, 5451.155070964007, 5607.775688972559, 5610.046292130429, 5616.0, 5618.803341883015, 5695.373508914099, 5250.264962905273, 5267.657602255841, 5308.230306605444, 5338.8932221356135, 5377.300950876361, 5387.542058925035, 5403.081476149143, 5408.0, 5422.403535611158, 5428.941356435457, 5172.250023746611, 5264.52619264268, 5280.341371440004, 5281.841544753664, 5330.706811125426, 5274.7890084396195, 5292.894142117213, 5308.761105750328, 5315.123004704181, 5373.462653734595, 5180.036644626831, 5185.533302002837, 5190.688558686491, 5195.74021298926, 5229.50319719626, 5192.039472697563, 5225.947740522698, 5258.0, 5275.894482110413, 5329.7068661224, 5195.76619052136, 5211.739413029258, 5214.661047031931, 5215.817446389358, 5240.0], "unit": "score", "name": "dojo.html", "value": 5009.780128357479}, {"lowerIsBetter": false, "replicates": [519.0371860199327, 546.9316335458068, 551.2282804074296, 552.4061633743726, 570.7089384413947, 28679.283017924536, 29094.563581546292, 29104.0, 29126.98055568058, 35738.821305893434, 39091.80454097725, 39547.80226098873, 39565.604343956555, 39590.40614390779, 39611.40582891259, 8573.871391929126, 8783.560821958908, 8787.0773568775, 8795.648174073029, 8800.779980500474, 8801.119888011179, 8973.865392019092, 8991.190792828644, 8996.0, 9005.819883602324, 8968.551572421353, 9036.8644470333, 9049.592768325441, 9062.093790620951, 9064.637414503444, 8872.778180545474, 8954.194122529003, 8956.68651597191, 8968.058353872815, 8974.102589741038, 8745.300375969908, 8778.429402088908, 8864.689735859278, 8903.910960890373, 8904.688335908211, 37887.81056094702, 38353.808230958944, 38363.616363836285, 38401.0, 38495.807520962495, 3333.3666603345287, 3350.79895206286, 3504.4217704078796, 3621.3119507293795, 4010.9197816043516, 29148.708512915022, 29231.2692182695, 29685.257868553457, 29732.40535189284, 29744.0, 3364.2262279675565, 3388.4917262410836, 3541.097020259843, 3556.2176321209295, 3560.732945029133, 263336.0, 264113.0, 264311.9999999981, 264519.0, 264551.0, 49860.50139498631, 50070.248946265834, 50369.0, 50386.74806625943, 55244.17133742997, 58704.0, 58869.0, 58912.11631825526, 58943.41056589465, 59090.0, 13941.58175254744, 14117.152970821784, 14122.788158177636, 14137.43450261978, 14138.50515231962, 10593.364398136137, 10612.25714200014, 10626.415547144981, 10631.255812093079, 10646.467676616137, 18473.353432629792, 18878.0, 18930.810691892904, 18972.430827075208, 18977.715334269997, 6369.0, 7232.168300645493, 7467.103947526223, 7517.511361761468, 7673.0, 923.4643906534194, 980.6665733650593, 997.1424574865609, 1074.8172810622214, 1140.0822338017808, 26184.476310473685, 27107.45785084287, 27160.592591111148, 27229.319267018484, 28105.71894281031, 1014.2899970021015, 1032.3754128751998, 1056.7675111475462, 1065.5524679634573, 1094.5129417409175, 14678.559643210721, 14723.558293251219, 14784.63038424048, 14899.851001490064, 15008.24958752058, 292770.0, 316095.0, 319841.0, 320897.0, 321500.0, 44854.32718509225, 45270.77364613156, 45481.0, 45495.77252113718, 45531.08937821225, 1329.0762919770666, 1330.8935285177163, 1332.7601031814368, 1345.4147445861277, 1346.8249127613544, 26875.596866046635, 27787.44425111527, 28191.0, 28549.28626784347, 28776.280592985342, 42751.0, 43316.0, 43324.56675433331, 43341.0, 43355.78322108495, 238478.0, 240887.0, 271438.0, 377234.0, 392818.0, 29156.27109322284, 29217.707822922348, 29245.415091698473, 29260.707392925797, 29526.0, 39803.40294895637, 40473.595264046984, 40661.1867762649, 40958.59041409548, 41361.0, 34552.654473454946, 34767.47848782321, 34823.65176348204, 34988.0, 35136.29727405489, 32598.34803303968, 34399.828000860834, 34441.55170521958, 34653.65346346605, 34738.65261347354, 34806.47790283097, 35325.0, 35531.64468355283, 35586.64413355833, 35841.46237806487, 30742.231444214074, 31211.375772484877, 31759.364812703156, 31805.0, 31813.20466988344, 24638.384040399134, 24688.876555617106, 24730.752692472845, 26135.346616334744, 26368.8681556591], "unit": "score", "name": "ext.html", "value": 17795.682109509875}, {"lowerIsBetter": false, "replicates": [363.25713915043735, 363.28614272953655, 365.4098630711401, 366.433859686784, 373.9981300093499, 13271.800922986164, 13894.930525347385, 16167.0, 16806.0, 17836.10819459025, 11124.944375278132, 11478.598249061284, 15720.0, 15998.840011599881, 16000.679986400264, 4937.407511098673, 5103.336566246383, 5103.795848166069, 5104.5405913467785, 5109.105906466353, 3623.836927338276, 3787.0532366908274, 4984.476629953857, 6572.178477690289, 6867.107276054106, 6138.754449822001, 6389.488840892741, 6721.663916804165, 6850.314968503159, 6860.622665753382, 6325.4307112359875, 6333.7466501339895, 6336.0, 6347.238331400238, 6647.933520664828, 6266.780662676784, 6453.935460645381, 6475.773347932847, 6482.286948435668, 6495.090687303781, 21628.783712162993, 22176.77823221763, 22189.11243550256, 22827.20104796341, 22919.083236670514, 2283.5889539882814, 2378.4410663494064, 2398.3404563744934, 2444.767747064026, 2939.8236105833716, 12948.676283092998, 13318.467261309535, 13484.190948543119, 13511.324433778273, 13673.179609223378, 1913.4546654203625, 1952.8616165298974, 1966.8328192103688, 1987.3541099142838, 2077.6779599162155, 60761.0, 61342.399320050725, 63621.04568431477, 64056.0, 64167.35832641661, 14872.256387180598, 15144.242787860563, 15154.16652084146, 15180.620484487976, 15186.924065379824, 23237.651435228487, 23329.533409331718, 23356.065757369855, 24435.900384482742, 24503.0, 8459.959340500991, 8680.522571258642, 8686.695965641173, 8709.608067636971, 8769.517676527725, 7495.737649182362, 7506.061742282215, 7545.584992825447, 7570.205128461543, 7595.430342724318, 6900.3099690031595, 7306.775283131291, 7706.842084216316, 7785.844283114419, 7854.646540905673, 2966.144012783373, 2981.2844917219713, 2987.731104200589, 3028.787984841084, 3072.1705139612627, 471.22718741264356, 472.09593628202293, 877.7630039889194, 894.0969620683027, 967.2455484721928, 9888.87389211323, 10313.896861031293, 11063.336199827874, 11112.94427029447, 11125.054370378446, 892.8839250897341, 894.7673604862653, 918.9248579162396, 926.3376685669779, 995.3331268050424, 8834.690785822466, 9170.770730731785, 9171.220446262143, 9339.159475647224, 9348.719538413858, 384027.0, 386668.0, 392746.0, 393017.0, 442699.0, 70938.0, 71099.2890071103, 72975.63512182511, 74881.0, 75241.62379188069, 992.8163289791412, 1097.7530055737395, 1144.4392247798685, 1153.7173392518887, 1155.1971379891063, 15214.847851521343, 15475.071495710294, 15523.534293971199, 15642.139682317582, 15729.842701572838, 33483.33033339271, 34116.829415852764, 34288.48567271443, 34369.484457733655, 35392.823035884656, 46519.767401162775, 46960.0, 47157.52842471531, 47999.5200047995, 48080.0, 7907.84184316322, 8017.679292828221, 8021.8395632088195, 8030.5181689098845, 8091.635876385694, 10435.37387756737, 11330.830037549278, 11954.043676505684, 12148.0, 12268.938655306667, 10502.05481506668, 10504.632337868137, 10551.841722374324, 10615.1507879371, 10694.679159625224, 10511.316764410289, 10646.0, 10785.838212426977, 10788.622398216025, 10883.183761218099, 10025.498725063571, 10305.53625086888, 10447.425391603534, 10593.09958653523, 10898.18263630215, 8102.959485202772, 8124.918750812416, 8158.265756081743, 8213.466124701876, 8218.137095605114, 10231.539580718736, 10580.0, 10806.0, 10820.4048777318, 10878.184136189975], "unit": "score", "name": "jquery.html", "value": 8895.872569432866}, {"lowerIsBetter": false, "replicates": [1303.6675647709833, 1441.2577522575873, 1448.3916754962918, 1601.7036848183086, 1774.2016092758254, 7133.607651579161, 7730.381569474443, 7954.642041108143, 7959.084705258882, 7960.084590272106, 7690.96154519228, 7906.802329941755, 7921.207879212076, 7926.841463170747, 7931.801704957365, 2010.879347239163, 2162.653975363942, 2202.592520383734, 2250.2574150530368, 2309.8614083155067, 2303.5738388398117, 2304.9884750576225, 2309.053288151858, 2313.27131953435, 2316.119874447716, 2271.454850835804, 2343.660169275454, 2346.038124369009, 2346.1905642553293, 2351.247600767755, 2257.6162052451123, 2288.0504590594965, 2337.5208082343165, 2337.649352597107, 2339.9883000584887, 2257.808086312665, 2267.331137314496, 2269.6708977198377, 2310.3761984264324, 2370.9644355334685, 8026.117127116013, 8082.3534117271065, 8092.190780921861, 8124.5937703114605, 8137.064237612691, 4677.625789936831, 4750.71495710255, 4770.403699537558, 4778.856634300976, 4788.0663270662235, 3043.3152540678393, 3058.480058390079, 3135.3572517634057, 3192.6488086310487, 3203.743700503954, 993.1260490768078, 997.3218211616098, 1025.2157099818644, 1029.1663752360612, 1030.1449796668746, 11183.888161118366, 11189.104871610252, 11240.887591124148, 11282.999999999918, 11295.265807722553, 4374.103308821747, 4418.160549495586, 4504.864854054318, 4506.932396014063, 4522.479914809774, 9516.095970882894, 9567.61729530825, 9574.952125239468, 9621.51892405377, 9622.085901839455, 4943.8022479101155, 4951.876203094879, 4955.108080545464, 4975.203967365204, 4975.303457515951, 4526.7283962961665, 4527.162474942146, 4534.070515544306, 4534.093181363674, 4537.8411755588395, 3398.5411969384313, 3709.740318177756, 3831.0, 3831.6934645228316, 3847.3267178243696, 1242.1801610936739, 1263.6588121207405, 1265.0322503284995, 1270.4219580091037, 1270.688681273094, 1273.2678709741751, 1279.6033229698824, 1297.9221246725037, 1298.8766067223598, 1299.2139755448006, 7389.298016688406, 7517.962410188024, 7553.773386798405, 7565.6973721050545, 7760.068791745027, 1094.8029354716068, 1108.778244351133, 1111.5776005118003, 1118.8992990630882, 1130.9943450282697, 5833.154192642043, 5927.081302398135, 5945.702714864239, 5952.345242023374, 5953.583249172516, 9395.342326037111, 9405.90594094064, 9427.151556359824, 9573.234141268682, 9640.662576809778, 9394.154526092685, 9453.574589143505, 9453.810923781624, 9462.337636365388, 9465.05349465048, 7378.229224985965, 7414.14737305206, 7496.812579685551, 7504.812379690551, 7577.242275772489, 7449.478536502393, 7451.105867295959, 7501.887471688038, 7576.848463030598, 7598.924010760043, 8548.016978047604, 8649.654013839629, 8861.069587693199, 8866.512341821262, 8877.24543413817, 8963.372563920462, 8979.955100224719, 9016.09839016093, 9086.591103400495, 9099.0, 6691.397774200345, 7664.6550905210515, 7807.51657185133, 7815.29662330393, 7820.217978202134, 7465.328120469184, 7625.618719063914, 7639.350655194148, 7678.308952194329, 7696.576688282198, 6979.965100174467, 7056.788296351117, 7261.891071634035, 7269.0550228472075, 7481.7755467336065, 7241.565506069653, 7261.564306141649, 7302.56184628924, 7398.0, 7406.44451666138, 7187.820304492429, 7188.60462674537, 7190.209077001421, 7207.9639601801655, 7295.598742069024, 6666.6000039995815, 6703.966480167763, 6716.932830671631, 6717.429018533479, 6724.562903411263, 6505.154329937078, 6508.284088750328, 6636.5113082594025, 6669.799906002828, 6713.261541230363], "unit": "score", "name": "mootools.html", "value": 4626.995341004239}, {"lowerIsBetter": false, "replicates": [339.6298035141695, 344.68633543475437, 346.98785542506016, 351.4885841101198, 352.6315000824137, 5805.564582656302, 5828.154917536955, 5873.647581145135, 5875.941240587593, 5886.146508756227, 5734.741936612852, 5768.826935191941, 5790.565707571928, 5795.3335366432875, 5797.71011449428, 4549.954500455003, 4552.635789136861, 4559.042601053783, 4562.703424277412, 4566.0, 4459.9331010034875, 4533.478649955265, 4554.817807287721, 4558.977205113986, 4567.885802854938, 4508.819647214107, 4513.435820522434, 4519.909601807962, 4524.479684836237, 4525.230710779159, 4271.487421509439, 4355.346697995326, 4517.960869000132, 4527.253003254459, 4531.750753708545, 3893.7274390792654, 3950.1902110067367, 3972.761634301922, 3986.8405263789414, 3997.420374045776, 5474.562035037187, 5497.45025497451, 5536.501714845643, 5541.861453463655, 5571.275734154575, 4928.778204980748, 5081.314022606938, 5234.685918844882, 5237.319148510707, 5264.184051472028, 6105.847353816146, 6110.480609148183, 6115.694215289218, 6123.510119190454, 6132.172156758825, 4390.385346051524, 4392.78036098197, 4393.51671316155, 4396.1867054595, 4401.361802538614, 6255.40573645503, 6411.262704788963, 6416.550841441101, 6423.454006409461, 6426.389492998158, 4536.97731511347, 4537.500874903758, 4540.636749060067, 4542.295944128666, 4547.931781023287, 4587.9541204588195, 4596.724196548218, 4600.35595016698, 4602.05657840142, 4608.907821843544, 5221.347331583552, 5228.934570844571, 5236.581073514109, 5237.711925844039, 5240.973795131, 6021.367756385516, 6169.198004259418, 6185.969070154621, 6191.907121393093, 6195.597286176384, 1597.8402159784162, 1611.8791090668012, 1612.3953517430964, 1612.6290953080857, 1613.572403313123, 1101.2841652925663, 1111.2332490581473, 1121.52895783771, 1125.7635896461834, 1128.3173679923693, 5830.125481177857, 5842.298924129132, 5854.941450585525, 5858.091995740667, 5870.14882841994, 6289.308176100625, 6306.49548036156, 6336.271328797156, 6402.423781859655, 6411.487081033506, 5793.507551858055, 5824.155497452845, 5841.182234487175, 5856.648601083949, 5865.178874957509, 3292.0782180989363, 3390.627031026585, 3412.351653185887, 3413.419718647836, 3417.572803399575, 6540.05169250456, 6551.181102362205, 6567.802965911031, 6568.835779105465, 6569.770058047945, 6223.097650840603, 6437.259715132726, 6438.8390290243115, 6442.452391546771, 6453.870922581522, 6615.338466153346, 6622.039804228456, 6631.23740769808, 6640.767573135014, 6641.767538136142, 6322.652254125883, 6326.588771729823, 6338.080978258219, 6342.841428964312, 6349.079383489276, 6029.336772954884, 6174.876502469836, 6253.656048917172, 6325.905111423241, 6333.493320534254, 6605.405513503808, 6614.603123812587, 6644.169478815148, 6669.699863506251, 6670.599764014175, 4575.656825738017, 4576.725396476222, 4577.176108300538, 4577.267637178035, 4579.313103034571, 6199.1011303359855, 6392.968035159794, 6403.0715546246465, 6404.103425520338, 6411.96794016027, 6188.628682279078, 6227.408396202353, 6231.4391704746795, 6238.500919926304, 6240.095186198067, 6223.3465486125115, 6227.128202051807, 6228.252609686867, 6229.906551401823, 6232.657203853832, 6014.097885317237, 6060.151578779062, 6112.510999120149, 6117.938820611737, 6126.693665316806, 6235.501159907287, 6248.250209974832, 6280.0, 6313.43179113882, 6316.210473690789, 6106.542009349406, 6121.755129794758, 6127.509799216141, 6135.049067394561, 6141.048137538689], "unit": "score", "name": "prototype.html", "value": 4703.841194578308}, {"lowerIsBetter": false, "replicates": [617.3209469583456, 658.2035736758519, 665.4809248785947, 744.7616762635955, 763.8739607964679, 13812.93093534532, 13882.375293111809, 13900.652483687913, 13961.232132232723, 13968.371423285938, 12974.675633109176, 13068.346582670853, 13142.540011099614, 13144.47422103117, 13238.536651217186, 804.0, 819.1194465949128, 819.3404309530825, 819.8278361544083, 819.8524265632213, 807.7657479331016, 813.7396033269356, 814.1207495904409, 814.5357146426539, 815.4536460571402, 844.9493030418164, 849.8725191221305, 849.9970035358275, 850.2475309351207, 850.6469815026757, 832.6169961817571, 836.2181360427988, 836.782436566491, 836.8661014237754, 837.2381133168848, 617.1699064757894, 618.8514756458462, 619.164128426625, 619.863630001399, 620.221621864557, 12712.364381780966, 12745.681357966032, 12753.234805911583, 12757.0, 12778.041646876522, 10702.0, 10725.195610329178, 10815.513301901434, 10898.50956706942, 10931.453427328603, 9857.55640996157, 9956.402615843073, 9964.352317099365, 10040.648577299833, 10051.296409251356, 3208.181913612014, 3320.684534969174, 3349.7822641528223, 3459.9827000865084, 3583.552055993001, 42910.57089429097, 45696.08607827858, 45973.0, 46084.308735369, 47818.760906195595, 10030.29787914839, 10193.592256309812, 10261.486925653688, 10274.0, 10413.271071025107, 17218.05300708473, 17908.91045544764, 17939.103044847707, 19114.80885191158, 19272.22911083541, 6544.640044797487, 7462.850742985219, 7886.0, 7900.683972641145, 8083.797905052303, 4037.212743515045, 4217.8523751668545, 4248.830046798155, 4262.46719160105, 4378.693491455631, 3305.3554556861664, 3342.0, 3342.364950659367, 3343.281194543185, 3351.0449521886144, 600.2406955201674, 607.5959486941223, 619.5632079384023, 621.2265729167216, 640.4940097323063, 567.5714835299406, 576.573335731564, 577.6216578141324, 577.9479846813807, 596.6062398816847, 7559.28186822251, 7729.149793522708, 7846.293833555007, 7955.4033447491665, 7975.8404831903035, 485.5605676862445, 534.8502419322596, 601.8555546668767, 610.1366566308712, 612.0727098445858, 3604.3151801157696, 3721.6092310307567, 3747.2505498900327, 3791.75353602015, 3821.796134217768, 57202.427975720544, 57586.424135758105, 57970.0, 58004.0, 58226.708866455396, 42413.36379954303, 49991.50008499941, 50427.24359134616, 50786.23820642693, 50820.0, 41373.172536549704, 41523.0, 41583.58416415797, 42107.0, 42121.36817947733, 7988.201179882198, 8017.398695097774, 8139.226773456512, 8177.79555511117, 8308.6676532938, 32571.674283256863, 33177.66822331746, 34648.82675586606, 35408.11479713028, 35762.0, 38341.424878627404, 38346.233075338896, 38778.4183237246, 40051.79974100227, 40273.798631006655, 10018.248631352531, 10423.895761042293, 10499.737506562396, 11085.0, 11221.326720396803, 11395.088392928712, 11484.598039068593, 11516.596919107791, 11750.647480575597, 11991.64025079249, 10608.939106089329, 10649.201309901944, 10686.465676715978, 10712.678619641423, 10727.088197503299, 11466.770664586495, 11658.6502404928, 11662.650120496399, 11663.533458661559, 11671.416429178676, 10238.744031398977, 10477.9476102619, 10496.737581560523, 10519.842202367123, 11249.71875703114, 9073.092690730875, 9107.908920910972, 9672.419654820733, 9907.507291541777, 10143.137833284254, 9133.954330228305, 9280.95359523198, 9344.392614480037, 9347.859782103409, 9464.242860571276], "unit": "score", "name": "yui.html", "value": 6089.287892789262}], "name": "dromaeo_css", "value": 6869.835919109345}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 110.0, 111.0, 112.0, 103.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 150.0, 166.0, 127.0, 152.0, 154.0, 128.0, 173.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 163.0, 162.0, 162.0, 163.0, 167.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 129.0, 97.0, 74.0, 75.0, 74.0, 121.0, 97.0, 72.0], "unit": "score", "name": "audio-fft", "value": 89.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 140.0, 95.0, 96.0, 97.0, 142.0, 95.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 150.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [69.0, 59.0, 59.0, 56.0, 54.0, 56.0, 55.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 117.0, 116.0, 114.0, 117.0, 119.0, 125.0, 117.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [158.0, 150.0, 150.0, 163.0, 149.0, 140.0, 149.0, 151.0, 156.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 71.0, 70.0, 68.0, 68.0, 67.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1523.1999999999998}]} 07:25:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1523.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6869.84"}}} 07:25:53 INFO - Return code: 0 07:25:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:25:53 INFO - # TBPL SUCCESS # 07:25:53 INFO - Running post-action listener: _resource_record_post_action 07:25:53 INFO - Running post-run listener: _resource_record_post_run 07:25:54 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 538804224; Read time: 364; Write time: 557836 07:25:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240525312; Read time: 148; Write time: 303388 07:25:54 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298274816; Read time: 216; Write time: 254448 07:25:54 INFO - Running post-run listener: _upload_blobber_files 07:25:54 INFO - Blob upload gear active. 07:25:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:25:54 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 07:25:54 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:25:54 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:25:54 INFO - (blobuploader) - INFO - Open directory for files ... 07:25:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:25:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:55 INFO - (blobuploader) - INFO - Done attempting. 07:25:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:25:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:25:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:25:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:25:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:25:56 INFO - (blobuploader) - INFO - Done attempting. 07:25:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:25:56 INFO - Return code: 0 07:25:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:25:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:25:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/732147e86b58af5dacf369a10b5508f1ad147a1cb6d3b6728fcb4cd4ab8fabb56b0be0087332ccee3434fbec0f9986fb2a7e49931a8b0bcfc4919b77e9552cc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c8577ef55ee7fc0d33a7f65a4a68e58040865aa1a33ecec0cec01598bf016cdb45f096b87a79e2af292a4e9194d8467b269c9f355e849724445219a95a7b7e"} 07:25:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:25:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:25:56 INFO - Contents: 07:25:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/732147e86b58af5dacf369a10b5508f1ad147a1cb6d3b6728fcb4cd4ab8fabb56b0be0087332ccee3434fbec0f9986fb2a7e49931a8b0bcfc4919b77e9552cc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c8577ef55ee7fc0d33a7f65a4a68e58040865aa1a33ecec0cec01598bf016cdb45f096b87a79e2af292a4e9194d8467b269c9f355e849724445219a95a7b7e"} 07:25:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:25:56 INFO - Copying logs to upload dir... 07:25:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:25:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.723361 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-17 07:25:56.306905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 07:25:56.310833) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/732147e86b58af5dacf369a10b5508f1ad147a1cb6d3b6728fcb4cd4ab8fabb56b0be0087332ccee3434fbec0f9986fb2a7e49931a8b0bcfc4919b77e9552cc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c8577ef55ee7fc0d33a7f65a4a68e58040865aa1a33ecec0cec01598bf016cdb45f096b87a79e2af292a4e9194d8467b269c9f355e849724445219a95a7b7e"} build_url:https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/X3Biz1efSimhoQMivPEflA/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/Firefox/sha512/732147e86b58af5dacf369a10b5508f1ad147a1cb6d3b6728fcb4cd4ab8fabb56b0be0087332ccee3434fbec0f9986fb2a7e49931a8b0bcfc4919b77e9552cc5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4c8577ef55ee7fc0d33a7f65a4a68e58040865aa1a33ecec0cec01598bf016cdb45f096b87a79e2af292a4e9194d8467b269c9f355e849724445219a95a7b7e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 07:25:56.336062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:25:56.336412) ========= 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=03627c79f6bb3d1578c4a402000001ba-1455721407.630209-374731027 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 07:25:56.422390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 07:25:56.422739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 07:25:56.423039) ========= ========= Total master_lag: 0.32 =========