builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1455170662.27 results: success (0) buildid: 20160210193318 builduid: df05cdd863ea4e4687cfe92a42db194c revision: 092510c19ca5514165e7493c75468f348ad053bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.270046) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.270531) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.270856) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006603 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.296463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.296768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.311876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.312200) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.379667) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.379986) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.380417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.380737) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-10 22:04:22-- 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% 43.3M=0s 2016-02-10 22:04:22 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105395 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.501794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.502115) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015582 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.553064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:22.553440) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 092510c19ca5514165e7493c75468f348ad053bc --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 092510c19ca5514165e7493c75468f348ad053bc --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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-10 22:04:22,889 truncating revision to first 12 chars 2016-02-10 22:04:22,890 Setting DEBUG logging. 2016-02-10 22:04:22,890 attempt 1/10 2016-02-10 22:04:22,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/092510c19ca5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 22:04:23,207 unpacking tar archive at: mozilla-inbound-092510c19ca5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649394 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:23.219885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:23.220278) ========= echo 092510c19ca5514165e7493c75468f348ad053bc in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'092510c19ca5514165e7493c75468f348ad053bc'] 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 092510c19ca5514165e7493c75468f348ad053bc program finished with exit code 0 elapsedTime=0.004673 script_repo_revision: '092510c19ca5514165e7493c75468f348ad053bc' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:23.273867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:23.274188) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 22:04:23.284228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-10 22:04:23.284533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:04:23 INFO - MultiFileLogger online at 20160210 22:04:23 in /builds/slave/test-pgo 22:04:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:04:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:04:23 INFO - {'append_to_log': False, 22:04:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:04:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:04:23 INFO - 'branch': 'Mozilla-Inbound', 22:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 22:04:23 INFO - 'config_files': ('talos/linux_config.py',), 22:04:23 INFO - 'default_actions': ('clobber', 22:04:23 INFO - 'read-buildbot-config', 22:04:23 INFO - 'download-and-extract', 22:04:23 INFO - 'populate-webroot', 22:04:23 INFO - 'create-virtualenv', 22:04:23 INFO - 'install', 22:04:23 INFO - 'run-tests'), 22:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:04:23 INFO - 'download_minidump_stackwalk': True, 22:04:23 INFO - 'download_symbols': 'ondemand', 22:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 22:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 22:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:04:23 INFO - 'installer_path': 'installer.exe', 22:04:23 INFO - 'log_level': 'info', 22:04:23 INFO - 'log_name': 'talos', 22:04:23 INFO - 'log_to_console': True, 22:04:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:04:23 INFO - 'opt_config_files': (), 22:04:23 INFO - 'pip_index': False, 22:04:23 INFO - 'sps_profile': False, 22:04:23 INFO - 'sps_profile_interval': 0, 22:04:23 INFO - 'suite': 'dromaeojs', 22:04:23 INFO - 'system_bits': '32', 22:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:04:23 INFO - 'title': 'talos-linux64-ix-008', 22:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:04:23 INFO - 'use_talos_json': True, 22:04:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:04:23 INFO - 'work_dir': 'build'} 22:04:23 INFO - ##### 22:04:23 INFO - ##### Running clobber step. 22:04:23 INFO - ##### 22:04:23 INFO - Running pre-action listener: _resource_record_pre_action 22:04:23 INFO - Running main action method: clobber 22:04:23 INFO - rmtree: /builds/slave/test-pgo/build 22:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:04:24 INFO - Running post-action listener: _resource_record_post_action 22:04:24 INFO - ##### 22:04:24 INFO - ##### Running read-buildbot-config step. 22:04:24 INFO - ##### 22:04:24 INFO - Running pre-action listener: _resource_record_pre_action 22:04:24 INFO - Running main action method: read_buildbot_config 22:04:24 INFO - Using buildbot properties: 22:04:24 INFO - { 22:04:24 INFO - "project": "", 22:04:24 INFO - "product": "firefox", 22:04:24 INFO - "script_repo_revision": "production", 22:04:24 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:04:24 INFO - "repository": "", 22:04:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:04:24 INFO - "buildid": "20160210193318", 22:04:24 INFO - "pgo_build": "True", 22:04:24 INFO - "basedir": "/builds/slave/test-pgo", 22:04:24 INFO - "buildnumber": 677, 22:04:24 INFO - "slavename": "talos-linux64-ix-008", 22:04:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:04:24 INFO - "platform": "ubuntu64_hw", 22:04:24 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:04:24 INFO - "branch": "mozilla-inbound", 22:04:24 INFO - "repo_path": "integration/mozilla-inbound", 22:04:24 INFO - "revision": "092510c19ca5514165e7493c75468f348ad053bc", 22:04:24 INFO - "stage_platform": "linux64-pgo", 22:04:24 INFO - "builduid": "df05cdd863ea4e4687cfe92a42db194c", 22:04:24 INFO - "slavebuilddir": "test" 22:04:24 INFO - } 22:04:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:04:24 INFO - Running post-action listener: _resource_record_post_action 22:04:24 INFO - ##### 22:04:24 INFO - ##### Running download-and-extract step. 22:04:24 INFO - ##### 22:04:24 INFO - Running pre-action listener: _resource_record_pre_action 22:04:24 INFO - Running main action method: download_and_extract 22:04:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:24 INFO - https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/test_packages.json 22:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/test_packages.json 22:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:04:33 INFO - Downloaded 1448 bytes. 22:04:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:04:33 INFO - Using the following test package requirements: 22:04:33 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:33 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:04:33 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:04:33 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'jsshell-linux-x86_64.zip'], 22:04:33 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:04:33 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:33 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:04:33 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:04:33 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:04:33 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:04:33 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:04:33 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:04:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:04:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:33 INFO - https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:04:35 INFO - Downloaded 23297646 bytes. 22:04:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:04:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:04:37 INFO - Return code: 0 22:04:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:37 INFO - https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:04:39 INFO - Downloaded 23297646 bytes. 22:04:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:04:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:04:40 INFO - Return code: 0 22:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:40 INFO - https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:04:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:04:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:04:42 INFO - Downloaded 10706547 bytes. 22:04:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:04:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:04:42 INFO - Return code: 0 22:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:42 INFO - https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:04:43 INFO - Downloaded 56571765 bytes. 22:04:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:43 INFO - mkdir: /builds/slave/test-pgo/properties 22:04:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:04:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:04:43 INFO - Contents: 22:04:43 INFO - build_url:https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:04:44 INFO - Running post-action listener: _resource_record_post_action 22:04:44 INFO - Running post-action listener: set_extra_try_arguments 22:04:44 INFO - ##### 22:04:44 INFO - ##### Running populate-webroot step. 22:04:44 INFO - ##### 22:04:44 INFO - Running pre-action listener: _resource_record_pre_action 22:04:44 INFO - Running main action method: populate_webroot 22:04:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:04:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:04:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:04:44 INFO - '--tppagecycles', 22:04:44 INFO - '7'], 22:04:44 INFO - 'tests': ['tsvgm']}}, 22:04:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:04:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:04:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:04:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:04:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:04:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'tests': ['damp', 'tps']}, 22:04:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['damp', 'tps']}, 22:04:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:04:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:04:44 INFO - 'other': {'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'other_l64': {'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:04:44 INFO - 'ts_paint', 22:04:44 INFO - 'tpaint', 22:04:44 INFO - 'sessionrestore', 22:04:44 INFO - 'sessionrestore_no_auto_restore']}, 22:04:44 INFO - 'svgr': {'tests': ['tsvgx', 22:04:44 INFO - 'tsvgr_opacity', 22:04:44 INFO - 'tart', 22:04:44 INFO - 'tscrollx', 22:04:44 INFO - 'cart']}, 22:04:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['tsvgx', 22:04:44 INFO - 'tsvgr_opacity', 22:04:44 INFO - 'tart', 22:04:44 INFO - 'tscrollx', 22:04:44 INFO - 'cart']}, 22:04:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'tests': ['tp5o']}, 22:04:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'talos_options': ['--e10s'], 22:04:44 INFO - 'tests': ['tp5o']}, 22:04:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'talos_options': ['--xperf_path', 22:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:44 INFO - 'tests': ['tp5n']}, 22:04:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:04:44 INFO - 'talos_options': ['--e10s', 22:04:44 INFO - '--xperf_path', 22:04:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:04:44 INFO - 'tests': ['tp5n']}}, 22:04:44 INFO - 'talos.zip': {'path': '', 22:04:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:04:44 INFO - Running post-action listener: _resource_record_post_action 22:04:44 INFO - ##### 22:04:44 INFO - ##### Running create-virtualenv step. 22:04:44 INFO - ##### 22:04:44 INFO - Running pre-action listener: _resource_record_pre_action 22:04:44 INFO - Running main action method: create_virtualenv 22:04:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:04:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:04:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:04:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:04:44 INFO - Using real prefix '/usr' 22:04:44 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:04:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:04:46 INFO - Installing pip.................done. 22:04:46 INFO - Return code: 0 22:04:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:04: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')]} 22:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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')]} 22:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:04: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 pip>=1.5 22:04:46 INFO - Using env: {'DISPLAY': ':0', 22:04:46 INFO - 'HOME': '/home/cltbld', 22:04:46 INFO - 'LANG': 'en_US.UTF-8', 22:04:46 INFO - 'LANGUAGE': 'en_US:en', 22:04:46 INFO - 'LOGNAME': 'cltbld', 22:04:46 INFO - 'MAIL': '/var/mail/cltbld', 22:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:46 INFO - 'MOZ_NO_REMOTE': '1', 22:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:46 INFO - 'NO_EM_RESTART': '1', 22:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:46 INFO - 'SHELL': '/bin/bash', 22:04:46 INFO - 'SHLVL': '1', 22:04:46 INFO - 'TERM': 'linux', 22:04:46 INFO - 'TMOUT': '86400', 22:04:46 INFO - 'USER': 'cltbld', 22:04:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:46 INFO - '_': '/tools/buildbot/bin/python'} 22:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:04:47 INFO - Cleaning up... 22:04:47 INFO - Return code: 0 22:04:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:47 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:04:47 INFO - Using env: {'DISPLAY': ':0', 22:04:47 INFO - 'HOME': '/home/cltbld', 22:04:47 INFO - 'LANG': 'en_US.UTF-8', 22:04:47 INFO - 'LANGUAGE': 'en_US:en', 22:04:47 INFO - 'LOGNAME': 'cltbld', 22:04:47 INFO - 'MAIL': '/var/mail/cltbld', 22:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:47 INFO - 'MOZ_NO_REMOTE': '1', 22:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:47 INFO - 'NO_EM_RESTART': '1', 22:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:47 INFO - 'SHELL': '/bin/bash', 22:04:47 INFO - 'SHLVL': '1', 22:04:47 INFO - 'TERM': 'linux', 22:04:47 INFO - 'TMOUT': '86400', 22:04:47 INFO - 'USER': 'cltbld', 22:04:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:47 INFO - '_': '/tools/buildbot/bin/python'} 22:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:47 INFO - Downloading/unpacking psutil>=0.7.1 22:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:49 INFO - Installing collected packages: psutil 22:04:49 INFO - Running setup.py install for psutil 22:04:49 INFO - building 'psutil._psutil_linux' extension 22:04:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:04:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:04:49 INFO - building 'psutil._psutil_posix' extension 22:04:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:04:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:04:49 INFO - Successfully installed psutil 22:04:49 INFO - Cleaning up... 22:04:49 INFO - Return code: 0 22:04:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:04: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')]} 22:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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')]} 22:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:49 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:04:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:04:49 INFO - Using env: {'DISPLAY': ':0', 22:04:49 INFO - 'HOME': '/home/cltbld', 22:04:49 INFO - 'LANG': 'en_US.UTF-8', 22:04:49 INFO - 'LANGUAGE': 'en_US:en', 22:04:49 INFO - 'LOGNAME': 'cltbld', 22:04:49 INFO - 'MAIL': '/var/mail/cltbld', 22:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:49 INFO - 'MOZ_NO_REMOTE': '1', 22:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:49 INFO - 'NO_EM_RESTART': '1', 22:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:49 INFO - 'SHELL': '/bin/bash', 22:04:49 INFO - 'SHLVL': '1', 22:04:49 INFO - 'TERM': 'linux', 22:04:49 INFO - 'TMOUT': '86400', 22:04:49 INFO - 'USER': 'cltbld', 22:04:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:49 INFO - '_': '/tools/buildbot/bin/python'} 22:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:04:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:04:51 INFO - Installing collected packages: mozsystemmonitor 22:04:51 INFO - Running setup.py install for mozsystemmonitor 22:04:51 INFO - Successfully installed mozsystemmonitor 22:04:51 INFO - Cleaning up... 22:04:51 INFO - Return code: 0 22:04:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04: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')]} 22:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:52 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:04:52 INFO - Using env: {'DISPLAY': ':0', 22:04:52 INFO - 'HOME': '/home/cltbld', 22:04:52 INFO - 'LANG': 'en_US.UTF-8', 22:04:52 INFO - 'LANGUAGE': 'en_US:en', 22:04:52 INFO - 'LOGNAME': 'cltbld', 22:04:52 INFO - 'MAIL': '/var/mail/cltbld', 22:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:52 INFO - 'MOZ_NO_REMOTE': '1', 22:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:52 INFO - 'NO_EM_RESTART': '1', 22:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:52 INFO - 'SHELL': '/bin/bash', 22:04:52 INFO - 'SHLVL': '1', 22:04:52 INFO - 'TERM': 'linux', 22:04:52 INFO - 'TMOUT': '86400', 22:04:52 INFO - 'USER': 'cltbld', 22:04:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:52 INFO - '_': '/tools/buildbot/bin/python'} 22:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:04:53 INFO - Downloading blobuploader-1.2.4.tar.gz 22:04:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:04:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04: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 22:04:54 INFO - Downloading docopt-0.6.1.tar.gz 22:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:04:54 INFO - Installing collected packages: blobuploader, requests, docopt 22:04:54 INFO - Running setup.py install for blobuploader 22:04:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:04:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:04:54 INFO - Running setup.py install for requests 22:04:55 INFO - Running setup.py install for docopt 22:04:55 INFO - Successfully installed blobuploader requests docopt 22:04:55 INFO - Cleaning up... 22:04:55 INFO - Return code: 0 22:04:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:55 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:04:55 INFO - Using env: {'DISPLAY': ':0', 22:04:55 INFO - 'HOME': '/home/cltbld', 22:04:55 INFO - 'LANG': 'en_US.UTF-8', 22:04:55 INFO - 'LANGUAGE': 'en_US:en', 22:04:55 INFO - 'LOGNAME': 'cltbld', 22:04:55 INFO - 'MAIL': '/var/mail/cltbld', 22:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:55 INFO - 'MOZ_NO_REMOTE': '1', 22:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:55 INFO - 'NO_EM_RESTART': '1', 22:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:55 INFO - 'SHELL': '/bin/bash', 22:04:55 INFO - 'SHLVL': '1', 22:04:55 INFO - 'TERM': 'linux', 22:04:55 INFO - 'TMOUT': '86400', 22:04:55 INFO - 'USER': 'cltbld', 22:04:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:55 INFO - '_': '/tools/buildbot/bin/python'} 22:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:55 INFO - Running setup.py (path:/tmp/pip-vtcyoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:55 INFO - Running setup.py (path:/tmp/pip-rEtrnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:55 INFO - Running setup.py (path:/tmp/pip-4Cgo1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:55 INFO - Running setup.py (path:/tmp/pip-WC8JZL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:55 INFO - Running setup.py (path:/tmp/pip-Ldw6iw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:55 INFO - Running setup.py (path:/tmp/pip-uPx91N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:55 INFO - Running setup.py (path:/tmp/pip-yWM8pb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:56 INFO - Running setup.py (path:/tmp/pip-vRZjFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:56 INFO - Running setup.py (path:/tmp/pip-Tj0ozz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:56 INFO - Running setup.py (path:/tmp/pip-MVEqIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:56 INFO - Running setup.py (path:/tmp/pip-sNpfgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:56 INFO - Running setup.py (path:/tmp/pip-Y6iHdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:56 INFO - Running setup.py (path:/tmp/pip-zuyjOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:56 INFO - Running setup.py (path:/tmp/pip-EXk0Cf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:56 INFO - Running setup.py (path:/tmp/pip-eoDCG3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:56 INFO - Running setup.py (path:/tmp/pip-G60mrc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:56 INFO - Running setup.py (path:/tmp/pip-ukRcoI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:04:56 INFO - Running setup.py install for manifestparser 22:04:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:04:56 INFO - Running setup.py install for mozcrash 22:04:56 INFO - Running setup.py install for mozdebug 22:04:57 INFO - Running setup.py install for mozdevice 22:04:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for mozfile 22:04:57 INFO - Running setup.py install for mozhttpd 22:04:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for mozinfo 22:04:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for mozInstall 22:04:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for mozleak 22:04:57 INFO - Running setup.py install for mozlog 22:04:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for moznetwork 22:04:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:04:57 INFO - Running setup.py install for mozprocess 22:04:58 INFO - Running setup.py install for mozprofile 22:04:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:04:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:04:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:04:58 INFO - Running setup.py install for mozrunner 22:04:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:04:58 INFO - Running setup.py install for mozscreenshot 22:04:58 INFO - Running setup.py install for moztest 22:04:58 INFO - Running setup.py install for mozversion 22:04:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:04:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:04:58 INFO - Cleaning up... 22:04:58 INFO - Return code: 0 22:04:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:04:58 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:04:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:04:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:04:58 INFO - Using env: {'DISPLAY': ':0', 22:04:58 INFO - 'HOME': '/home/cltbld', 22:04:58 INFO - 'LANG': 'en_US.UTF-8', 22:04:58 INFO - 'LANGUAGE': 'en_US:en', 22:04:58 INFO - 'LOGNAME': 'cltbld', 22:04:58 INFO - 'MAIL': '/var/mail/cltbld', 22:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:04:58 INFO - 'MOZ_NO_REMOTE': '1', 22:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:04:58 INFO - 'NO_EM_RESTART': '1', 22:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:04:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:04:58 INFO - 'SHELL': '/bin/bash', 22:04:58 INFO - 'SHLVL': '1', 22:04:58 INFO - 'TERM': 'linux', 22:04:58 INFO - 'TMOUT': '86400', 22:04:58 INFO - 'USER': 'cltbld', 22:04:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:04:58 INFO - '_': '/tools/buildbot/bin/python'} 22:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:04:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:58 INFO - Running setup.py (path:/tmp/pip-ayYQhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:04:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:58 INFO - Running setup.py (path:/tmp/pip-zI1GMA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:04:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:58 INFO - Running setup.py (path:/tmp/pip-BqtONg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:04:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:04:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:59 INFO - Running setup.py (path:/tmp/pip-V3uR_d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:59 INFO - Running setup.py (path:/tmp/pip-4osJLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:59 INFO - Running setup.py (path:/tmp/pip-4V8b7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:59 INFO - Running setup.py (path:/tmp/pip-kZTHho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:59 INFO - Running setup.py (path:/tmp/pip-sry84X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:59 INFO - Running setup.py (path:/tmp/pip-2Nm6Zu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:59 INFO - Running setup.py (path:/tmp/pip-5hOFuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:59 INFO - Running setup.py (path:/tmp/pip-EBp5J7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:59 INFO - Running setup.py (path:/tmp/pip-W8Nrqy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:59 INFO - Running setup.py (path:/tmp/pip-J_DEzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:59 INFO - Running setup.py (path:/tmp/pip-tRSrgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:59 INFO - Running setup.py (path:/tmp/pip-zEM0O7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:59 INFO - Running setup.py (path:/tmp/pip-R0xsju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:04:59 INFO - Running setup.py (path:/tmp/pip-76iYE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:05:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:01 INFO - Downloading blessings-1.6.tar.gz 22:05:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:05:01 INFO - Installing collected packages: blessings 22:05:01 INFO - Running setup.py install for blessings 22:05:01 INFO - Successfully installed blessings 22:05:01 INFO - Cleaning up... 22:05:02 INFO - Return code: 0 22:05:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:05:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:05:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:05:02 INFO - Reading from file tmpfile_stdout 22:05:02 INFO - Current package versions: 22:05:02 INFO - argparse == 1.2.1 22:05:02 INFO - blessings == 1.6 22:05:02 INFO - blobuploader == 1.2.4 22:05:02 INFO - docopt == 0.6.1 22:05:02 INFO - manifestparser == 1.1 22:05:02 INFO - mozInstall == 1.12 22:05:02 INFO - mozcrash == 0.16 22:05:02 INFO - mozdebug == 0.1 22:05:02 INFO - mozdevice == 0.48 22:05:02 INFO - mozfile == 1.2 22:05:02 INFO - mozhttpd == 0.7 22:05:02 INFO - mozinfo == 0.9 22:05:02 INFO - mozleak == 0.1 22:05:02 INFO - mozlog == 3.1 22:05:02 INFO - moznetwork == 0.27 22:05:02 INFO - mozprocess == 0.22 22:05:02 INFO - mozprofile == 0.28 22:05:02 INFO - mozrunner == 6.11 22:05:02 INFO - mozscreenshot == 0.1 22:05:02 INFO - mozsystemmonitor == 0.0 22:05:02 INFO - moztest == 0.7 22:05:02 INFO - mozversion == 1.4 22:05:02 INFO - psutil == 3.1.1 22:05:02 INFO - requests == 1.2.3 22:05:02 INFO - wsgiref == 0.1.2 22:05:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:02 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:05:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:05:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:05:02 INFO - Using env: {'DISPLAY': ':0', 22:05:02 INFO - 'HOME': '/home/cltbld', 22:05:02 INFO - 'LANG': 'en_US.UTF-8', 22:05:02 INFO - 'LANGUAGE': 'en_US:en', 22:05:02 INFO - 'LOGNAME': 'cltbld', 22:05:02 INFO - 'MAIL': '/var/mail/cltbld', 22:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:02 INFO - 'MOZ_NO_REMOTE': '1', 22:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:02 INFO - 'NO_EM_RESTART': '1', 22:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:05:02 INFO - 'SHELL': '/bin/bash', 22:05:02 INFO - 'SHLVL': '1', 22:05:02 INFO - 'TERM': 'linux', 22:05:02 INFO - 'TMOUT': '86400', 22:05:02 INFO - 'USER': 'cltbld', 22:05:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:02 INFO - '_': '/tools/buildbot/bin/python'} 22:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:05:02 INFO - Cleaning up... 22:05:02 INFO - Return code: 0 22:05:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:02 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 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:05:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:05:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:05:02 INFO - Using env: {'DISPLAY': ':0', 22:05:02 INFO - 'HOME': '/home/cltbld', 22:05:02 INFO - 'LANG': 'en_US.UTF-8', 22:05:02 INFO - 'LANGUAGE': 'en_US:en', 22:05:02 INFO - 'LOGNAME': 'cltbld', 22:05:02 INFO - 'MAIL': '/var/mail/cltbld', 22:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:02 INFO - 'MOZ_NO_REMOTE': '1', 22:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:02 INFO - 'NO_EM_RESTART': '1', 22:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:05:02 INFO - 'SHELL': '/bin/bash', 22:05:02 INFO - 'SHLVL': '1', 22:05:02 INFO - 'TERM': 'linux', 22:05:02 INFO - 'TMOUT': '86400', 22:05:02 INFO - 'USER': 'cltbld', 22:05:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:02 INFO - '_': '/tools/buildbot/bin/python'} 22:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:02 INFO - Downloading/unpacking jsonschema 22:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:05:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:05:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:05:04 INFO - warning: no files found matching '*.txt' 22:05:04 INFO - no previously-included directories found matching 'build' 22:05:04 INFO - no previously-included directories found matching 'dist' 22:05:04 INFO - no previously-included directories found matching '.git*' 22:05:04 INFO - Installing collected packages: jsonschema, functools32 22:05:04 INFO - Running setup.py install for functools32 22:05:04 INFO - warning: no files found matching '*.txt' 22:05:04 INFO - no previously-included directories found matching 'build' 22:05:04 INFO - no previously-included directories found matching 'dist' 22:05:04 INFO - no previously-included directories found matching '.git*' 22:05:04 INFO - Successfully installed jsonschema functools32 22:05:04 INFO - Cleaning up... 22:05:04 INFO - Return code: 0 22:05:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3e7278f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1173670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, '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': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:05:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:05:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:05:04 INFO - Using env: {'DISPLAY': ':0', 22:05:04 INFO - 'HOME': '/home/cltbld', 22:05:04 INFO - 'LANG': 'en_US.UTF-8', 22:05:04 INFO - 'LANGUAGE': 'en_US:en', 22:05:04 INFO - 'LOGNAME': 'cltbld', 22:05:04 INFO - 'MAIL': '/var/mail/cltbld', 22:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:04 INFO - 'MOZ_NO_REMOTE': '1', 22:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:04 INFO - 'NO_EM_RESTART': '1', 22:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:05:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:05:04 INFO - 'SHELL': '/bin/bash', 22:05:04 INFO - 'SHLVL': '1', 22:05:04 INFO - 'TERM': 'linux', 22:05:04 INFO - 'TMOUT': '86400', 22:05:04 INFO - 'USER': 'cltbld', 22:05:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:04 INFO - '_': '/tools/buildbot/bin/python'} 22:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:05:05 INFO - Downloading/unpacking flake8 22:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:05:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:05:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:05:07 INFO - no previously-included directories found matching 'docs/_build' 22:05:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:05:07 INFO - Running setup.py install for pep8 22:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:05:07 INFO - no previously-included directories found matching 'docs/_build' 22:05:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:05:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:05:07 INFO - Cleaning up... 22:05:07 INFO - Return code: 0 22:05:07 INFO - Running post-action listener: _resource_record_post_action 22:05:07 INFO - Running post-action listener: _start_resource_monitoring 22:05:07 INFO - Starting resource monitoring. 22:05:07 INFO - ##### 22:05:07 INFO - ##### Running install step. 22:05:07 INFO - ##### 22:05:07 INFO - Running pre-action listener: _resource_record_pre_action 22:05:07 INFO - Running main action method: install 22:05:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:05:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:05:08 INFO - Reading from file tmpfile_stdout 22:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:05:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:05:08 INFO - Reading from file tmpfile_stdout 22:05:08 INFO - Output received: 22:05:08 INFO - Usage: mozinstall [options] installer 22:05:08 INFO - Options: 22:05:08 INFO - -h, --help show this help message and exit 22:05:08 INFO - -d DEST, --destination=DEST 22:05:08 INFO - Directory to install application into. [default: 22:05:08 INFO - "/builds/slave/test-pgo"] 22:05:08 INFO - --app=APP Application being installed. [default: firefox] 22:05:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:05:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:05:24 INFO - Reading from file tmpfile_stdout 22:05:24 INFO - Output received: 22:05:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:05:24 INFO - Running post-action listener: _resource_record_post_action 22:05:24 INFO - ##### 22:05:24 INFO - ##### Running run-tests step. 22:05:24 INFO - ##### 22:05:24 INFO - Running pre-action listener: _resource_record_pre_action 22:05:24 INFO - Running main action method: run_tests 22:05:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:05:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:05:24 INFO - Python 2.7.3 22:05:24 INFO - Return code: 0 22:05:24 INFO - grabbing minidump binary from tooltool 22:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:05:24 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 0x12028c0>, '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 0x12037c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1203c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:05:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:05:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:05:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:05:24 INFO - Return code: 0 22:05:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:05:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:05:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:05:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:05:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:05:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:05:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:05:25 INFO - Return code: 0 22:05:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 22:05:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 22:05:25 INFO - Using env: {'DISPLAY': ':0', 22:05:25 INFO - 'HOME': '/home/cltbld', 22:05:25 INFO - 'LANG': 'en_US.UTF-8', 22:05:25 INFO - 'LANGUAGE': 'en_US:en', 22:05:25 INFO - 'LOGNAME': 'cltbld', 22:05:25 INFO - 'MAIL': '/var/mail/cltbld', 22:05:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:05:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:05:25 INFO - 'MOZ_NO_REMOTE': '1', 22:05:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:05:25 INFO - 'NO_EM_RESTART': '1', 22:05:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:05:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:05:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:05:25 INFO - 'SHELL': '/bin/bash', 22:05:25 INFO - 'SHLVL': '1', 22:05:25 INFO - 'TERM': 'linux', 22:05:25 INFO - 'TMOUT': '86400', 22:05:25 INFO - 'USER': 'cltbld', 22:05:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487', 22:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:05:25 INFO - '_': '/tools/buildbot/bin/python'} 22:05:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 22:05:25 INFO - mozversion application_buildid: 20160210193318 22:05:25 INFO - mozversion application_changeset: 092510c19ca5514165e7493c75468f348ad053bc 22:05:25 INFO - mozversion application_display_name: Nightly 22:05:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:05:25 INFO - mozversion application_name: Firefox 22:05:25 INFO - mozversion application_remotingname: firefox 22:05:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:05:25 INFO - mozversion application_vendor: Mozilla 22:05:25 INFO - mozversion application_version: 47.0a1 22:05:25 INFO - mozversion platform_buildid: 20160210193318 22:05:25 INFO - mozversion platform_changeset: 092510c19ca5514165e7493c75468f348ad053bc 22:05:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:05:25 INFO - mozversion platform_version: 47.0a1 22:05:25 INFO - using testdate: 1455170725 22:05:25 INFO - actual date: 1455170725 22:05:25 INFO - starting webserver on 'localhost:47921' 22:05:25 INFO - SUITE-START | Running 2 tests 22:05:25 INFO - TEST-START | dromaeo_css 22:05:25 INFO - operating with platform_type : linux_ 22:05:25 INFO - Initialising browser for dromaeo_css test... 22:05:25 INFO - TEST-INFO | started process 27643 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuw3gt_/profile http://localhost:47921/getInfo.html) 22:05:29 INFO - PROCESS | 27643 | __metrics Screen width/height:1600/1200 22:05:29 INFO - PROCESS | 27643 | colorDepth:24 22:05:29 INFO - PROCESS | 27643 | Browser inner width/height: 1024/697 22:05:29 INFO - PROCESS | 27643 | __metrics 22:05:30 INFO - PROCESS | 27643 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:05:31 INFO - TEST-INFO | 27643: exit 0 22:05:31 INFO - Browser initialized. 22:05:31 INFO - Running cycle 1/1 for dromaeo_css test... 22:05:31 INFO - TEST-INFO | started process 27735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuw3gt_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:42 INFO - PROCESS | 27735 | RSS: Main: 153423872 22:05:42 INFO - PROCESS | 27735 | 22:06:34 INFO - PROCESS | 27735 | 1455170794215 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:08:42 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47921/tests/dromaeo/cssquery-ext.html) 22:08:43 INFO - PROCESS | 27735 | RSS: Main: 267833344 22:08:43 INFO - PROCESS | 27735 | 22:11:45 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-ext.html (next: http://localhost:47921/tests/dromaeo/cssquery-jquery.html) 22:11:46 INFO - PROCESS | 27735 | RSS: Main: 239542272 22:11:46 INFO - PROCESS | 27735 | 22:14:48 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47921/tests/dromaeo/cssquery-mootools.html) 22:14:49 INFO - PROCESS | 27735 | RSS: Main: 234688512 22:14:49 INFO - PROCESS | 27735 | 22:17:50 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47921/tests/dromaeo/cssquery-prototype.html) 22:17:51 INFO - PROCESS | 27735 | RSS: Main: 220213248 22:17:51 INFO - PROCESS | 27735 | 22:20:53 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47921/tests/dromaeo/cssquery-yui.html) 22:20:54 INFO - PROCESS | 27735 | RSS: Main: 224288768 22:20:54 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | Cycle 1(1): loaded http://localhost:47921/tests/dromaeo/cssquery-yui.html (next: http://localhost:47921/tests/dromaeo/cssquery-dojo.html) 22:23:57 INFO - PROCESS | 27735 | RSS: Main: 296280064 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | __start_tp_report 22:23:57 INFO - PROCESS | 27735 | _x_x_mozilla_page_load 22:23:57 INFO - PROCESS | 27735 | _x_x_mozilla_page_load_details 22:23:57 INFO - PROCESS | 27735 | |i|pagename|runs| 22:23:57 INFO - PROCESS | 27735 | |0;dojo.html;3130.671279515651;3177.205698575356;3214.4696125139353;3219.5009773485117;3244.0916543367857;5014.749262536877;5105.668131571445;5130.179171332587;5136.717480538574;5144.099782538055;5101.056304583654;5115.616328775338;5145.845624631258;5146.588272938166;5153.433122356538;4569.977150114245;4594.058218065297;4625.653076019295;4667.696599721007;4757.333973243749;4640.930386044195;4658.720476771405;4660.6970546914345;4672.532746725317;4757.571818536331;4724.5984091352275;4739.241721324572;4756.9286460703115;4765.499622539635;4778.1638213312535;4719.07977944301;4733.928991065102;4735.171345014609;4770.61835053195;4791.736454495001;4663.556962088596;4666.39336886206;4721.409823772028;4747.7388743619085;4775.403074615673;4928.654994150411;4939.629527785394;4952.975235123838;4953;4973.602111831045;5345.278387417727;5443.646162999393;5459.508644222039;5467.726613669341;5485.6434331768305;5490;5494.615376923617;5510.448955104497;5546.611737178399;5595.076812325961;5042.6470147090085;5052.8484145475695;5056.797728090872;5094.108531007059;5123.769430375642;5483.588730845123;5483.8080667176455;5512.366077901012;5521.254630624894;5605.187247849039;5491.9725401373535;5510.8071217507195;5521.779128834802;5524.309461317335;5575.33096028471;5573.275474188411;5596.720163991866;5599.160125981054;5601.691906945076;5608.495235428831;5364.624476286623;5433.8369848904595;5485.698286594195;5549.556035517149;5565.437995808048;5513.393526712059;5519.69641669704;5520.089185284383;5522.889542209134;5560.388357280696;4297.72064815786;4300.526942036374;4302.204092242945;4310.698251122391;4344.326629372453;3766.9434958475645;3787.791671458041;3842.1547259602844;3872.9419058714143;3892.7469714469034;5043.722595257296;5053;5072.873178170502;5073.847784566469;5122.052420302256;5321.3348331458565;5488.313960754906;5509.063459211943;5510.559155267569;5520.1167813149705;4926.6551341406475;5013;5055.545000949932;5070.569001634903;5093.490650934951;4648.279516674921;4658.743769092733;4675.682779621041;4675.883102922454;4715.457722361973;5528.143137813645;5613.915791263134;5623.662580245198;5635.802746903839;5641.351244606841;5586.581006424616;5593.300837395325;5605.691686957257;5613.635113717595;5653;5582.525485333792;5598.552115830806;5601.24383208278;5601.495865372136;5621.7189140542;5353.089974704388;5356.089464790917;5374.973125134349;5408.026555220098;5430.918536222039;5459.754311055933;5464.153056276284;5466.945330546644;5469.890602187855;5508.614396992172;5345.518903298722;5355.758990845499;5357.678539287655;5367.463253674601;5405.78376864921;5312.9734351328;5338.065838478328;5344.10284349066;5356.892862142658;5380.139177731544;5282.55098316632;5310.203469479609;5312.5484333832055;5319.042572337016;5324.041672498987;5397.865053373697;5406.729663516887;5411.540019098264;5416.647917885325;5445.809396671098;5203.739813009259;5272.499112584298;5282.81510147143;5296.940611877717;5360.65155764874 22:23:57 INFO - PROCESS | 27735 | |1;ext.html;532.2335836395592;548.7256371814094;559.2003435087822;561.9353774315955;567.5856624663995;28008.159755207325;34647.48028779567;35367.469487957635;35404.64595354046;35520.64479355203;41277.380839287434;42022.36966445498;42187;42284;42291;8601.182887625666;8795.076516965722;8852;8854.468731876075;8871.778205544848;8612.48325100493;8740.300775937909;8743.912560874374;8749.343799215052;8756.956215218916;8795.076516965722;8842.204201621853;8850.955745221298;8881;8881.1118888111;8672.436291641056;8772.210501054871;8774.517401542913;8775.166359195866;8777.210051095368;8733.563321833946;8870.246029087471;8892.199702026848;8893.244074253696;8893.688720894737;38011.80994095039;38463.384393872635;38474.80762596197;38527.42208866869;38555.807220963994;3290.901272961815;3405.1487128217946;3839.212961342918;3852.499175107218;4062.1875624874847;29261.56107658387;29471.263218419495;29622.555661664876;29657.555136672967;30388.84805575958;3862.208247309323;3879.243547508237;3993.3610622300585;4007.8998025049314;4030.778307193103;256859;257272;257335.99999999814;257781;258877;50966.745166274675;56004;56186.719066405225;56189.71905140448;56216.71891640516;58533.70733146392;58601;58847.70576147092;59068.704656476446;59183.704081479314;14001.299935003413;14155.575332740034;14182.14907105577;14192;14350.354234059492;10868.836967445495;10930.453477326102;10958.178136639784;10960.945195274133;10988.066014388707;17504.674596772256;18904.338348157748;19076.52308692266;19124.521886952938;19237.13432895523;6007.909881351783;6945.756898508629;7270.818229544304;7277.781666550012;7293.52592081513;1016.9288149829441;1060.3266925502362;1072.8498010278568;1085.5223701571283;1182.0838849891402;29011.274718132216;29151;29250.414991700472;29425;29594.112176634735;1077.7144056824948;1122.3266040375709;1161.2916121166081;1173.0146676791537;1189.714468527547;15143;15215.239238038053;15307.923460382626;15508;15513;281664;402892;402978;406105;406255;47945.28082078772;47969.76015119972;48247.75876120597;48356.75821620869;48421.27368089482;1299.883010529038;1317.4598414650138;1332.293884241373;1350.2438634364787;1374.8900087993136;27173.456530869666;27981.860090699418;28325.150245491845;28715.13854584366;28907.42185156327;41790.79104604458;42180.1563968725;42191.1561768769;42249;42276;252371;378421;378532;378573;384063;29938.25154371158;29981.250468738457;29989.550156748104;30068.849655751583;30071.248218794706;41000.79499602483;41314.79342603268;41760.79119604383;42522.1495570093;42539;34293.82853085719;34560;34696.653033469345;35135.47296790499;35205.11987200341;35291.539672104656;35893.641063590076;36000.63999360077;36164;36219;36318.27363452769;36443.45334819927;36468.63531364759;36638;36721.63278367182;29855;31193;32270.515942261354;32429.51355729713;32508.349833002736;25055.248342549752;25311.493770124864;25433.237002889942;25517.61723574111;25945.351366215997 22:23:57 INFO - PROCESS | 27735 | |2;jquery.html;363.5419371591795;364.19512876542836;365.60879858551345;369.74487603553547;372.3409565069825;13611.319434028308;14122.576322710309;16333.836661633395;17158.48524544264;17566.209520571574;14996;15327.310271037803;15537.067775933423;15546.300416481257;16559.420420285292;5493.972530137344;5671.8582035449035;5677.971610141964;5679.119736440858;5679.914801277984;4085.8569950051756;5610.971945140269;5831.387704291031;6109.053096770008;6118.3269840317525;5909.704514774266;5996.460318571328;6052.425019623129;6070.878582428349;6241.407066328714;6155.415235552616;6157.7536898524;6206.317305096436;6216.129741836146;6220.440160385564;5298.682079075268;5417.702026388547;5419.268398766156;5423.29497165366;5430.185472179165;12372.195807272588;12699.936500317532;12712.936435317857;12743.808842867364;20425.8978705107;2081.177934715794;2123.352377524854;2386.331827088418;2828.9575656365173;2833.4049849531416;9252.16730494252;9339.299552533586;9404.576794044284;9625.663101791473;12556.18384804994;1822.6172503774224;1834.0462959261242;1866.3281218761235;1892.0823400650672;1909.7708275006948;59856.40143598595;60478.69760651213;60912.999999999556;61787.69106154441;63597.68201159011;10170.491475426199;10269.127124194378;10278.33190842593;10327.225458090674;10412.68761937128;13319.40062697181;13729;13733.587992360246;13752;13757.243351615758;6966.164060312795;7162.785116446515;7173.569585824867;7222.927770722331;7278.235785242579;7181.784546463615;7231.566106033655;7232.638368081575;7254.673539690621;7259.346658800628;4042.4744783178585;4259.787010649455;4422.159789640023;4461.866144015685;4531.501534831166;1766.8338896328362;1772.4328214971342;1792.3278770461077;1799.6706093726502;1813.5012871460453;914.095045904563;934.8457504511815;1020.1838529176629;1026.6047571684805;1046.3512622174148;12783.744325113446;16819.91590042042;16922.23849926756;16934.49196524106;18180.553554483555;930.2883294279882;989.42118860466;1023.8515415264894;1035.0994634667736;1094.5457635081352;9135.17783399484;9218.170364667078;9382.577783999737;9534.380265282734;9677.177439917687;336108;357433;423784;481264;492267;71430.64284678648;72021.63989180021;73971.63014185002;74442;75542.24457755462;1136.198979719296;1143.7540928700369;1154.001788452982;1160.3849959521467;1167.1129941244715;15380.38478460849;15769.526914192593;15935.601609959844;16184.271707772943;16330.183490825173;32126.83936580302;33217;33753.493697594065;34071.82964085164;34200.14499637529;42510.57489425066;43410;43444.13111737684;43691.78154109209;46744.06511869811;6916.308369163044;7400.629968501661;7449.47853650261;7546.886796698163;7574.5076570022775;9920.900790991998;11213.439328033728;11289.71775705614;11764.176507644383;11851.229670071418;10024.24818138628;10194;10317.74205644865;10499.737506562396;10537.473126343499;10027.348222365523;10172.542235599267;10248.11380579334;10484.94757526238;10605.469726513798;9792.461414622265;10209.183265338903;10496.580136794442;10500.894991050298;10815.513301901276;7529.924700752922;7811.570363630055;7831.765047048598;7866.292033716993;7898.249666281924;8292.2951549119;8691;10103.343282686601;10189.286749927434;10584.364938103738 22:23:57 INFO - PROCESS | 27735 | |3;mootools.html;1318.2617734068915;1419.4322271091562;1432.2552272818139;1605.0244242847175;1792.0323025566188;6720;7609.733659321925;7697.923020769791;7745.4190935679835;7759.961200194005;7614.619269036553;7804.531728096318;7805.219478052192;7811.140774514799;7816.491928024674;1950.3466338776527;1992.561636439981;2289.4848659051745;2307.630779075348;2333.7549557296493;2321.663358812971;2357.929262122139;2359.268626725712;2361.527694461106;2361.8819059047064;2274.158561332301;2340.707411573553;2342.601757701186;2342.8360014798973;2345.2846881701075;2286.6798648189265;2316.9420764480856;2319.5476882008015;2322.175627652176;2325.767423257678;2317.7798109179603;2319.0375993962484;2340.040583360814;2348.8473249238746;2357.481354102112;7754.495957762728;7840.568768717718;7846.372290216769;7847.1368149503505;7853.293203611703;4705.764711764398;4847.5394837490385;4851.442084160296;4852.9272060918765;4853.296272040534;3017.185359952822;3071.984640076808;3085.92285192872;3086.135881953057;3120.563121163039;973.124188230591;994.4778991029694;1025.7897131088184;1060;1066.3335415365398;10893.83659245112;10910.181736369805;11005.504752286166;11065.391403472806;11081.390523521202;4284.1645879053285;4314.9784251078545;4361.890952726144;4401.537838526972;4406.317020861771;9563.187129093965;9628.807423851484;9640.228781697448;9642.566084526214;9654.372465789702;4807.423109226846;4822.734749588806;4829.203181475017;4840.75796210188;4842.225243960949;4413.051193993307;4413.646908247332;4414.337849322627;4418.469783625986;4419.535948725337;3342.8997130086136;3631.8728844490315;3673.7061035117663;3689.5756987946193;3719.4420836874683;1141.611851970334;1144.1418935798151;1147.8335641332128;1148.242160174281;1152.1474109159162;1115.5259014918627;1133.3709791066037;1135.9772804543863;1282.7947528395598;1341.6444642169834;7257.673404696801;7327.413806895435;7346.742863999842;7392.593407362539;7395.445341599401;1060.6181774561153;1076.7631121153333;1103.4923934989995;1110.6667999600088;1131.3212072756444;5713.4000929902595;5785.50823180026;5795.304563452412;5805.651660900359;5808.448197421239;9129.45223286605;9226.123518265755;9299.256059515223;9420.811583768285;9427.962924078345;9298.86051709225;9310.301727370339;9318.487483188354;9326.813463730823;9329.72010839676;7267.236940121211;7302.306280903305;7428.145763237297;7459.70161193557;7514.4364172687265;6942.305769423017;6951.617661028692;6974.755883544051;6978.511504194657;6985.44116470671;8089.9191008089165;8331;8484.151584841466;8491;8492.70275540353;8586.527740974056;8700.738977830675;8823.69117080899;8843.646254149762;8860.778480538038;6053.969730151321;6878.484113691393;6946.652667366712;7029.61337126463;7031.542949708252;6700.698468569024;6725.630090345078;7302.19675835647;7447.366973807287;7507.136679281953;7099.0416293801745;7130.429565634633;7166.53417527859;7211.783646490614;7252.311030452099;7020.227774944854;7066.116735408074;7091.82270443243;7170.139583250043;7302.488825782144;6961.2342642308295;7096.787096387116;7171.533850299714;7191.460640452092;7205.387542058984;6617.7683781067435;6651.600903945779;6670.332966703485;6672.8999065013095;6676.9666151668935;6373.3945275198785;6539.4768418525455;6556.967215163893;6579.144711187515;6582 22:23:57 INFO - PROCESS | 27735 | |4;prototype.html;340.2022257805446;341;341.9128122328806;345.65434565434566;347.67492394611054;5882.32353279373;5886.175935369047;5912.615679980799;5921.674307913063;5958.553108516868;5825.271841019872;5840.0947853082735;5852.502537284336;5854.795082172125;5873.588848780587;4587.655925805561;4593.931091033637;4598.310253461974;4606.101810147006;4607.677462577621;4505.076459325846;4576.084783043405;4600.217962946291;4607.8156873725175;4611.584957353837;4551.499335073139;4552.635789136861;4557.794899229542;4558.817647294104;4559.338895860098;4308.569143085698;4447.910261985834;4555.111753208126;4563.703359281636;4574.222382195018;3943.4226309476153;3982.880513584597;3989.4215338776007;3991.70269662358;4021.9195616087513;5604.047311956977;5609.270794796691;5611.438856114356;5612.214289999403;5612.438756124396;5003.699778013294;5078.21287700407;5233.450487698775;5233.476652334774;5278.683279003272;6143.846403839895;6161.014237721988;6171.876562468726;6179.443850053472;6199.628022318675;4355.194289056503;4355.7822108894425;4357.586029327209;4360.869173924787;4364.323529852878;6263.6868156592445;6424.93575064248;6446.871062578723;6455.5158363122955;6473.74105035798;4386.298192289219;4386.71486353386;4388.670849686287;4404.603585677304;4429.49060857999;4447.977760111179;4449.065696203834;4451.933221001687;4457.955420445819;4484.551544845489;5172.870678232999;5177.792888284426;5189.273501709764;5191.195364718475;5192.402873669576;6082.939170608237;6243.562950593506;6245.156903818017;6259.061140828912;6273.0904018917;1551;1568.4902406717863;1569.7959265295667;1572.3396173607111;1573.2212554785226;991.6975322526698;1038.127972503101;1038.48075962019;1041.047441590951;1051.7002654243504;5790.913136302959;5792.160136780143;5792.739326730307;5793.609533711879;5796.101604251347;6399.744010239631;6402.199725034371;6405.871882562323;6410.8076757697345;6414.743410263631;5839.182514447981;5839.503642190376;5847.590668653153;5848.561357898175;5852.502537284294;3375.476801095834;3453.4129198036394;3467.2372078142766;3471.479278108304;3475.1485885957595;6636.270010298863;6636.966815165893;6641.50188735837;6646.767363142267;6648.867022659617;6407.263164736022;6482.935170648328;6553.442957348583;6563.638999855054;6580.539362244693;6685.298043705341;6738.966305168541;6744.156980377453;6751.122354093936;6752.898706519406;6461.935380646133;6470.902936456051;6474.773382931575;6476.12572302752;6485.286618472059;6242.500599952084;6397.264314603694;6403.6798160090875;6415.358464153547;6420.967895160495;6701.463882889259;6702.430293424918;6711.865762684816;6714.563553369016;6717.899231511629;4337.609615134653;4345.760983145831;4345.891352716208;4355.520892701737;4359.433273674402;6348.714307856065;6470.741170353133;6473.514486413444;6476.4495017924;6476.935230647821;6321.715522801393;6328.7152078157515;6333.113364129118;6333.65164915934;6335.303116657072;6318.684065796784;6322.620642761449;6347.746090156342;6356.332585078685;6372.872542549216;6017.097435384728;6165.599236049642;6176.6911654418;6179.69101544912;6196.876062478635;6297.496200303873;6307.653079080695;6374.58565193261;6400.039994000937;6405.455536279468;6133.38666133401;6144.201253836973;6147.108669243024;6190.969045154746;6199 22:23:57 INFO - PROCESS | 27735 | |5;yui.html;740.2671355358195;741.1180694972982;808.1231863428177;815.5799763121989;834.1658341658342;13853.653658658539;13949.651258718537;13965.999999999975;13998.090124141936;14009.15945043298;13226.867731322684;13270.535531256408;13297.667558311046;13326.133801302909;13336.666583335422;677.3362105136956;692.9653517324139;693.5630552751785;693.7745232799335;824.9257566818985;833.262562632072;850.2220468271524;850.3494826457764;850.5407080176698;851.5784686580121;877.1360210192955;888.7511496780912;888.8400087984161;889.2663552569124;890.1721399098835;713.2475238623224;859.2782063066991;875.5622188905547;880.282569705691;881.2157180109707;640.4556127291811;642.5373730913734;643.09002761093;643.5462998585986;644.561698045329;12516.561920332835;12555.686107847378;12567.371631418393;12574.622761317176;12577.371131443482;12769.55306564275;13065.150765200231;13133;13271.203727776365;13341.466341346335;10861.619843305447;10866.67399978002;10968.945155274172;10978.560857565688;11136.220464567483;3647.6170002149656;3686.5207523022104;3765.4351847223134;3784.678302344304;3843.4811300474357;47498;47675.52324476746;47959;47983;48021;9993.550290236957;10301.35178371457;10373.740656483647;10386.221033422524;10915.181361397927;18202.543796496248;18383.816161838477;18398.908005460155;18420.81579184218;18437.907810460863;7406;7461.589612571361;7536.886946695804;7609.429292802951;7753.689852405841;4173.603507666767;4254.595813397722;4265.701400901907;4321.7406955582765;4333.523312435629;3032.3177285110673;3086.66046734859;3087.6757940416383;3090.196548897258;3112.5486804413235;547.3787251469611;564.0242380681362;570.5122120586922;571.8513186571521;576.881739243454;533.5438200338655;584.1208980484344;636.3636363636364;653.5555822040963;699.8600279944031;8815.766582995724;8890.688825891062;8957.283417326598;9016.774580635536;9105.726828195166;650.847050943028;674.5345711459078;680.8502179217759;693.5734523268254;697.2887654592288;4010.8796736097966;4239.215745087169;4251.44731184944;4315.352697095461;4365.80353884076;56515;56581;56789.43210567842;57056.42943570511;57079.14381284284;47882.521174788504;48171.5182848167;48309.5169048312;48659;48718.756406218454;43558.564414356086;44398.55601444009;47656;48545.5145448541;48700.5129948696;9111.908880911371;9122.726318210463;9296.628134874529;9323.393979391318;9517.666881659108;34553.82723086369;34608.30783384368;35308.47037294391;35502.64497355097;35572;39537.80231098826;40068.79965600153;43662;43724.78137609291;44807;11464.347341776896;11596.826047609462;11609.3614851184;11732.296062236293;11898.940505297418;12389.876101239233;12493.93753031229;12595.24428534291;12810.67973300675;12829.743405132032;11547.63262129398;11780.70548236301;11973.940130299292;12133.150679452354;12399.380030998234;11570.59502917394;11759.588414405454;11997.40012999364;12239.87760122423;12668.366581670694;11594.826077609012;11825.940870295593;12012.099092567918;12151.756964860477;12170.939145304572;8827.558622069;8926;8965.148310910454;9339.48632825174;9373.20327772147;9243.534063654588;9312.580933857857;9469.715908522756;9546.570404331684;10253.948730256301 22:23:57 INFO - PROCESS | 27735 | __end_tp_report 22:23:57 INFO - PROCESS | 27735 | __start_cc_report 22:23:57 INFO - PROCESS | 27735 | _x_x_mozilla_cycle_collect,885 22:23:57 INFO - PROCESS | 27735 | __end_cc_report 22:23:57 INFO - PROCESS | 27735 | __startTimestamp1455171837251__endTimestamp 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | ------- Summary: start ------- 22:23:57 INFO - PROCESS | 27735 | Number of tests: 6 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#0] dojo.html Cycles:165 Average:5103.30 Median:5312.97 stddev:539.64 (10.2%) stddev-sans-first:518.63 22:23:57 INFO - PROCESS | 27735 | Values: 3130.7 3177.2 3214.5 3219.5 3244.1 5014.7 5105.7 5130.2 5136.7 5144.1 5101.1 5115.6 5145.8 5146.6 5153.4 4570.0 4594.1 4625.7 4667.7 4757.3 4640.9 4658.7 4660.7 4672.5 4757.6 4724.6 4739.2 4756.9 4765.5 4778.2 4719.1 4733.9 4735.2 4770.6 4791.7 4663.6 4666.4 4721.4 4747.7 4775.4 4928.7 4939.6 4953.0 4953.0 4973.6 5345.3 5443.6 5459.5 5467.7 5485.6 5490.0 5494.6 5510.4 5546.6 5595.1 5042.6 5052.8 5056.8 5094.1 5123.8 5483.6 5483.8 5512.4 5521.3 5605.2 5492.0 5510.8 5521.8 5524.3 5575.3 5573.3 5596.7 5599.2 5601.7 5608.5 5364.6 5433.8 5485.7 5549.6 5565.4 5513.4 5519.7 5520.1 5522.9 5560.4 4297.7 4300.5 4302.2 4310.7 4344.3 3766.9 3787.8 3842.2 3872.9 3892.7 5043.7 5053.0 5072.9 5073.8 5122.1 5321.3 5488.3 5509.1 5510.6 5520.1 4926.7 5013.0 5055.5 5070.6 5093.5 4648.3 4658.7 4675.7 4675.9 4715.5 5528.1 5613.9 5623.7 5635.8 5641.4 5586.6 5593.3 5605.7 5613.6 5653.0 5582.5 5598.6 5601.2 5601.5 5621.7 5353.1 5356.1 5375.0 5408.0 5430.9 5459.8 5464.2 5466.9 5469.9 5508.6 5345.5 5355.8 5357.7 5367.5 5405.8 5313.0 5338.1 5344.1 5356.9 5380.1 5282.6 5310.2 5312.5 5319.0 5324.0 5397.9 5406.7 5411.5 5416.6 5445.8 5203.7 5272.5 5282.8 5296.9 5360.7 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#1] ext.html Cycles:180 Average:48770.84 Median:36456.04 stddev:88876.53 (243.8%) stddev-sans-first:89052.06 22:23:57 INFO - PROCESS | 27735 | Values: 532.2 548.7 559.2 561.9 567.6 28008.2 34647.5 35367.5 35404.6 35520.6 41277.4 42022.4 42187.0 42284.0 42291.0 8601.2 8795.1 8852.0 8854.5 8871.8 8612.5 8740.3 8743.9 8749.3 8757.0 8795.1 8842.2 8851.0 8881.0 8881.1 8672.4 8772.2 8774.5 8775.2 8777.2 8733.6 8870.2 8892.2 8893.2 8893.7 38011.8 38463.4 38474.8 38527.4 38555.8 3290.9 3405.1 3839.2 3852.5 4062.2 29261.6 29471.3 29622.6 29657.6 30388.8 3862.2 3879.2 3993.4 4007.9 4030.8 256859.0 257272.0 257336.0 257781.0 258877.0 50966.7 56004.0 56186.7 56189.7 56216.7 58533.7 58601.0 58847.7 59068.7 59183.7 14001.3 14155.6 14182.1 14192.0 14350.4 10868.8 10930.5 10958.2 10960.9 10988.1 17504.7 18904.3 19076.5 19124.5 19237.1 6007.9 6945.8 7270.8 7277.8 7293.5 1016.9 1060.3 1072.8 1085.5 1182.1 29011.3 29151.0 29250.4 29425.0 29594.1 1077.7 1122.3 1161.3 1173.0 1189.7 15143.0 15215.2 15307.9 15508.0 15513.0 281664.0 402892.0 402978.0 406105.0 406255.0 47945.3 47969.8 48247.8 48356.8 48421.3 1299.9 1317.5 1332.3 1350.2 1374.9 27173.5 27981.9 28325.2 28715.1 28907.4 41790.8 42180.2 42191.2 42249.0 42276.0 252371.0 378421.0 378532.0 378573.0 384063.0 29938.3 29981.3 29989.6 30068.8 30071.2 41000.8 41314.8 41760.8 42522.1 42539.0 34293.8 34560.0 34696.7 35135.5 35205.1 35291.5 35893.6 36000.6 36164.0 36219.0 36318.3 36443.5 36468.6 36638.0 36721.6 29855.0 31193.0 32270.5 32429.5 32508.3 25055.2 25311.5 25433.2 25517.6 25945.4 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#2] jquery.html Cycles:180 Average:24325.22 Median:363.87 stddev:69403.44 (19073.8%) stddev-sans-first:69574.82 22:23:57 INFO - PROCESS | 27735 | Values: 363.5 364.2 365.6 369.7 372.3 13611.3 14122.6 16333.8 17158.5 17566.2 14996.0 15327.3 15537.1 15546.3 16559.4 5494.0 5671.9 5678.0 5679.1 5679.9 4085.9 5611.0 5831.4 6109.1 6118.3 5909.7 5996.5 6052.4 6070.9 6241.4 6155.4 6157.8 6206.3 6216.1 6220.4 5298.7 5417.7 5419.3 5423.3 5430.2 12372.2 12699.9 12712.9 12743.8 20425.9 2081.2 2123.4 2386.3 2829.0 2833.4 9252.2 9339.3 9404.6 9625.7 12556.2 1822.6 1834.0 1866.3 1892.1 1909.8 59856.4 60478.7 60913.0 61787.7 63597.7 10170.5 10269.1 10278.3 10327.2 10412.7 13319.4 13729.0 13733.6 13752.0 13757.2 6966.2 7162.8 7173.6 7222.9 7278.2 7181.8 7231.6 7232.6 7254.7 7259.3 4042.5 4259.8 4422.2 4461.9 4531.5 1766.8 1772.4 1792.3 1799.7 1813.5 914.1 934.8 1020.2 1026.6 1046.4 12783.7 16819.9 16922.2 16934.5 18180.6 930.3 989.4 1023.9 1035.1 1094.5 9135.2 9218.2 9382.6 9534.4 9677.2 336108.0 357433.0 423784.0 481264.0 492267.0 71430.6 72021.6 73971.6 74442.0 75542.2 1136.2 1143.8 1154.0 1160.4 1167.1 15380.4 15769.5 15935.6 16184.3 16330.2 32126.8 33217.0 33753.5 34071.8 34200.1 42510.6 43410.0 43444.1 43691.8 46744.1 6916.3 7400.6 7449.5 7546.9 7574.5 9920.9 11213.4 11289.7 11764.2 11851.2 10024.2 10194.0 10317.7 10499.7 10537.5 10027.3 10172.5 10248.1 10484.9 10605.5 9792.5 10209.2 10496.6 10500.9 10815.5 7529.9 7811.6 7831.8 7866.3 7898.2 8292.3 8691.0 10103.3 10189.3 10584.4 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#3] mootools.html Cycles:180 Average:5502.82 Median:6548.22 stddev:2851.74 (43.5%) stddev-sans-first:2842.39 22:23:57 INFO - PROCESS | 27735 | Values: 1318.3 1419.4 1432.3 1605.0 1792.0 6720.0 7609.7 7697.9 7745.4 7760.0 7614.6 7804.5 7805.2 7811.1 7816.5 1950.3 1992.6 2289.5 2307.6 2333.8 2321.7 2357.9 2359.3 2361.5 2361.9 2274.2 2340.7 2342.6 2342.8 2345.3 2286.7 2316.9 2319.5 2322.2 2325.8 2317.8 2319.0 2340.0 2348.8 2357.5 7754.5 7840.6 7846.4 7847.1 7853.3 4705.8 4847.5 4851.4 4852.9 4853.3 3017.2 3072.0 3085.9 3086.1 3120.6 973.1 994.5 1025.8 1060.0 1066.3 10893.8 10910.2 11005.5 11065.4 11081.4 4284.2 4315.0 4361.9 4401.5 4406.3 9563.2 9628.8 9640.2 9642.6 9654.4 4807.4 4822.7 4829.2 4840.8 4842.2 4413.1 4413.6 4414.3 4418.5 4419.5 3342.9 3631.9 3673.7 3689.6 3719.4 1141.6 1144.1 1147.8 1148.2 1152.1 1115.5 1133.4 1136.0 1282.8 1341.6 7257.7 7327.4 7346.7 7392.6 7395.4 1060.6 1076.8 1103.5 1110.7 1131.3 5713.4 5785.5 5795.3 5805.7 5808.4 9129.5 9226.1 9299.3 9420.8 9428.0 9298.9 9310.3 9318.5 9326.8 9329.7 7267.2 7302.3 7428.1 7459.7 7514.4 6942.3 6951.6 6974.8 6978.5 6985.4 8089.9 8331.0 8484.2 8491.0 8492.7 8586.5 8700.7 8823.7 8843.6 8860.8 6054.0 6878.5 6946.7 7029.6 7031.5 6700.7 6725.6 7302.2 7447.4 7507.1 7099.0 7130.4 7166.5 7211.8 7252.3 7020.2 7066.1 7091.8 7170.1 7302.5 6961.2 7096.8 7171.5 7191.5 7205.4 6617.8 6651.6 6670.3 6672.9 6677.0 6373.4 6539.5 6557.0 6579.1 6582.0 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#4] prototype.html Cycles:180 Average:5221.74 Median:5852.50 stddev:1572.92 (26.9%) stddev-sans-first:1534.06 22:23:57 INFO - PROCESS | 27735 | Values: 340.2 341.0 341.9 345.7 347.7 5882.3 5886.2 5912.6 5921.7 5958.6 5825.3 5840.1 5852.5 5854.8 5873.6 4587.7 4593.9 4598.3 4606.1 4607.7 4505.1 4576.1 4600.2 4607.8 4611.6 4551.5 4552.6 4557.8 4558.8 4559.3 4308.6 4447.9 4555.1 4563.7 4574.2 3943.4 3982.9 3989.4 3991.7 4021.9 5604.0 5609.3 5611.4 5612.2 5612.4 5003.7 5078.2 5233.5 5233.5 5278.7 6143.8 6161.0 6171.9 6179.4 6199.6 4355.2 4355.8 4357.6 4360.9 4364.3 6263.7 6424.9 6446.9 6455.5 6473.7 4386.3 4386.7 4388.7 4404.6 4429.5 4448.0 4449.1 4451.9 4458.0 4484.6 5172.9 5177.8 5189.3 5191.2 5192.4 6082.9 6243.6 6245.2 6259.1 6273.1 1551.0 1568.5 1569.8 1572.3 1573.2 991.7 1038.1 1038.5 1041.0 1051.7 5790.9 5792.2 5792.7 5793.6 5796.1 6399.7 6402.2 6405.9 6410.8 6414.7 5839.2 5839.5 5847.6 5848.6 5852.5 3375.5 3453.4 3467.2 3471.5 3475.1 6636.3 6637.0 6641.5 6646.8 6648.9 6407.3 6482.9 6553.4 6563.6 6580.5 6685.3 6739.0 6744.2 6751.1 6752.9 6461.9 6470.9 6474.8 6476.1 6485.3 6242.5 6397.3 6403.7 6415.4 6421.0 6701.5 6702.4 6711.9 6714.6 6717.9 4337.6 4345.8 4345.9 4355.5 4359.4 6348.7 6470.7 6473.5 6476.4 6476.9 6321.7 6328.7 6333.1 6333.7 6335.3 6318.7 6322.6 6347.7 6356.3 6372.9 6017.1 6165.6 6176.7 6179.7 6196.9 6297.5 6307.7 6374.6 6400.0 6405.5 6133.4 6144.2 6147.1 6191.0 6199.0 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - PROCESS | 27735 | [#5] yui.html Cycles:180 Average:13785.49 Median:44602.78 stddev:15563.79 (34.9%) stddev-sans-first:15576.62 22:23:57 INFO - PROCESS | 27735 | Values: 740.3 741.1 808.1 815.6 834.2 13853.7 13949.7 13966.0 13998.1 14009.2 13226.9 13270.5 13297.7 13326.1 13336.7 677.3 693.0 693.6 693.8 824.9 833.3 850.2 850.3 850.5 851.6 877.1 888.8 888.8 889.3 890.2 713.2 859.3 875.6 880.3 881.2 640.5 642.5 643.1 643.5 644.6 12516.6 12555.7 12567.4 12574.6 12577.4 12769.6 13065.2 13133.0 13271.2 13341.5 10861.6 10866.7 10968.9 10978.6 11136.2 3647.6 3686.5 3765.4 3784.7 3843.5 47498.0 47675.5 47959.0 47983.0 48021.0 9993.6 10301.4 10373.7 10386.2 10915.2 18202.5 18383.8 18398.9 18420.8 18437.9 7406.0 7461.6 7536.9 7609.4 7753.7 4173.6 4254.6 4265.7 4321.7 4333.5 3032.3 3086.7 3087.7 3090.2 3112.5 547.4 564.0 570.5 571.9 576.9 533.5 584.1 636.4 653.6 699.9 8815.8 8890.7 8957.3 9016.8 9105.7 650.8 674.5 680.9 693.6 697.3 4010.9 4239.2 4251.4 4315.4 4365.8 56515.0 56581.0 56789.4 57056.4 57079.1 47882.5 48171.5 48309.5 48659.0 48718.8 43558.6 44398.6 47656.0 48545.5 48700.5 9111.9 9122.7 9296.6 9323.4 9517.7 34553.8 34608.3 35308.5 35502.6 35572.0 39537.8 40068.8 43662.0 43724.8 44807.0 11464.3 11596.8 11609.4 11732.3 11898.9 12389.9 12493.9 12595.2 12810.7 12829.7 11547.6 11780.7 11973.9 12133.2 12399.4 11570.6 11759.6 11997.4 12239.9 12668.4 11594.8 11825.9 12012.1 12151.8 12170.9 8827.6 8926.0 8965.1 9339.5 9373.2 9243.5 9312.6 9469.7 9546.6 10253.9 22:23:57 INFO - PROCESS | 27735 | -------- Summary: end -------- 22:23:57 INFO - PROCESS | 27735 | 22:23:57 INFO - TEST-INFO | 27735: exit 0 22:23:57 INFO - TEST-OK | dromaeo_css | took 1112149ms 22:23:57 INFO - TEST-START | kraken 22:23:57 INFO - operating with platform_type : linux_ 22:23:57 INFO - Initialising browser for kraken test... 22:23:57 INFO - TEST-INFO | started process 27921 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95dd9y/profile http://localhost:47921/getInfo.html) 22:24:01 INFO - PROCESS | 27921 | __metrics Screen width/height:1600/1200 22:24:01 INFO - PROCESS | 27921 | colorDepth:24 22:24:01 INFO - PROCESS | 27921 | Browser inner width/height: 1024/697 22:24:01 INFO - PROCESS | 27921 | __metrics 22:24:02 INFO - PROCESS | 27921 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:24:02 INFO - TEST-INFO | 27921: exit 0 22:24:02 INFO - Browser initialized. 22:24:02 INFO - Running cycle 1/1 for kraken test... 22:24:02 INFO - TEST-INFO | started process 28004 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp95dd9y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:24:14 INFO - PROCESS | 28004 | RSS: Main: 152616960 22:24:14 INFO - PROCESS | 28004 | 22:24:17 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47921/tests/kraken/driver.html?testName=audio-beat-detection) 22:24:17 INFO - PROCESS | 28004 | RSS: Main: 195915776 22:24:17 INFO - PROCESS | 28004 | 22:24:20 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47921/tests/kraken/driver.html?testName=audio-dft) 22:24:20 INFO - PROCESS | 28004 | RSS: Main: 185495552 22:24:20 INFO - PROCESS | 28004 | 22:24:23 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47921/tests/kraken/driver.html?testName=audio-fft) 22:24:24 INFO - PROCESS | 28004 | RSS: Main: 170676224 22:24:24 INFO - PROCESS | 28004 | 22:24:26 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47921/tests/kraken/driver.html?testName=audio-oscillator) 22:24:27 INFO - PROCESS | 28004 | RSS: Main: 171757568 22:24:27 INFO - PROCESS | 28004 | 22:24:29 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47921/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:24:29 INFO - PROCESS | 28004 | RSS: Main: 174153728 22:24:29 INFO - PROCESS | 28004 | 22:24:32 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47921/tests/kraken/driver.html?testName=imaging-darkroom) 22:24:33 INFO - PROCESS | 28004 | RSS: Main: 174927872 22:24:33 INFO - PROCESS | 28004 | 22:24:36 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47921/tests/kraken/driver.html?testName=imaging-desaturate) 22:24:37 INFO - PROCESS | 28004 | RSS: Main: 174759936 22:24:37 INFO - PROCESS | 28004 | 22:24:40 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47921/tests/kraken/driver.html?testName=json-parse-financial) 22:24:40 INFO - PROCESS | 28004 | RSS: Main: 174632960 22:24:40 INFO - PROCESS | 28004 | 22:24:42 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47921/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:24:42 INFO - PROCESS | 28004 | RSS: Main: 187371520 22:24:42 INFO - PROCESS | 28004 | 22:24:44 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:24:45 INFO - PROCESS | 28004 | RSS: Main: 184840192 22:24:45 INFO - PROCESS | 28004 | 22:24:47 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:24:48 INFO - PROCESS | 28004 | RSS: Main: 198328320 22:24:48 INFO - PROCESS | 28004 | 22:24:50 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:24:51 INFO - PROCESS | 28004 | RSS: Main: 201060352 22:24:51 INFO - PROCESS | 28004 | 22:24:53 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:24:54 INFO - PROCESS | 28004 | RSS: Main: 198463488 22:24:54 INFO - PROCESS | 28004 | 22:24:55 INFO - PROCESS | 28004 | Cycle 1(1): loaded http://localhost:47921/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47921/tests/kraken/driver.html?testName=ai-astar) 22:24:56 INFO - PROCESS | 28004 | RSS: Main: 261070848 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | __start_tp_report 22:24:56 INFO - PROCESS | 28004 | _x_x_mozilla_page_load 22:24:56 INFO - PROCESS | 28004 | _x_x_mozilla_page_load_details 22:24:56 INFO - PROCESS | 28004 | |i|pagename|runs| 22:24:56 INFO - PROCESS | 28004 | |0;ai-astar;111;111;107;111;111;110;101;111;110;110 22:24:56 INFO - PROCESS | 28004 | |1;audio-beat-detection;151;127;161;179;127;153;157;126;168;134 22:24:56 INFO - PROCESS | 28004 | |2;audio-dft;161;163;162;161;161;160;161;163;161;161 22:24:56 INFO - PROCESS | 28004 | |3;audio-fft;74;73;95;98;73;75;72;105;98;74 22:24:56 INFO - PROCESS | 28004 | |4;audio-oscillator;96;97;151;96;95;96;141;95;97;142 22:24:56 INFO - PROCESS | 28004 | |5;imaging-gaussian-blur;119;116;116;115;115;115;116;115;115;114 22:24:56 INFO - PROCESS | 28004 | |6;imaging-darkroom;145;146;145;145;146;145;145;145;145;145 22:24:56 INFO - PROCESS | 28004 | |7;imaging-desaturate;96;96;96;95;95;96;95;96;96;96 22:24:56 INFO - PROCESS | 28004 | |8;json-parse-financial;61;58;56;56;59;56;56;66;53;54 22:24:56 INFO - PROCESS | 28004 | |9;json-stringify-tinderbox;66;65;74;66;67;66;67;66;67;67 22:24:56 INFO - PROCESS | 28004 | |10;stanford-crypto-aes;81;82;82;89;82;83;83;83;91;83 22:24:56 INFO - PROCESS | 28004 | |11;stanford-crypto-ccm;122;115;117;116;116;117;129;115;129;115 22:24:56 INFO - PROCESS | 28004 | |12;stanford-crypto-pbkdf2;156;141;148;149;152;141;163;151;151;151 22:24:56 INFO - PROCESS | 28004 | |13;stanford-crypto-sha256-iterative;71;69;70;69;70;68;67;69;68;66 22:24:56 INFO - PROCESS | 28004 | __end_tp_report 22:24:56 INFO - PROCESS | 28004 | __start_cc_report 22:24:56 INFO - PROCESS | 28004 | _x_x_mozilla_cycle_collect,993 22:24:56 INFO - PROCESS | 28004 | __end_cc_report 22:24:56 INFO - PROCESS | 28004 | __startTimestamp1455171896219__endTimestamp 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | ------- Summary: start ------- 22:24:56 INFO - PROCESS | 28004 | Number of tests: 14 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.16 (2.9%) stddev-sans-first:3.30 22:24:56 INFO - PROCESS | 28004 | Values: 111.0 111.0 107.0 111.0 111.0 110.0 101.0 111.0 110.0 110.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.00 stddev:18.87 (12.2%) stddev-sans-first:19.99 22:24:56 INFO - PROCESS | 28004 | Values: 151.0 127.0 161.0 179.0 127.0 153.0 157.0 126.0 168.0 134.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 22:24:56 INFO - PROCESS | 28004 | Values: 161.0 163.0 162.0 161.0 161.0 160.0 161.0 163.0 161.0 161.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#3] audio-fft Cycles:10 Average:83.70 Median:74.50 stddev:13.42 (18.0%) stddev-sans-first:13.76 22:24:56 INFO - PROCESS | 28004 | Values: 74.0 73.0 95.0 98.0 73.0 75.0 72.0 105.0 98.0 74.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:23.66 (24.6%) stddev-sans-first:24.50 22:24:56 INFO - PROCESS | 28004 | Values: 96.0 97.0 151.0 96.0 95.0 96.0 141.0 95.0 97.0 142.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:1.35 (1.2%) stddev-sans-first:0.67 22:24:56 INFO - PROCESS | 28004 | Values: 119.0 116.0 116.0 115.0 115.0 115.0 116.0 115.0 115.0 114.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 22:24:56 INFO - PROCESS | 28004 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 22:24:56 INFO - PROCESS | 28004 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 96.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:3.78 (6.6%) stddev-sans-first:3.79 22:24:56 INFO - PROCESS | 28004 | Values: 61.0 58.0 56.0 56.0 59.0 56.0 56.0 66.0 53.0 54.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:2.51 (3.8%) stddev-sans-first:2.64 22:24:56 INFO - PROCESS | 28004 | Values: 66.0 65.0 74.0 66.0 67.0 66.0 67.0 66.0 67.0 67.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:3.31 (4.0%) stddev-sans-first:3.35 22:24:56 INFO - PROCESS | 28004 | Values: 81.0 82.0 82.0 89.0 82.0 83.0 83.0 83.0 91.0 83.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:117.00 stddev:5.61 (4.8%) stddev-sans-first:5.85 22:24:56 INFO - PROCESS | 28004 | Values: 122.0 115.0 117.0 116.0 116.0 117.0 129.0 115.0 129.0 115.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:151.00 stddev:6.48 (4.3%) stddev-sans-first:6.54 22:24:56 INFO - PROCESS | 28004 | Values: 156.0 141.0 148.0 149.0 152.0 141.0 163.0 151.0 151.0 151.0 22:24:56 INFO - PROCESS | 28004 | 22:24:56 INFO - PROCESS | 28004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.33 22:24:56 INFO - PROCESS | 28004 | Values: 71.0 69.0 70.0 69.0 70.0 68.0 67.0 69.0 68.0 66.0 22:24:56 INFO - PROCESS | 28004 | -------- Summary: end -------- 22:24:56 INFO - PROCESS | 28004 | 22:24:57 INFO - TEST-INFO | 28004: exit 0 22:24:57 INFO - TEST-OK | kraken | took 59288ms 22:24:57 INFO - SUITE-END | took 1171s 22:24:57 INFO - Completed test suite (00:19:31) 22:24:57 INFO - Working with test: dromaeo_css 22:24:57 INFO - Generating results file: dromaeo_css 22:24:57 INFO - Working with test: kraken 22:24:57 INFO - Generating results file: kraken 22:24:57 INFO - javascript benchmark 22:24:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:24:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:24:57 INFO - process_Request line: dromaeo_css 6865.16 graph.html#tests=[[72,63,35]] 22:24:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:24:57 INFO - process_Request line: kraken 1516.40 graph.html#tests=[[232,63,35]] 22:24:57 INFO - RETURN: dromaeo_css: 6865.16 22:24:57 INFO - RETURN: kraken: 1516.40 22:24:57 INFO - javascript benchmark 22:24:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.671279515651, 3177.205698575356, 3214.4696125139353, 3219.5009773485117, 3244.0916543367857, 5014.749262536877, 5105.668131571445, 5130.179171332587, 5136.717480538574, 5144.099782538055, 5101.056304583654, 5115.616328775338, 5145.845624631258, 5146.588272938166, 5153.433122356538, 4569.977150114245, 4594.058218065297, 4625.653076019295, 4667.696599721007, 4757.333973243749, 4640.930386044195, 4658.720476771405, 4660.6970546914345, 4672.532746725317, 4757.571818536331, 4724.5984091352275, 4739.241721324572, 4756.9286460703115, 4765.499622539635, 4778.1638213312535, 4719.07977944301, 4733.928991065102, 4735.171345014609, 4770.61835053195, 4791.736454495001, 4663.556962088596, 4666.39336886206, 4721.409823772028, 4747.7388743619085, 4775.403074615673, 4928.654994150411, 4939.629527785394, 4952.975235123838, 4953.0, 4973.602111831045, 5345.278387417727, 5443.646162999393, 5459.508644222039, 5467.726613669341, 5485.6434331768305, 5490.0, 5494.615376923617, 5510.448955104497, 5546.611737178399, 5595.076812325961, 5042.6470147090085, 5052.8484145475695, 5056.797728090872, 5094.108531007059, 5123.769430375642, 5483.588730845123, 5483.8080667176455, 5512.366077901012, 5521.254630624894, 5605.187247849039, 5491.9725401373535, 5510.8071217507195, 5521.779128834802, 5524.309461317335, 5575.33096028471, 5573.275474188411, 5596.720163991866, 5599.160125981054, 5601.691906945076, 5608.495235428831, 5364.624476286623, 5433.8369848904595, 5485.698286594195, 5549.556035517149, 5565.437995808048, 5513.393526712059, 5519.69641669704, 5520.089185284383, 5522.889542209134, 5560.388357280696, 4297.72064815786, 4300.526942036374, 4302.204092242945, 4310.698251122391, 4344.326629372453, 3766.9434958475645, 3787.791671458041, 3842.1547259602844, 3872.9419058714143, 3892.7469714469034, 5043.722595257296, 5053.0, 5072.873178170502, 5073.847784566469, 5122.052420302256, 5321.3348331458565, 5488.313960754906, 5509.063459211943, 5510.559155267569, 5520.1167813149705, 4926.6551341406475, 5013.0, 5055.545000949932, 5070.569001634903, 5093.490650934951, 4648.279516674921, 4658.743769092733, 4675.682779621041, 4675.883102922454, 4715.457722361973, 5528.143137813645, 5613.915791263134, 5623.662580245198, 5635.802746903839, 5641.351244606841, 5586.581006424616, 5593.300837395325, 5605.691686957257, 5613.635113717595, 5653.0, 5582.525485333792, 5598.552115830806, 5601.24383208278, 5601.495865372136, 5621.7189140542, 5353.089974704388, 5356.089464790917, 5374.973125134349, 5408.026555220098, 5430.918536222039, 5459.754311055933, 5464.153056276284, 5466.945330546644, 5469.890602187855, 5508.614396992172, 5345.518903298722, 5355.758990845499, 5357.678539287655, 5367.463253674601, 5405.78376864921, 5312.9734351328, 5338.065838478328, 5344.10284349066, 5356.892862142658, 5380.139177731544, 5282.55098316632, 5310.203469479609, 5312.5484333832055, 5319.042572337016, 5324.041672498987, 5397.865053373697, 5406.729663516887, 5411.540019098264, 5416.647917885325, 5445.809396671098, 5203.739813009259, 5272.499112584298, 5282.81510147143, 5296.940611877717, 5360.65155764874], "unit": "score", "name": "dojo.html", "value": 5070.458554749763}, {"lowerIsBetter": false, "replicates": [532.2335836395592, 548.7256371814094, 559.2003435087822, 561.9353774315955, 567.5856624663995, 28008.159755207325, 34647.48028779567, 35367.469487957635, 35404.64595354046, 35520.64479355203, 41277.380839287434, 42022.36966445498, 42187.0, 42284.0, 42291.0, 8601.182887625666, 8795.076516965722, 8852.0, 8854.468731876075, 8871.778205544848, 8612.48325100493, 8740.300775937909, 8743.912560874374, 8749.343799215052, 8756.956215218916, 8795.076516965722, 8842.204201621853, 8850.955745221298, 8881.0, 8881.1118888111, 8672.436291641056, 8772.210501054871, 8774.517401542913, 8775.166359195866, 8777.210051095368, 8733.563321833946, 8870.246029087471, 8892.199702026848, 8893.244074253696, 8893.688720894737, 38011.80994095039, 38463.384393872635, 38474.80762596197, 38527.42208866869, 38555.807220963994, 3290.901272961815, 3405.1487128217946, 3839.212961342918, 3852.499175107218, 4062.1875624874847, 29261.56107658387, 29471.263218419495, 29622.555661664876, 29657.555136672967, 30388.84805575958, 3862.208247309323, 3879.243547508237, 3993.3610622300585, 4007.8998025049314, 4030.778307193103, 256859.0, 257272.0, 257335.99999999814, 257781.0, 258877.0, 50966.745166274675, 56004.0, 56186.719066405225, 56189.71905140448, 56216.71891640516, 58533.70733146392, 58601.0, 58847.70576147092, 59068.704656476446, 59183.704081479314, 14001.299935003413, 14155.575332740034, 14182.14907105577, 14192.0, 14350.354234059492, 10868.836967445495, 10930.453477326102, 10958.178136639784, 10960.945195274133, 10988.066014388707, 17504.674596772256, 18904.338348157748, 19076.52308692266, 19124.521886952938, 19237.13432895523, 6007.909881351783, 6945.756898508629, 7270.818229544304, 7277.781666550012, 7293.52592081513, 1016.9288149829441, 1060.3266925502362, 1072.8498010278568, 1085.5223701571283, 1182.0838849891402, 29011.274718132216, 29151.0, 29250.414991700472, 29425.0, 29594.112176634735, 1077.7144056824948, 1122.3266040375709, 1161.2916121166081, 1173.0146676791537, 1189.714468527547, 15143.0, 15215.239238038053, 15307.923460382626, 15508.0, 15513.0, 281664.0, 402892.0, 402978.0, 406105.0, 406255.0, 47945.28082078772, 47969.76015119972, 48247.75876120597, 48356.75821620869, 48421.27368089482, 1299.883010529038, 1317.4598414650138, 1332.293884241373, 1350.2438634364787, 1374.8900087993136, 27173.456530869666, 27981.860090699418, 28325.150245491845, 28715.13854584366, 28907.42185156327, 41790.79104604458, 42180.1563968725, 42191.1561768769, 42249.0, 42276.0, 252371.0, 378421.0, 378532.0, 378573.0, 384063.0, 29938.25154371158, 29981.250468738457, 29989.550156748104, 30068.849655751583, 30071.248218794706, 41000.79499602483, 41314.79342603268, 41760.79119604383, 42522.1495570093, 42539.0, 34293.82853085719, 34560.0, 34696.653033469345, 35135.47296790499, 35205.11987200341, 35291.539672104656, 35893.641063590076, 36000.63999360077, 36164.0, 36219.0, 36318.27363452769, 36443.45334819927, 36468.63531364759, 36638.0, 36721.63278367182, 29855.0, 31193.0, 32270.515942261354, 32429.51355729713, 32508.349833002736, 25055.248342549752, 25311.493770124864, 25433.237002889942, 25517.61723574111, 25945.351366215997], "unit": "score", "name": "ext.html", "value": 18350.30904094712}, {"lowerIsBetter": false, "replicates": [363.5419371591795, 364.19512876542836, 365.60879858551345, 369.74487603553547, 372.3409565069825, 13611.319434028308, 14122.576322710309, 16333.836661633395, 17158.48524544264, 17566.209520571574, 14996.0, 15327.310271037803, 15537.067775933423, 15546.300416481257, 16559.420420285292, 5493.972530137344, 5671.8582035449035, 5677.971610141964, 5679.119736440858, 5679.914801277984, 4085.8569950051756, 5610.971945140269, 5831.387704291031, 6109.053096770008, 6118.3269840317525, 5909.704514774266, 5996.460318571328, 6052.425019623129, 6070.878582428349, 6241.407066328714, 6155.415235552616, 6157.7536898524, 6206.317305096436, 6216.129741836146, 6220.440160385564, 5298.682079075268, 5417.702026388547, 5419.268398766156, 5423.29497165366, 5430.185472179165, 12372.195807272588, 12699.936500317532, 12712.936435317857, 12743.808842867364, 20425.8978705107, 2081.177934715794, 2123.352377524854, 2386.331827088418, 2828.9575656365173, 2833.4049849531416, 9252.16730494252, 9339.299552533586, 9404.576794044284, 9625.663101791473, 12556.18384804994, 1822.6172503774224, 1834.0462959261242, 1866.3281218761235, 1892.0823400650672, 1909.7708275006948, 59856.40143598595, 60478.69760651213, 60912.999999999556, 61787.69106154441, 63597.68201159011, 10170.491475426199, 10269.127124194378, 10278.33190842593, 10327.225458090674, 10412.68761937128, 13319.40062697181, 13729.0, 13733.587992360246, 13752.0, 13757.243351615758, 6966.164060312795, 7162.785116446515, 7173.569585824867, 7222.927770722331, 7278.235785242579, 7181.784546463615, 7231.566106033655, 7232.638368081575, 7254.673539690621, 7259.346658800628, 4042.4744783178585, 4259.787010649455, 4422.159789640023, 4461.866144015685, 4531.501534831166, 1766.8338896328362, 1772.4328214971342, 1792.3278770461077, 1799.6706093726502, 1813.5012871460453, 914.095045904563, 934.8457504511815, 1020.1838529176629, 1026.6047571684805, 1046.3512622174148, 12783.744325113446, 16819.91590042042, 16922.23849926756, 16934.49196524106, 18180.553554483555, 930.2883294279882, 989.42118860466, 1023.8515415264894, 1035.0994634667736, 1094.5457635081352, 9135.17783399484, 9218.170364667078, 9382.577783999737, 9534.380265282734, 9677.177439917687, 336108.0, 357433.0, 423784.0, 481264.0, 492267.0, 71430.64284678648, 72021.63989180021, 73971.63014185002, 74442.0, 75542.24457755462, 1136.198979719296, 1143.7540928700369, 1154.001788452982, 1160.3849959521467, 1167.1129941244715, 15380.38478460849, 15769.526914192593, 15935.601609959844, 16184.271707772943, 16330.183490825173, 32126.83936580302, 33217.0, 33753.493697594065, 34071.82964085164, 34200.14499637529, 42510.57489425066, 43410.0, 43444.13111737684, 43691.78154109209, 46744.06511869811, 6916.308369163044, 7400.629968501661, 7449.47853650261, 7546.886796698163, 7574.5076570022775, 9920.900790991998, 11213.439328033728, 11289.71775705614, 11764.176507644383, 11851.229670071418, 10024.24818138628, 10194.0, 10317.74205644865, 10499.737506562396, 10537.473126343499, 10027.348222365523, 10172.542235599267, 10248.11380579334, 10484.94757526238, 10605.469726513798, 9792.461414622265, 10209.183265338903, 10496.580136794442, 10500.894991050298, 10815.513301901276, 7529.924700752922, 7811.570363630055, 7831.765047048598, 7866.292033716993, 7898.249666281924, 8292.2951549119, 8691.0, 10103.343282686601, 10189.286749927434, 10584.364938103738], "unit": "score", "name": "jquery.html", "value": 8280.848433021294}, {"lowerIsBetter": false, "replicates": [1318.2617734068915, 1419.4322271091562, 1432.2552272818139, 1605.0244242847175, 1792.0323025566188, 6720.0, 7609.733659321925, 7697.923020769791, 7745.4190935679835, 7759.961200194005, 7614.619269036553, 7804.531728096318, 7805.219478052192, 7811.140774514799, 7816.491928024674, 1950.3466338776527, 1992.561636439981, 2289.4848659051745, 2307.630779075348, 2333.7549557296493, 2321.663358812971, 2357.929262122139, 2359.268626725712, 2361.527694461106, 2361.8819059047064, 2274.158561332301, 2340.707411573553, 2342.601757701186, 2342.8360014798973, 2345.2846881701075, 2286.6798648189265, 2316.9420764480856, 2319.5476882008015, 2322.175627652176, 2325.767423257678, 2317.7798109179603, 2319.0375993962484, 2340.040583360814, 2348.8473249238746, 2357.481354102112, 7754.495957762728, 7840.568768717718, 7846.372290216769, 7847.1368149503505, 7853.293203611703, 4705.764711764398, 4847.5394837490385, 4851.442084160296, 4852.9272060918765, 4853.296272040534, 3017.185359952822, 3071.984640076808, 3085.92285192872, 3086.135881953057, 3120.563121163039, 973.124188230591, 994.4778991029694, 1025.7897131088184, 1060.0, 1066.3335415365398, 10893.83659245112, 10910.181736369805, 11005.504752286166, 11065.391403472806, 11081.390523521202, 4284.1645879053285, 4314.9784251078545, 4361.890952726144, 4401.537838526972, 4406.317020861771, 9563.187129093965, 9628.807423851484, 9640.228781697448, 9642.566084526214, 9654.372465789702, 4807.423109226846, 4822.734749588806, 4829.203181475017, 4840.75796210188, 4842.225243960949, 4413.051193993307, 4413.646908247332, 4414.337849322627, 4418.469783625986, 4419.535948725337, 3342.8997130086136, 3631.8728844490315, 3673.7061035117663, 3689.5756987946193, 3719.4420836874683, 1141.611851970334, 1144.1418935798151, 1147.8335641332128, 1148.242160174281, 1152.1474109159162, 1115.5259014918627, 1133.3709791066037, 1135.9772804543863, 1282.7947528395598, 1341.6444642169834, 7257.673404696801, 7327.413806895435, 7346.742863999842, 7392.593407362539, 7395.445341599401, 1060.6181774561153, 1076.7631121153333, 1103.4923934989995, 1110.6667999600088, 1131.3212072756444, 5713.4000929902595, 5785.50823180026, 5795.304563452412, 5805.651660900359, 5808.448197421239, 9129.45223286605, 9226.123518265755, 9299.256059515223, 9420.811583768285, 9427.962924078345, 9298.86051709225, 9310.301727370339, 9318.487483188354, 9326.813463730823, 9329.72010839676, 7267.236940121211, 7302.306280903305, 7428.145763237297, 7459.70161193557, 7514.4364172687265, 6942.305769423017, 6951.617661028692, 6974.755883544051, 6978.511504194657, 6985.44116470671, 8089.9191008089165, 8331.0, 8484.151584841466, 8491.0, 8492.70275540353, 8586.527740974056, 8700.738977830675, 8823.69117080899, 8843.646254149762, 8860.778480538038, 6053.969730151321, 6878.484113691393, 6946.652667366712, 7029.61337126463, 7031.542949708252, 6700.698468569024, 6725.630090345078, 7302.19675835647, 7447.366973807287, 7507.136679281953, 7099.0416293801745, 7130.429565634633, 7166.53417527859, 7211.783646490614, 7252.311030452099, 7020.227774944854, 7066.116735408074, 7091.82270443243, 7170.139583250043, 7302.488825782144, 6961.2342642308295, 7096.787096387116, 7171.533850299714, 7191.460640452092, 7205.387542058984, 6617.7683781067435, 6651.600903945779, 6670.332966703485, 6672.8999065013095, 6676.9666151668935, 6373.3945275198785, 6539.4768418525455, 6556.967215163893, 6579.144711187515, 6582.0], "unit": "score", "name": "mootools.html", "value": 4521.100899487774}, {"lowerIsBetter": false, "replicates": [340.2022257805446, 341.0, 341.9128122328806, 345.65434565434566, 347.67492394611054, 5882.32353279373, 5886.175935369047, 5912.615679980799, 5921.674307913063, 5958.553108516868, 5825.271841019872, 5840.0947853082735, 5852.502537284336, 5854.795082172125, 5873.588848780587, 4587.655925805561, 4593.931091033637, 4598.310253461974, 4606.101810147006, 4607.677462577621, 4505.076459325846, 4576.084783043405, 4600.217962946291, 4607.8156873725175, 4611.584957353837, 4551.499335073139, 4552.635789136861, 4557.794899229542, 4558.817647294104, 4559.338895860098, 4308.569143085698, 4447.910261985834, 4555.111753208126, 4563.703359281636, 4574.222382195018, 3943.4226309476153, 3982.880513584597, 3989.4215338776007, 3991.70269662358, 4021.9195616087513, 5604.047311956977, 5609.270794796691, 5611.438856114356, 5612.214289999403, 5612.438756124396, 5003.699778013294, 5078.21287700407, 5233.450487698775, 5233.476652334774, 5278.683279003272, 6143.846403839895, 6161.014237721988, 6171.876562468726, 6179.443850053472, 6199.628022318675, 4355.194289056503, 4355.7822108894425, 4357.586029327209, 4360.869173924787, 4364.323529852878, 6263.6868156592445, 6424.93575064248, 6446.871062578723, 6455.5158363122955, 6473.74105035798, 4386.298192289219, 4386.71486353386, 4388.670849686287, 4404.603585677304, 4429.49060857999, 4447.977760111179, 4449.065696203834, 4451.933221001687, 4457.955420445819, 4484.551544845489, 5172.870678232999, 5177.792888284426, 5189.273501709764, 5191.195364718475, 5192.402873669576, 6082.939170608237, 6243.562950593506, 6245.156903818017, 6259.061140828912, 6273.0904018917, 1551.0, 1568.4902406717863, 1569.7959265295667, 1572.3396173607111, 1573.2212554785226, 991.6975322526698, 1038.127972503101, 1038.48075962019, 1041.047441590951, 1051.7002654243504, 5790.913136302959, 5792.160136780143, 5792.739326730307, 5793.609533711879, 5796.101604251347, 6399.744010239631, 6402.199725034371, 6405.871882562323, 6410.8076757697345, 6414.743410263631, 5839.182514447981, 5839.503642190376, 5847.590668653153, 5848.561357898175, 5852.502537284294, 3375.476801095834, 3453.4129198036394, 3467.2372078142766, 3471.479278108304, 3475.1485885957595, 6636.270010298863, 6636.966815165893, 6641.50188735837, 6646.767363142267, 6648.867022659617, 6407.263164736022, 6482.935170648328, 6553.442957348583, 6563.638999855054, 6580.539362244693, 6685.298043705341, 6738.966305168541, 6744.156980377453, 6751.122354093936, 6752.898706519406, 6461.935380646133, 6470.902936456051, 6474.773382931575, 6476.12572302752, 6485.286618472059, 6242.500599952084, 6397.264314603694, 6403.6798160090875, 6415.358464153547, 6420.967895160495, 6701.463882889259, 6702.430293424918, 6711.865762684816, 6714.563553369016, 6717.899231511629, 4337.609615134653, 4345.760983145831, 4345.891352716208, 4355.520892701737, 4359.433273674402, 6348.714307856065, 6470.741170353133, 6473.514486413444, 6476.4495017924, 6476.935230647821, 6321.715522801393, 6328.7152078157515, 6333.113364129118, 6333.65164915934, 6335.303116657072, 6318.684065796784, 6322.620642761449, 6347.746090156342, 6356.332585078685, 6372.872542549216, 6017.097435384728, 6165.599236049642, 6176.6911654418, 6179.69101544912, 6196.876062478635, 6297.496200303873, 6307.653079080695, 6374.58565193261, 6400.039994000937, 6405.455536279468, 6133.38666133401, 6144.201253836973, 6147.108669243024, 6190.969045154746, 6199.0], "unit": "score", "name": "prototype.html", "value": 4711.559440149928}, {"lowerIsBetter": false, "replicates": [740.2671355358195, 741.1180694972982, 808.1231863428177, 815.5799763121989, 834.1658341658342, 13853.653658658539, 13949.651258718537, 13965.999999999975, 13998.090124141936, 14009.15945043298, 13226.867731322684, 13270.535531256408, 13297.667558311046, 13326.133801302909, 13336.666583335422, 677.3362105136956, 692.9653517324139, 693.5630552751785, 693.7745232799335, 824.9257566818985, 833.262562632072, 850.2220468271524, 850.3494826457764, 850.5407080176698, 851.5784686580121, 877.1360210192955, 888.7511496780912, 888.8400087984161, 889.2663552569124, 890.1721399098835, 713.2475238623224, 859.2782063066991, 875.5622188905547, 880.282569705691, 881.2157180109707, 640.4556127291811, 642.5373730913734, 643.09002761093, 643.5462998585986, 644.561698045329, 12516.561920332835, 12555.686107847378, 12567.371631418393, 12574.622761317176, 12577.371131443482, 12769.55306564275, 13065.150765200231, 13133.0, 13271.203727776365, 13341.466341346335, 10861.619843305447, 10866.67399978002, 10968.945155274172, 10978.560857565688, 11136.220464567483, 3647.6170002149656, 3686.5207523022104, 3765.4351847223134, 3784.678302344304, 3843.4811300474357, 47498.0, 47675.52324476746, 47959.0, 47983.0, 48021.0, 9993.550290236957, 10301.35178371457, 10373.740656483647, 10386.221033422524, 10915.181361397927, 18202.543796496248, 18383.816161838477, 18398.908005460155, 18420.81579184218, 18437.907810460863, 7406.0, 7461.589612571361, 7536.886946695804, 7609.429292802951, 7753.689852405841, 4173.603507666767, 4254.595813397722, 4265.701400901907, 4321.7406955582765, 4333.523312435629, 3032.3177285110673, 3086.66046734859, 3087.6757940416383, 3090.196548897258, 3112.5486804413235, 547.3787251469611, 564.0242380681362, 570.5122120586922, 571.8513186571521, 576.881739243454, 533.5438200338655, 584.1208980484344, 636.3636363636364, 653.5555822040963, 699.8600279944031, 8815.766582995724, 8890.688825891062, 8957.283417326598, 9016.774580635536, 9105.726828195166, 650.847050943028, 674.5345711459078, 680.8502179217759, 693.5734523268254, 697.2887654592288, 4010.8796736097966, 4239.215745087169, 4251.44731184944, 4315.352697095461, 4365.80353884076, 56515.0, 56581.0, 56789.43210567842, 57056.42943570511, 57079.14381284284, 47882.521174788504, 48171.5182848167, 48309.5169048312, 48659.0, 48718.756406218454, 43558.564414356086, 44398.55601444009, 47656.0, 48545.5145448541, 48700.5129948696, 9111.908880911371, 9122.726318210463, 9296.628134874529, 9323.393979391318, 9517.666881659108, 34553.82723086369, 34608.30783384368, 35308.47037294391, 35502.64497355097, 35572.0, 39537.80231098826, 40068.79965600153, 43662.0, 43724.78137609291, 44807.0, 11464.347341776896, 11596.826047609462, 11609.3614851184, 11732.296062236293, 11898.940505297418, 12389.876101239233, 12493.93753031229, 12595.24428534291, 12810.67973300675, 12829.743405132032, 11547.63262129398, 11780.70548236301, 11973.940130299292, 12133.150679452354, 12399.380030998234, 11570.59502917394, 11759.588414405454, 11997.40012999364, 12239.87760122423, 12668.366581670694, 11594.826077609012, 11825.940870295593, 12012.099092567918, 12151.756964860477, 12170.939145304572, 8827.558622069, 8926.0, 8965.148310910454, 9339.48632825174, 9373.20327772147, 9243.534063654588, 9312.580933857857, 9469.715908522756, 9546.570404331684, 10253.948730256301], "unit": "score", "name": "yui.html", "value": 6378.113474646489}], "name": "dromaeo_css", "value": 6865.162920012597}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 107.0, 111.0, 111.0, 110.0, 101.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [151.0, 127.0, 161.0, 179.0, 127.0, 153.0, 157.0, 126.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 95.0, 98.0, 73.0, 75.0, 72.0, 105.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 151.0, 96.0, 95.0, 96.0, 141.0, 95.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 116.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [61.0, 58.0, 56.0, 56.0, 59.0, 56.0, 56.0, 66.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 74.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 89.0, 82.0, 83.0, 83.0, 83.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [122.0, 115.0, 117.0, 116.0, 116.0, 117.0, 129.0, 115.0, 129.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [156.0, 141.0, 148.0, 149.0, 152.0, 141.0, 163.0, 151.0, 151.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 69.0, 70.0, 68.0, 67.0, 69.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1516.3999999999999}]} 22:24:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1516.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6865.16"}}} 22:24:57 INFO - Return code: 0 22:24:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:24:57 INFO - # TBPL SUCCESS # 22:24:57 INFO - Running post-action listener: _resource_record_post_action 22:24:57 INFO - Running post-run listener: _resource_record_post_run 22:24:58 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527204352; Read time: 12; Write time: 369056 22:24:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240250880; Read time: 0; Write time: 204540 22:24:58 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286953472; Read time: 12; Write time: 164516 22:24:58 INFO - Running post-run listener: _upload_blobber_files 22:24:58 INFO - Blob upload gear active. 22:24:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:24:58 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 22:24:58 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:24:58 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:24:59 INFO - (blobuploader) - INFO - Open directory for files ... 22:24:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:24:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:24:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:25:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:25:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:25:00 INFO - (blobuploader) - INFO - Done attempting. 22:25:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:25:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:25:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:25:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:25:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:25:02 INFO - (blobuploader) - INFO - Done attempting. 22:25:02 INFO - (blobuploader) - INFO - Iteration through files over. 22:25:02 INFO - Return code: 0 22:25:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:25:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:25:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4648383291c28cc78022a9f531afc74d606b8cdea05774d65196045c9eaed12a98349f8f229908d7ed1aa5bf1010fdaafd6598dff23d734cce742abe9aadad5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05418d0139a79e249aa8309c1d62b35873e698f1d34028e062e8086a5cf8ceb13e637be3971062d24dde21e7dc643b795213caf209aa83f36a289f839894b709"} 22:25:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:25:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:25:02 INFO - Contents: 22:25:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4648383291c28cc78022a9f531afc74d606b8cdea05774d65196045c9eaed12a98349f8f229908d7ed1aa5bf1010fdaafd6598dff23d734cce742abe9aadad5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05418d0139a79e249aa8309c1d62b35873e698f1d34028e062e8086a5cf8ceb13e637be3971062d24dde21e7dc643b795213caf209aa83f36a289f839894b709"} 22:25:02 INFO - Running post-run listener: copy_logs_to_upload_dir 22:25:02 INFO - Copying logs to upload dir... 22:25:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:25:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.699544 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-10 22:25:01.996112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 22:25:01.999759) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b4648383291c28cc78022a9f531afc74d606b8cdea05774d65196045c9eaed12a98349f8f229908d7ed1aa5bf1010fdaafd6598dff23d734cce742abe9aadad5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05418d0139a79e249aa8309c1d62b35873e698f1d34028e062e8086a5cf8ceb13e637be3971062d24dde21e7dc643b795213caf209aa83f36a289f839894b709"} build_url:https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/b7ST2EWoQF-cAMaXTHqOVg/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/Mozilla-Inbound/sha512/b4648383291c28cc78022a9f531afc74d606b8cdea05774d65196045c9eaed12a98349f8f229908d7ed1aa5bf1010fdaafd6598dff23d734cce742abe9aadad5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/05418d0139a79e249aa8309c1d62b35873e698f1d34028e062e8086a5cf8ceb13e637be3971062d24dde21e7dc643b795213caf209aa83f36a289f839894b709"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 22:25:02.024611) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:25:02.024963) ========= 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=32c5991c409366f7fec8a718000001d2-1455169927.790193-802266487 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 22:25:02.107155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 22:25:02.107534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 22:25:02.107854) ========= ========= Total master_lag: 0.30 =========