builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-003 starttime: 1456531135.9 results: success (0) buildid: 20160226133250 builduid: 5943cc503b4149e7b554d1712835fffe revision: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.904104) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.904681) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.905011) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009065 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.936887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.937404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.990344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:55.990679) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.051932) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.052445) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.053136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.053715) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 15:58:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-02-26 15:58:56 (39.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156644 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.235730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.236043) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014651 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.296644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.296998) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c728ed2a0ba979418ce9ea98cfb45b55967cc7cb --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 c728ed2a0ba979418ce9ea98cfb45b55967cc7cb --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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 15:58:56,801 truncating revision to first 12 chars 2016-02-26 15:58:56,801 Setting DEBUG logging. 2016-02-26 15:58:56,801 attempt 1/10 2016-02-26 15:58:56,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c728ed2a0ba9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 15:58:57,231 unpacking tar archive at: mozilla-inbound-c728ed2a0ba9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764700 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.089748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.090135) ========= echo c728ed2a0ba979418ce9ea98cfb45b55967cc7cb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c728ed2a0ba979418ce9ea98cfb45b55967cc7cb'] 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c728ed2a0ba979418ce9ea98cfb45b55967cc7cb program finished with exit code 0 elapsedTime=0.004023 script_repo_revision: 'c728ed2a0ba979418ce9ea98cfb45b55967cc7cb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.140338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.140676) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.150659) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-26 15:58:57.150975) ========= /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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:57 INFO - MultiFileLogger online at 20160226 15:58:57 in /builds/slave/test-pgo 15:58:57 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 15:58:57 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:58:57 INFO - {'append_to_log': False, 15:58:57 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:58:57 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:58:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:58:57 INFO - 'branch': 'Mozilla-Inbound', 15:58:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:57 INFO - 'config_files': ('talos/linux_config.py',), 15:58:57 INFO - 'default_actions': ('clobber', 15:58:57 INFO - 'read-buildbot-config', 15:58:57 INFO - 'download-and-extract', 15:58:57 INFO - 'populate-webroot', 15:58:57 INFO - 'create-virtualenv', 15:58:57 INFO - 'install', 15:58:57 INFO - 'run-tests'), 15:58:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:57 INFO - 'download_minidump_stackwalk': True, 15:58:57 INFO - 'download_symbols': 'ondemand', 15:58:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:57 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:57 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:57 INFO - 'installer_path': 'installer.exe', 15:58:57 INFO - 'log_level': 'info', 15:58:57 INFO - 'log_name': 'talos', 15:58:57 INFO - 'log_to_console': True, 15:58:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:57 INFO - 'opt_config_files': (), 15:58:57 INFO - 'pip_index': False, 15:58:57 INFO - 'sps_profile': False, 15:58:57 INFO - 'sps_profile_interval': 0, 15:58:57 INFO - 'suite': 'dromaeojs', 15:58:57 INFO - 'system_bits': '32', 15:58:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:57 INFO - 'title': 'talos-linux64-ix-003', 15:58:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:57 INFO - 'use_talos_json': True, 15:58:57 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:58:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:57 INFO - 'work_dir': 'build'} 15:58:57 INFO - ##### 15:58:57 INFO - ##### Running clobber step. 15:58:57 INFO - ##### 15:58:57 INFO - Running pre-action listener: _resource_record_pre_action 15:58:57 INFO - Running main action method: clobber 15:58:57 INFO - rmtree: /builds/slave/test-pgo/build 15:58:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:58:58 INFO - Running post-action listener: _resource_record_post_action 15:58:58 INFO - ##### 15:58:58 INFO - ##### Running read-buildbot-config step. 15:58:58 INFO - ##### 15:58:58 INFO - Running pre-action listener: _resource_record_pre_action 15:58:58 INFO - Running main action method: read_buildbot_config 15:58:58 INFO - Using buildbot properties: 15:58:58 INFO - { 15:58:58 INFO - "project": "", 15:58:58 INFO - "product": "firefox", 15:58:58 INFO - "script_repo_revision": "production", 15:58:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:58:58 INFO - "repository": "", 15:58:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:58:58 INFO - "buildid": "20160226133250", 15:58:58 INFO - "pgo_build": "True", 15:58:58 INFO - "basedir": "/builds/slave/test-pgo", 15:58:58 INFO - "buildnumber": 1541, 15:58:58 INFO - "slavename": "talos-linux64-ix-003", 15:58:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:58:58 INFO - "platform": "ubuntu64_hw", 15:58:58 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:58:58 INFO - "branch": "mozilla-inbound", 15:58:58 INFO - "repo_path": "integration/mozilla-inbound", 15:58:58 INFO - "revision": "c728ed2a0ba979418ce9ea98cfb45b55967cc7cb", 15:58:58 INFO - "stage_platform": "linux64-pgo", 15:58:58 INFO - "builduid": "5943cc503b4149e7b554d1712835fffe", 15:58:58 INFO - "slavebuilddir": "test" 15:58:58 INFO - } 15:58:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:58:58 INFO - Running post-action listener: _resource_record_post_action 15:58:58 INFO - ##### 15:58:58 INFO - ##### Running download-and-extract step. 15:58:58 INFO - ##### 15:58:58 INFO - Running pre-action listener: _resource_record_pre_action 15:58:58 INFO - Running main action method: download_and_extract 15:58:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:58: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')]} 15:58:58 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json 15:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json 15:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:58:58 INFO - Downloaded 1448 bytes. 15:58:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:58:58 INFO - Using the following test package requirements: 15:58:58 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:58:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'jsshell-linux-x86_64.zip'], 15:58:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:58 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:58 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58: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')]} 15:58:58 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:00 INFO - Downloaded 23370843 bytes. 15:59:00 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'] 15:59:00 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 15:59:01 INFO - Return code: 0 15:59:01 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 15:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:01 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:03 INFO - Downloaded 23370843 bytes. 15:59:03 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'] 15:59:03 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 15:59:05 INFO - Return code: 0 15:59:05 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')]} 15:59:05 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:06 INFO - Downloaded 10713410 bytes. 15:59:06 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'] 15:59:06 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 15:59:06 INFO - Return code: 0 15:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:06 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:10 INFO - Downloaded 56629920 bytes. 15:59:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:10 INFO - mkdir: /builds/slave/test-pgo/properties 15:59:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:59:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:59:10 INFO - Contents: 15:59:10 INFO - build_url:https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:11 INFO - Running post-action listener: _resource_record_post_action 15:59:11 INFO - Running post-action listener: set_extra_try_arguments 15:59:11 INFO - ##### 15:59:11 INFO - ##### Running populate-webroot step. 15:59:11 INFO - ##### 15:59:11 INFO - Running pre-action listener: _resource_record_pre_action 15:59:11 INFO - Running main action method: populate_webroot 15:59:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:11 INFO - '--tppagecycles', 15:59:11 INFO - '7'], 15:59:11 INFO - 'tests': ['tsvgm']}}, 15:59:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:59:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'tests': ['damp', 'tps']}, 15:59:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['damp', 'tps']}, 15:59:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:11 INFO - 'other': {'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'other_l64': {'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:11 INFO - 'ts_paint', 15:59:11 INFO - 'tpaint', 15:59:11 INFO - 'sessionrestore', 15:59:11 INFO - 'sessionrestore_no_auto_restore']}, 15:59:11 INFO - 'svgr': {'tests': ['tsvgx', 15:59:11 INFO - 'tsvgr_opacity', 15:59:11 INFO - 'tart', 15:59:11 INFO - 'tscrollx', 15:59:11 INFO - 'cart']}, 15:59:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['tsvgx', 15:59:11 INFO - 'tsvgr_opacity', 15:59:11 INFO - 'tart', 15:59:11 INFO - 'tscrollx', 15:59:11 INFO - 'cart']}, 15:59:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'tests': ['tp5o']}, 15:59:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'talos_options': ['--e10s'], 15:59:11 INFO - 'tests': ['tp5o']}, 15:59:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'talos_options': ['--xperf_path', 15:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:11 INFO - 'tests': ['tp5n']}, 15:59:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:11 INFO - 'talos_options': ['--e10s', 15:59:11 INFO - '--xperf_path', 15:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:11 INFO - 'tests': ['tp5n']}}, 15:59:11 INFO - 'talos.zip': {'path': '', 15:59:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:11 INFO - Running post-action listener: _resource_record_post_action 15:59:11 INFO - ##### 15:59:11 INFO - ##### Running create-virtualenv step. 15:59:11 INFO - ##### 15:59:11 INFO - Running pre-action listener: _resource_record_pre_action 15:59:11 INFO - Running main action method: create_virtualenv 15:59:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:59:11 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 15:59:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:59:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:11 INFO - Using real prefix '/usr' 15:59:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:59:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:13 INFO - Installing pip.................done. 15:59:13 INFO - Return code: 0 15:59:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:59:14 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 15:59:14 INFO - Using env: {'DISPLAY': ':0', 15:59:14 INFO - 'HOME': '/home/cltbld', 15:59:14 INFO - 'LANG': 'en_US.UTF-8', 15:59:14 INFO - 'LANGUAGE': 'en_US:en', 15:59:14 INFO - 'LOGNAME': 'cltbld', 15:59:14 INFO - 'MAIL': '/var/mail/cltbld', 15:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:14 INFO - 'MOZ_NO_REMOTE': '1', 15:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:14 INFO - 'NO_EM_RESTART': '1', 15:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:14 INFO - 'SHELL': '/bin/bash', 15:59:14 INFO - 'SHLVL': '1', 15:59:14 INFO - 'TERM': 'linux', 15:59:14 INFO - 'TMOUT': '86400', 15:59:14 INFO - 'USER': 'cltbld', 15:59:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:14 INFO - '_': '/tools/buildbot/bin/python'} 15:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:14 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 15:59:14 INFO - Cleaning up... 15:59:14 INFO - Return code: 0 15:59:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:59:14 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')]} 15:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:14 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')]} 15:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:14 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:14 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 15:59:14 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 15:59:14 INFO - Using env: {'DISPLAY': ':0', 15:59:14 INFO - 'HOME': '/home/cltbld', 15:59:14 INFO - 'LANG': 'en_US.UTF-8', 15:59:14 INFO - 'LANGUAGE': 'en_US:en', 15:59:14 INFO - 'LOGNAME': 'cltbld', 15:59:14 INFO - 'MAIL': '/var/mail/cltbld', 15:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:14 INFO - 'MOZ_NO_REMOTE': '1', 15:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:14 INFO - 'NO_EM_RESTART': '1', 15:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:14 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:14 INFO - 'SHELL': '/bin/bash', 15:59:14 INFO - 'SHLVL': '1', 15:59:14 INFO - 'TERM': 'linux', 15:59:14 INFO - 'TMOUT': '86400', 15:59:14 INFO - 'USER': 'cltbld', 15:59:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:14 INFO - '_': '/tools/buildbot/bin/python'} 15:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:14 INFO - Downloading/unpacking psutil>=0.7.1 15:59:14 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 15:59:14 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 15:59:14 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 15:59:14 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 15:59:14 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 15:59:14 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 15:59:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:16 INFO - Installing collected packages: psutil 15:59:16 INFO - Running setup.py install for psutil 15:59:16 INFO - building 'psutil._psutil_linux' extension 15:59:16 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 15:59:16 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 15:59:16 INFO - building 'psutil._psutil_posix' extension 15:59:16 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 15:59:16 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 15:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:16 INFO - Successfully installed psutil 15:59:16 INFO - Cleaning up... 15:59:16 INFO - Return code: 0 15:59:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:59:16 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')]} 15:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:16 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')]} 15:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:16 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:16 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 15:59:16 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 15:59:16 INFO - Using env: {'DISPLAY': ':0', 15:59:16 INFO - 'HOME': '/home/cltbld', 15:59:16 INFO - 'LANG': 'en_US.UTF-8', 15:59:16 INFO - 'LANGUAGE': 'en_US:en', 15:59:16 INFO - 'LOGNAME': 'cltbld', 15:59:16 INFO - 'MAIL': '/var/mail/cltbld', 15:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:16 INFO - 'MOZ_NO_REMOTE': '1', 15:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:16 INFO - 'NO_EM_RESTART': '1', 15:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:16 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:16 INFO - 'SHELL': '/bin/bash', 15:59:16 INFO - 'SHLVL': '1', 15:59:16 INFO - 'TERM': 'linux', 15:59:16 INFO - 'TMOUT': '86400', 15:59:16 INFO - 'USER': 'cltbld', 15:59:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:16 INFO - '_': '/tools/buildbot/bin/python'} 15:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:17 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 15:59:17 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 15:59:17 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 15:59:17 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 15:59:17 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 15:59:17 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 15:59:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:19 INFO - Installing collected packages: mozsystemmonitor 15:59:19 INFO - Running setup.py install for mozsystemmonitor 15:59:19 INFO - Successfully installed mozsystemmonitor 15:59:19 INFO - Cleaning up... 15:59:19 INFO - Return code: 0 15:59:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:59:19 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')]} 15:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 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')]} 15:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:19 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:19 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 15:59:19 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 15:59:19 INFO - Using env: {'DISPLAY': ':0', 15:59:19 INFO - 'HOME': '/home/cltbld', 15:59:19 INFO - 'LANG': 'en_US.UTF-8', 15:59:19 INFO - 'LANGUAGE': 'en_US:en', 15:59:19 INFO - 'LOGNAME': 'cltbld', 15:59:19 INFO - 'MAIL': '/var/mail/cltbld', 15:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:19 INFO - 'MOZ_NO_REMOTE': '1', 15:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:19 INFO - 'NO_EM_RESTART': '1', 15:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:19 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:19 INFO - 'SHELL': '/bin/bash', 15:59:19 INFO - 'SHLVL': '1', 15:59:19 INFO - 'TERM': 'linux', 15:59:19 INFO - 'TMOUT': '86400', 15:59:19 INFO - 'USER': 'cltbld', 15:59:19 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:19 INFO - '_': '/tools/buildbot/bin/python'} 15:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:19 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:19 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 15:59:19 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 15:59:19 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 15:59:19 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 15:59:19 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 15:59:19 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 15:59:21 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:21 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 15:59:22 INFO - Downloading docopt-0.6.1.tar.gz 15:59:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:22 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:22 INFO - Running setup.py install for blobuploader 15:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:59:22 INFO - Running setup.py install for requests 15:59:22 INFO - Running setup.py install for docopt 15:59:22 INFO - Successfully installed blobuploader requests docopt 15:59:22 INFO - Cleaning up... 15:59:22 INFO - Return code: 0 15:59:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:22 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:22 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 15:59:22 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 15:59:22 INFO - Using env: {'DISPLAY': ':0', 15:59:22 INFO - 'HOME': '/home/cltbld', 15:59:22 INFO - 'LANG': 'en_US.UTF-8', 15:59:22 INFO - 'LANGUAGE': 'en_US:en', 15:59:22 INFO - 'LOGNAME': 'cltbld', 15:59:22 INFO - 'MAIL': '/var/mail/cltbld', 15:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:22 INFO - 'MOZ_NO_REMOTE': '1', 15:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:22 INFO - 'NO_EM_RESTART': '1', 15:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:22 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:22 INFO - 'SHELL': '/bin/bash', 15:59:22 INFO - 'SHLVL': '1', 15:59:22 INFO - 'TERM': 'linux', 15:59:22 INFO - 'TMOUT': '86400', 15:59:22 INFO - 'USER': 'cltbld', 15:59:22 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:22 INFO - '_': '/tools/buildbot/bin/python'} 15:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:22 INFO - Running setup.py (path:/tmp/pip-ZwKpHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:23 INFO - Running setup.py (path:/tmp/pip-pR6ZCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:23 INFO - Running setup.py (path:/tmp/pip-Zpo5Bi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:23 INFO - Running setup.py (path:/tmp/pip-zybKQ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:23 INFO - Running setup.py (path:/tmp/pip-Ncd2ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:23 INFO - Running setup.py (path:/tmp/pip-P8eYVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:23 INFO - Running setup.py (path:/tmp/pip-a0x7Ud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:23 INFO - Running setup.py (path:/tmp/pip-3Bhrsr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:23 INFO - Running setup.py (path:/tmp/pip-Cfx_7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:23 INFO - Running setup.py (path:/tmp/pip-QDvpek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:23 INFO - Running setup.py (path:/tmp/pip-FvDgcD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:23 INFO - Running setup.py (path:/tmp/pip-jMDBfP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:23 INFO - Running setup.py (path:/tmp/pip-HRlHj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:23 INFO - Running setup.py (path:/tmp/pip-RiKeXB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:23 INFO - Running setup.py (path:/tmp/pip-BP40By-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:24 INFO - Running setup.py (path:/tmp/pip-p4_gY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:24 INFO - Running setup.py (path:/tmp/pip-WTfkDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:24 INFO - Running setup.py install for manifestparser 15:59:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Running setup.py install for mozcrash 15:59:24 INFO - Running setup.py install for mozdebug 15:59:24 INFO - Running setup.py install for mozdevice 15:59:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Running setup.py install for mozfile 15:59:24 INFO - Running setup.py install for mozhttpd 15:59:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Running setup.py install for mozinfo 15:59:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Running setup.py install for mozInstall 15:59:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:59:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Running setup.py install for mozleak 15:59:25 INFO - Running setup.py install for mozlog 15:59:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Running setup.py install for moznetwork 15:59:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Running setup.py install for mozprocess 15:59:25 INFO - Running setup.py install for mozprofile 15:59:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Running setup.py install for mozrunner 15:59:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Running setup.py install for mozscreenshot 15:59:25 INFO - Running setup.py install for moztest 15:59:25 INFO - Running setup.py install for mozversion 15:59:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:59:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:25 INFO - Cleaning up... 15:59:25 INFO - Return code: 0 15:59:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:25 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')]} 15:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:25 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')]} 15:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:25 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:25 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 15:59:25 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 15:59:25 INFO - Using env: {'DISPLAY': ':0', 15:59:25 INFO - 'HOME': '/home/cltbld', 15:59:25 INFO - 'LANG': 'en_US.UTF-8', 15:59:25 INFO - 'LANGUAGE': 'en_US:en', 15:59:25 INFO - 'LOGNAME': 'cltbld', 15:59:25 INFO - 'MAIL': '/var/mail/cltbld', 15:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:25 INFO - 'MOZ_NO_REMOTE': '1', 15:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:25 INFO - 'NO_EM_RESTART': '1', 15:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:25 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:25 INFO - 'SHELL': '/bin/bash', 15:59:25 INFO - 'SHLVL': '1', 15:59:25 INFO - 'TERM': 'linux', 15:59:25 INFO - 'TMOUT': '86400', 15:59:25 INFO - 'USER': 'cltbld', 15:59:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:25 INFO - '_': '/tools/buildbot/bin/python'} 15:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:26 INFO - Running setup.py (path:/tmp/pip-0UrwkB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:26 INFO - Running setup.py (path:/tmp/pip-1hhD2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:26 INFO - Running setup.py (path:/tmp/pip-ysl4QZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:26 INFO - Running setup.py (path:/tmp/pip-Tu9iGK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:26 INFO - Running setup.py (path:/tmp/pip-mgdow6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:26 INFO - Running setup.py (path:/tmp/pip-A4Exih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:26 INFO - Running setup.py (path:/tmp/pip-eyhDd_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:26 INFO - Running setup.py (path:/tmp/pip-6TMHj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:26 INFO - Running setup.py (path:/tmp/pip-ngISho-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:26 INFO - Running setup.py (path:/tmp/pip-AUgDGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:26 INFO - Running setup.py (path:/tmp/pip-RqsXvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:26 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)) 15:59:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:27 INFO - Running setup.py (path:/tmp/pip-sekGP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:27 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)) 15:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:27 INFO - Running setup.py (path:/tmp/pip-zUIAbk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:27 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)) 15:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:27 INFO - Running setup.py (path:/tmp/pip-CH8rR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:27 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)) 15:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:27 INFO - Running setup.py (path:/tmp/pip-UOtsy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:27 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)) 15:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:27 INFO - Running setup.py (path:/tmp/pip-OrJy0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:27 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)) 15:59:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:27 INFO - Running setup.py (path:/tmp/pip-pySJjs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:27 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)) 15:59:27 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)) 15:59:27 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)) 15:59:27 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)) 15:59:27 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)) 15:59:27 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)) 15:59:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:27 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 15:59:27 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 15:59:27 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 15:59:27 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 15:59:27 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 15:59:27 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 15:59:29 INFO - Downloading blessings-1.6.tar.gz 15:59:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:29 INFO - Installing collected packages: blessings 15:59:29 INFO - Running setup.py install for blessings 15:59:29 INFO - Successfully installed blessings 15:59:29 INFO - Cleaning up... 15:59:29 INFO - Return code: 0 15:59:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:59:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:29 INFO - Reading from file tmpfile_stdout 15:59:29 INFO - Current package versions: 15:59:29 INFO - argparse == 1.2.1 15:59:29 INFO - blessings == 1.6 15:59:29 INFO - blobuploader == 1.2.4 15:59:29 INFO - docopt == 0.6.1 15:59:29 INFO - manifestparser == 1.1 15:59:29 INFO - mozInstall == 1.12 15:59:29 INFO - mozcrash == 0.16 15:59:29 INFO - mozdebug == 0.1 15:59:29 INFO - mozdevice == 0.48 15:59:29 INFO - mozfile == 1.2 15:59:29 INFO - mozhttpd == 0.7 15:59:29 INFO - mozinfo == 0.9 15:59:29 INFO - mozleak == 0.1 15:59:29 INFO - mozlog == 3.1 15:59:29 INFO - moznetwork == 0.27 15:59:29 INFO - mozprocess == 0.22 15:59:29 INFO - mozprofile == 0.28 15:59:29 INFO - mozrunner == 6.11 15:59:29 INFO - mozscreenshot == 0.1 15:59:29 INFO - mozsystemmonitor == 0.0 15:59:29 INFO - moztest == 0.7 15:59:29 INFO - mozversion == 1.4 15:59:29 INFO - psutil == 3.1.1 15:59:29 INFO - requests == 1.2.3 15:59:29 INFO - wsgiref == 0.1.2 15:59:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:29 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 15:59:29 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 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 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)) 15:59:29 INFO - Cleaning up... 15:59:29 INFO - Return code: 0 15:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:30 INFO - Downloading/unpacking jsonschema 15:59:30 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 15:59:30 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 15:59:30 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 15:59:30 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 15:59:30 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 15:59:30 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 15:59:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:31 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:32 INFO - warning: no files found matching '*.txt' 15:59:32 INFO - no previously-included directories found matching 'build' 15:59:32 INFO - no previously-included directories found matching 'dist' 15:59:32 INFO - no previously-included directories found matching '.git*' 15:59:32 INFO - Installing collected packages: jsonschema, functools32 15:59:32 INFO - Running setup.py install for functools32 15:59:32 INFO - warning: no files found matching '*.txt' 15:59:32 INFO - no previously-included directories found matching 'build' 15:59:32 INFO - no previously-included directories found matching 'dist' 15:59:32 INFO - no previously-included directories found matching '.git*' 15:59:32 INFO - Successfully installed jsonschema functools32 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x7fe778ef6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f7670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, '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': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', '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 15:59:32 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 15:59:32 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 15:59:32 INFO - Using env: {'DISPLAY': ':0', 15:59:32 INFO - 'HOME': '/home/cltbld', 15:59:32 INFO - 'LANG': 'en_US.UTF-8', 15:59:32 INFO - 'LANGUAGE': 'en_US:en', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MAIL': '/var/mail/cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SHLVL': '1', 15:59:32 INFO - 'TERM': 'linux', 15:59:32 INFO - 'TMOUT': '86400', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - '_': '/tools/buildbot/bin/python'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 INFO - Downloading/unpacking flake8 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:34 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 15:59:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:35 INFO - no previously-included directories found matching 'docs/_build' 15:59:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:35 INFO - Running setup.py install for pep8 15:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:35 INFO - no previously-included directories found matching 'docs/_build' 15:59:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:59:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:35 INFO - Cleaning up... 15:59:35 INFO - Return code: 0 15:59:35 INFO - Running post-action listener: _resource_record_post_action 15:59:35 INFO - Running post-action listener: _start_resource_monitoring 15:59:35 INFO - Starting resource monitoring. 15:59:35 INFO - ##### 15:59:35 INFO - ##### Running install step. 15:59:35 INFO - ##### 15:59:35 INFO - Running pre-action listener: _resource_record_pre_action 15:59:35 INFO - Running main action method: install 15:59:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:35 INFO - Reading from file tmpfile_stdout 15:59:35 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:59:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:59:35 INFO - Reading from file tmpfile_stdout 15:59:35 INFO - Output received: 15:59:35 INFO - Usage: mozinstall [options] installer 15:59:35 INFO - Options: 15:59:35 INFO - -h, --help show this help message and exit 15:59:35 INFO - -d DEST, --destination=DEST 15:59:35 INFO - Directory to install application into. [default: 15:59:35 INFO - "/builds/slave/test-pgo"] 15:59:35 INFO - --app=APP Application being installed. [default: firefox] 15:59:35 INFO - mkdir: /builds/slave/test-pgo/build/application 15:59:35 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'] 15:59:35 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 15:59:52 INFO - Reading from file tmpfile_stdout 15:59:52 INFO - Output received: 15:59:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:59:52 INFO - Running post-action listener: _resource_record_post_action 15:59:52 INFO - ##### 15:59:52 INFO - ##### Running run-tests step. 15:59:52 INFO - ##### 15:59:52 INFO - Running pre-action listener: _resource_record_pre_action 15:59:52 INFO - Running main action method: run_tests 15:59:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:59:52 INFO - Python 2.7.3 15:59:52 INFO - Return code: 0 15:59:52 INFO - grabbing minidump binary from tooltool 15:59: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')]} 15:59:52 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 0x13868c0>, '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 0x13877c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1387c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:59:52 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 15:59:52 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 15:59:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:52 INFO - Return code: 0 15:59:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:59:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:59:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:59:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:59:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:59:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:59:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:59:53 INFO - Return code: 0 15:59:53 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/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 15:59:53 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/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 15:59:53 INFO - Using env: {'DISPLAY': ':0', 15:59:53 INFO - 'HOME': '/home/cltbld', 15:59:53 INFO - 'LANG': 'en_US.UTF-8', 15:59:53 INFO - 'LANGUAGE': 'en_US:en', 15:59:53 INFO - 'LOGNAME': 'cltbld', 15:59:53 INFO - 'MAIL': '/var/mail/cltbld', 15:59:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:59:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:53 INFO - 'MOZ_NO_REMOTE': '1', 15:59:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:53 INFO - 'NO_EM_RESTART': '1', 15:59:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:59:53 INFO - 'SHELL': '/bin/bash', 15:59:53 INFO - 'SHLVL': '1', 15:59:53 INFO - 'TERM': 'linux', 15:59:53 INFO - 'TMOUT': '86400', 15:59:53 INFO - 'USER': 'cltbld', 15:59:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1456529635.592504-1876714100', 15:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:53 INFO - '_': '/tools/buildbot/bin/python'} 15:59:53 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/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 15:59:53 INFO - mozversion application_buildid: 20160226133250 15:59:53 INFO - mozversion application_changeset: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb 15:59:53 INFO - mozversion application_display_name: Nightly 15:59:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:53 INFO - mozversion application_name: Firefox 15:59:53 INFO - mozversion application_remotingname: firefox 15:59:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:53 INFO - mozversion application_vendor: Mozilla 15:59:53 INFO - mozversion application_version: 47.0a1 15:59:53 INFO - mozversion platform_buildid: 20160226133250 15:59:53 INFO - mozversion platform_changeset: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb 15:59:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:59:53 INFO - mozversion platform_version: 47.0a1 15:59:53 INFO - using testdate: 1456531193 15:59:53 INFO - actual date: 1456531193 15:59:53 INFO - starting webserver on 'localhost:48307' 15:59:53 INFO - SUITE-START | Running 2 tests 15:59:53 INFO - TEST-START | dromaeo_css 15:59:53 INFO - operating with platform_type : linux_ 15:59:53 INFO - Initialising browser for dromaeo_css test... 15:59:53 INFO - TEST-INFO | started process 25781 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp70ZHL/profile http://localhost:48307/getInfo.html) 15:59:57 INFO - PROCESS | 25781 | __metrics Screen width/height:1600/1200 15:59:57 INFO - PROCESS | 25781 | colorDepth:24 15:59:57 INFO - PROCESS | 25781 | Browser inner width/height: 1024/697 15:59:57 INFO - PROCESS | 25781 | __metrics 15:59:58 INFO - PROCESS | 25781 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 15:59:58 INFO - PROCESS | 25781 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 15:59:59 INFO - TEST-INFO | 25781: exit 0 15:59:59 INFO - Browser initialized. 15:59:59 INFO - Running cycle 1/1 for dromaeo_css test... 15:59:59 INFO - TEST-INFO | started process 25875 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp70ZHL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:11 INFO - PROCESS | 25875 | RSS: Main: 150786048 16:00:11 INFO - PROCESS | 25875 | 16:01:02 INFO - PROCESS | 25875 | 1456531262949 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] 16:03:10 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48307/tests/dromaeo/cssquery-ext.html) 16:03:11 INFO - PROCESS | 25875 | RSS: Main: 256614400 16:03:11 INFO - PROCESS | 25875 | 16:06:14 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-ext.html (next: http://localhost:48307/tests/dromaeo/cssquery-jquery.html) 16:06:14 INFO - PROCESS | 25875 | RSS: Main: 235966464 16:06:14 INFO - PROCESS | 25875 | 16:09:16 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48307/tests/dromaeo/cssquery-mootools.html) 16:09:17 INFO - PROCESS | 25875 | RSS: Main: 233476096 16:09:17 INFO - PROCESS | 25875 | 16:12:19 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48307/tests/dromaeo/cssquery-prototype.html) 16:12:19 INFO - PROCESS | 25875 | RSS: Main: 202678272 16:12:19 INFO - PROCESS | 25875 | 16:15:22 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48307/tests/dromaeo/cssquery-yui.html) 16:15:22 INFO - PROCESS | 25875 | RSS: Main: 213078016 16:15:22 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | Cycle 1(1): loaded http://localhost:48307/tests/dromaeo/cssquery-yui.html (next: http://localhost:48307/tests/dromaeo/cssquery-dojo.html) 16:18:25 INFO - PROCESS | 25875 | RSS: Main: 320700416 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | __start_tp_report 16:18:25 INFO - PROCESS | 25875 | _x_x_mozilla_page_load 16:18:25 INFO - PROCESS | 25875 | _x_x_mozilla_page_load_details 16:18:25 INFO - PROCESS | 25875 | |i|pagename|runs| 16:18:25 INFO - PROCESS | 25875 | |0;dojo.html;3090.2892334763005;3117.5323701444768;3159.69982851629;3169.8890538831147;3193.105930339505;4956.5786908112805;4964.999999999995;4988.35151430314;5072.695638261707;5149.485051494858;4998.7250701211415;5047.4447810740885;5125.154349532323;5152.845414637567;5157.355330583677;4640.955784948394;4644.837430689927;4660.394148760656;4683.882902927437;4908.705477671351;4665.9766701166445;4793.32893394925;4822.011487645024;4835.806567737286;4898.7060776353355;4658.580727734503;4722.220833562458;4731.1720448921305;4739.881502962419;4762.714237145765;4616.469106052779;4622.583967442946;4645.279981602857;4645.7909394077005;4660.720356778605;4613.561711637422;4622.514635963209;4626.560476754703;4723.645726570521;4800;4895.559399654013;4904.6566740327835;4925.655204135712;4934.80260789568;4945.406551213841;5448.101063324547;5458.099413596752;5461.713676214776;5462.317210348707;5512.062949298589;5361;5497.8075767347955;5567.9977604031255;5590.18942253375;5665.5467562594895;5211.895762084737;5255.316808814868;5257.263983042377;5261.263423120766;5274.894502109936;5656.604037717402;5688.9715551422805;5702.857428564236;5703.429657034263;5708.4862362387585;5227.738613069331;5325.653832500952;5347.572194224453;5409.215663728737;5420.105682562333;5459.099248624012;5464.371597266286;5466.1527463243265;5469.945300546943;5472;5344.305240318734;5437.483439073281;5445.401005889349;5451.209574611738;5492.588055895744;5528.474794894479;5548.750306236229;5560.138178582245;5563.304586926634;5621.49406553404;4182.832686692498;4219.367094935723;4221.810018549173;4226.112516371535;4255.744655320691;3731.235096805203;3767.4348847672522;3827.349350610403;3838.5777564467885;3861.884143475644;5097.260897169964;5114.769835357418;5116.795328186905;5160.432352441228;5160.948390516121;5376.650517716336;5382.219578161144;5386.892262154814;5401.3248343957;5433.701146436984;5051.87370315745;5123.513266239701;5184.974075129676;5200.193969934666;5306.814261500829;4644.0944015916575;4662.6269898408045;4667.439907211156;4693;4701.553352431513;5670.177824215466;5680.261565996394;5680.801171958961;5693.259876216065;5720.513756330675;5397.433269506802;5414.810481633124;5460.372057213472;5465.754041068082;5500.697461639648;5674.460926212003;5681.318241811009;5687.943120568907;5689.54483641316;5698.800541981011;5386.757595908115;5388.811391601275;5391.622586418913;5393.191021346673;5397.9730101350815;5387.568994480511;5408.648437851527;5495.422980586981;5530.446955304437;5555.527780138734;5296.073187192149;5304.575633949352;5307.840764777063;5309.628326017296;5314.681119132864;5286.524212820865;5291.523762861361;5303.575713942798;5305.151175811851;5348.7593058311695;5210.895782084262;5282.260483532232;5304.230886521355;5347.51872331492;5373;5247.344081989751;5322.946770532245;5330.840074797762;5331;5382.865428364165;5106.131957567297;5220.008198442284;5223.4515375884985;5229.895402092013;5237.685738855528 16:18:25 INFO - PROCESS | 25875 | |1;ext.html;510.7037918007556;513.5557742552693;516.886285017296;528.2472476720673;556.3407362275701;28500.28749281269;37502.249955000916;37637.247255054914;37716.43425348622;37807.05482362942;39753.20493590134;40024.79987600065;40121.799391003005;40256.79871600645;40293;8496.1503849615;8692.174243446863;8698.39111262212;8703.347248956323;8740.8688869667;8429.241368276855;8539.06070332263;8575.056743758181;8575.056743758181;8775.868361974575;8766.517841518715;8823.382363234576;8846.690365837198;8851.380403371766;8852.070532594082;8718.564071796385;8776.297896168291;8793.7801554961;8796.648134074629;8798.604062817156;8652.178043085896;8730.69442569507;8758.781030474225;8796.25231855293;8799.692010779656;40172.397414038816;40595;40662.18675626471;40699.59300407017;40703.79648101741;3329.966700333014;3339.9980005998104;3383.543221665093;3486.1981744198724;4043.8382464701376;28856.567151492745;28931.421371572662;29289.41421171586;30342.54486182709;30384.54423183654;3380.628130905623;3391.5590973173576;3444.9655503444897;3452.6202117767025;3471.1322169457635;265598;269191.6540417305;272196.30724002875;273067;273223;42626.57373426288;64361.67819160968;64453;65036;65071;43585.56414435879;43902.34146487805;43914.78042609766;43969.560304396546;43989;14776.113433194043;14965.625859353604;15032.924835375754;15035.473758418402;15046.924765376103;11708.648740537797;11994.820077698841;12030.81953770694;12033.819492707617;12039.699007524707;14791.260436978324;14896.478623248135;14897.627559310888;14929.776053359208;15021.69956600862;5985.34161242263;6100.664463454464;6119.418655227746;6165.167702360124;6206.534509911684;915.3729695158837;921.3918813583003;1005;1036.3367444835312;1046.9214808889365;28299.15102546927;28312.71687283142;28417.147485575464;28697;28720;1041.7760181561;1058.111186603257;1123.3203911633507;1123.9550417983353;1191.2792760379846;14392.85607143936;14810.851891481163;14823.925880370745;14861.182634954965;15047.398104075934;308414;310349;311828;312310;312522;52345.7382713084;52972.735136324074;53021.469785302426;53045.469545304826;53090.46909530855;1169.7543515861594;1323.6095351871222;1331.4807225182187;1352.7767918293569;1356.4438580182275;25297.87351063233;26747.86626066935;26880.59679104854;26885;26985.460290794468;39101.21797563976;49328.75335623299;50227.99544009173;50338.49661503338;50348;279042;284903.05678602296;286422;287018;288333;37335.43996840104;43028.78485607552;43097.35353969756;43807.34288985732;45448.31827522524;40452.3932141024;41011.58988410197;41238.58761412468;41262.79368603138;41877.79061104797;33213.335733284715;33614;34812.65187348094;37035;38227.42658860064;37388.4672389612;37390.439143412324;37951.62048379481;38044.23911521809;38585.22829543337;36890.44664330091;37563;38304.80847595744;38947.2210555793;39348.40977385284;28977;30757.846210768803;30922.158436285365;31086.37827243488;33314;25583.6162457567;25685.229443116736;25709.13622664546;25749.227523174333;25970.09104681327 16:18:25 INFO - PROCESS | 25875 | |2;jquery.html;354.91659460026887;356.71997481976655;359.4087725691238;361.97466177367596;365.344207148169;14188.07777494462;16892.999999999985;17309.307627694892;17324.307027718874;18480.537986550342;14560.985201077188;14584.927075364609;14916.701665966673;15085.360061989162;15448.15035173065;5269.578433725303;5312.229726689628;5377.78488860447;5400.78396864125;5403;5208.583313334924;5333.839984800462;5407.3781515125875;5411.107167317407;5420.756065977041;5356.330458692663;5359.651622644536;5361.651492652984;5369.355677318707;5395.59533035022;5353;5366.570674346043;5462.754176062067;5635.464630860103;5636.126400407943;4993.7503124843615;4995.725235112068;4997.325361076281;5019.723915184663;5030.396352437694;11537.307761534335;13748.862511374859;20156.49608759778;20162.092705828272;20212.494687632927;2085.0825636719796;2223.3663405929233;2231.0295021665465;2378.5124049569795;2527.481866217421;8631.956840215758;8774;9037.277017838556;9158.908410915872;9231.769205769842;1738.4089409600797;1859.748933893934;1867.4304337177155;1870.803565625617;1871.8876867388;62169.99999999955;62612.37387626157;62964.370356296306;64033.67983160101;64663.4413021624;9414.2468602513;9480.24158067353;9509.952450237704;9615.711528654152;9694.51527423626;11869.287842729464;12329.198602091015;12365.258084514959;12390.81413778794;12408.441620127116;7083.539569927938;7256.4146804368065;7309.5248808827255;7328.890066649004;7368.815779605553;6923.446124310043;6941.375276225164;6975.79072627822;7023.789286321418;7062.117235345582;4487.125010622897;4493.483249426358;4502.3921770560555;4523.095380923828;4565.269556870885;1614.5802091456305;1634.7302695055182;1723.1039859273358;1725.5427311762394;1738.1135620833213;889.564113584339;900.4372267332917;919.9632014719336;960.558143254111;978.500964508106;16259;16627.66744665124;16944;17157.57106072358;17282.82717172837;936.5598168860624;938.8685584018243;943.4575119306427;949.3734135470694;954.1365064616533;9163.129502697233;9488.098630630078;9500.287478439144;9633.951830240803;9737.415755054719;391093;396228;401020;409750;410205;71968;75869;76298.61850690823;77032;78129;951.1012093571646;954.6086104697041;967.849983252597;968.5399435268191;982.7101005203625;13900.721985560434;14538.491152809602;14567;14649.707005860037;15051.774223386878;31690;32708.182295441853;32789.83605081959;32805.83597081999;32988.1752956178;41461;44851.775741122394;45751.542484574726;45892.77053614844;46776.7661161692;7421.888671669822;7546.735864244725;7653.770386888402;7764.495307804975;7780.49426787257;9256.861147082664;9685.564149613143;11172.385518796544;12174.330411827434;12503.06227032958;10296.639617613348;10467.528961196613;10513.316634418738;10729.409882456228;10756.354618722902;10274.845877311996;10332.586696532055;10341.37951722869;10651.520681569504;10894.182936279969;10232;10523.78952420932;10744.946275268574;10794.56821727122;11007.889921100686;7318.890216646861;7341.963290183515;7497.437692173218;7575.166731659403;7843.4117441191;10039.749006274902;10622.150227981898;10866.945665271624;10921.836172457579;10951.726206844893 16:18:25 INFO - PROCESS | 25875 | |3;mootools.html;1348.5414958913968;1403.4035534897669;1421.2325344314072;1549.9845001549988;1754.149237619754;6885.4147397471215;7023.262557431466;7031.085958825352;7057.858842823141;7082.610456424907;7252;7415.147258065324;7437.739679111232;7437.814054648637;7439.962800186005;1910.1213441816712;2111.313823007521;2112.6936594193835;2138.016512404296;2172.391730315514;2153.6984822124837;2187.2344679362254;2190.1786829938774;2191.298784388996;2191.8356123290737;2129.4356995396233;2143.164165975263;2146.8067873891346;2148.559545293211;2149.849510534263;2150.3441450357554;2173.608750424923;2178.9891050544807;2185.7595664476894;2186.1364760919428;2130.2224687988773;2156.2453141400383;2171.880546569938;2172.8153106985924;2175.8041776240216;7304.160021597531;7345.669444874993;7348.191698913115;7349.265073492661;7365.189829118793;4425.159219748238;4508.188526065307;4540.409746732904;4544.909101817978;4545.454545454533;2924.6344206974127;2962.3630919352445;2999.685033071518;3007.6541197762317;3064.724174824254;915.7985243246475;920.7329874336434;921.2215677752289;932.1610550504532;962.5668449197819;10001.849972250422;10150.289479736495;10191.847122293171;10195.133413659847;10200.48997550127;4012.498437695288;4065.2682517147196;4130.524989626231;4138.089620283533;4147.564505726855;8736.995245546716;8745.693900713572;8758.167974042455;8796.384253102222;8835.734927952171;4013.4381186633896;4552.908941821212;4558.247889098328;4574.565416285448;4579.198640237945;4005.1989602079702;4102.794860256975;4109.938350924738;4126.133511962522;4131.938020929689;3500.2824420993634;3569.7322700797026;3582.695470885004;3594.2452085062428;3661.212839239576;1147.1167201255155;1153.5155234801402;1158.102470585303;1165.1727273635813;1166.0147175636573;1065.1159537583787;1078.126717358926;1085.592902661502;1227.975440491203;1333.9399727012308;7023.89464158038;7109;7112.146542414944;7116.466265030143;7137;1112.4993752811267;1127.610974213895;1132.3828513460185;1140.4753813246;1152.343164396286;5476.918770867124;5737.454941780524;5738.598298119092;5740.425957404226;5745.1382292656435;8742.21320081183;8870.51212183336;8905.020447750741;8967.058458861857;8991.775205619912;8972.8654070189;9004.639814407481;9024.232940200025;9048.009437923647;9113.726588202364;7043.506954513237;7079.1858936223;7194.820129496805;7201.855962880818;7203.89194162088;6893.517453778388;6941.167059952838;6952.687129079305;6962.1297337832775;6967.581945083311;8005.639746211551;8086.838263234585;8096.757097287091;8230.958845205736;8266.958665206635;8221.79445513867;8417.873731893904;8440.282575981111;8528.488290702579;8532.786680333042;5618.634788738719;5719.656820590778;5721.971390143022;6264.373562643699;6305.337939516285;7000.194977577644;7085;7146;7147.46394020461;7176.96411517939;6345.968270158804;6409.2949775525585;6442.967785161044;6500.414962653384;6579.4736421087155;6273.874522509615;6386.361363863576;6437;6483.967580162069;6518.543701940818;6694.966525167343;6734.898976515454;6747;6812.455003599799;6855.177378714586;6086.72609732572;6114.327423983447;6123.755049797958;6264.154339164154;6304.243490781136;6135.84660383494;6152.323244443197;6178.536609754196;6201.1628430163155;6225.937740622536 16:18:25 INFO - PROCESS | 25875 | |4;prototype.html;287.5155363212986;291.25293621859936;293.25220687247526;299.94301082794254;303.1662926950885;5755.0504166812425;5799.246098007258;5812.912806307903;5820.708964551766;5835.5915085944;5682.659040457565;5693;5700.600957932947;5712.200291959129;5716.14257861321;4186.141840922619;4273.850415235467;4372.890677733066;4376.759278239696;4390.100029493946;4376.627986621141;4385.10105428388;4394.670399720034;4398.208322501949;4399.27411977025;4354.346847972798;4356.97821510892;4359.585839345273;4362.8691139265875;4368.5194628590825;4160.604742549468;4254.4043833863125;4335.154644844257;4335.653147748172;4338.652907767371;3731.4589384539363;3740.139767853409;3751.362268414376;3755.455458958436;3755.924881502382;5468.152436372368;5473.75368108436;5475.178723191513;5476.58925580579;5477.370102438231;4995.975020124913;4997.375328083989;4998.050370429607;4999.875003124915;5001.124803159432;6027.578069535134;6033.3664965178905;6036.698165091771;6042.848928776772;6049.122877182828;3902.863399780994;4044.0496483326397;4145.108801607669;4145.7927103645;4149.958500415018;6298.275698294663;6312.905306420407;6334.239891213084;6334.904976425358;6339.270983836872;4152.460180176618;4153.1486045360625;4153.6677065834665;4154.937675934863;4156.584341565819;4202.537720850704;4203.138356636882;4204.306289462204;4206.768627725443;4207.305794543866;4942.159832828428;4945;4945.826896058621;4946;4952.90094198114;6083.695815209222;6114.908276375858;6122.081687746784;6122.938770612237;6132.110843927606;1426.764583843675;1458.4603696632314;1466.8459811719615;1469.5077149154938;1469.772185311257;901.486152892858;929.4516235420999;949.5821838391224;952.6808519146025;971.5627967414691;5808.419158084158;5857.7949771757785;5864.941350586525;5867.413258674183;5874.060150375919;6252.531060170505;6259.78090766821;6263.31103578606;6264.968675156595;6278.591891527036;5854.7072646367515;5857.15071314657;5859.091840764689;5864.47219750216;5864.560157988168;3301.620313663959;3347.8660853565584;3359.9584128919623;3371.561696979377;3375.7130643895543;6394.520410969196;6459.160309159779;6533.869322613521;6537.967310163419;6543.44380727634;6346.365363463709;6372.58578192416;6378.043293505918;6379.617222966637;6379.96810015947;6513.023046542961;6516.674166291667;6521.6413097279155;6527.510436717265;6529.640869752209;6228.128062071404;6229.906551401642;6231.2522497300615;6238.937610623836;6240.438360547572;6053.818385448443;6113.1135985281;6171.074338849208;6178.196834411498;6181.752729890754;6519.934800651933;6573.079768832272;6573.5398522103;6574.76988305407;6582.473402127914;4184.163167366478;4223.683223758292;4227.66178705709;4230.217409779078;4239.491261048694;6293.465055470337;6319.747210111544;6320.336364681642;6326.43062124411;6328.936710632835;6136.662483563447;6141.017437210025;6141.263048434216;6145.35473775265;6148.047052706837;5989.341172471112;6095.634261944298;6103.481204097701;6144.38556144382;6161.476274516537;6008.969955150371;6036.094585812163;6043.969780151071;6052.334243233153;6052.425019623305;6168.660723660062;6180.721867515883;6196.845078873064;6219;6238;5840.503557197686;5890.587658864009;5950.19672344228;6005.219321488178;6021.307549631673 16:18:25 INFO - PROCESS | 25875 | |5;yui.html;703.5110598134296;752.0223709178067;760.1793704078732;810.7284059839953;818.1818181818186;13421.664458388545;13622.046456748032;13642.727145457085;13644.45422183114;13647.454101835914;12222;12348.567800126997;12448.688782780435;12579.874201257984;12580.182288151263;682.740558587736;809.5992483720566;828.1387357148558;838.8490071787106;851.4167795060373;830.7092517618845;838.6980686952692;839.6221700234888;839.9034111077243;840.5251033166242;880.9339299552527;890.2566357091804;891.9554022298859;892.1123482135284;895.7088946092514;724.6775185042658;872.668386013314;881.0616693221698;881.7575166829141;889.1597440418807;657.0177584511187;657.2244751193638;657.9111819904299;658.499540349338;658.7793089315037;13712.794308085387;13774.173549586956;13786.517471888435;13799.862001379957;13802.102863313852;12982.610521684364;13189.604311870658;13437.529686460926;13488.325583720873;13570;10731.570737170503;10735.248532602722;10779.5688172473;10873.401962892116;10922.563097476092;3754.530683664542;3797.639224273717;3815.5802861685193;3821.2357528494135;3828.062124779419;51179.232311514985;51220;51281.974360512955;51632.74183629058;51672.741636291576;10395.272330936761;10524.158067354594;10562.947185264178;10650.360978341168;10733.317049584035;17838.643227135643;17911.641767164583;17975.831570947845;18037.458876233733;18062.819371806112;7888.1323054463965;7931.841363172704;7981.920180798234;7987.400944929153;8212.17878212174;4090.9181816363507;4186.28833098374;4216.746995180299;4312.396264522969;4420.690551661417;2945.0428610701606;2985.1939976206304;2996.161074899032;3000.1749518882484;3006.6842981487066;520.625149892077;520.6485622204997;536.1609081786991;540.4838379347714;547.2393373211239;526.4787860018554;569.6126633888995;599.2210126835184;678.5521555773166;681.8510809286369;8676;8678.522681252593;8722;8729.563521824011;8814.559272036373;596.5108610938988;640.0303540136697;674;693.8161387232387;703.9225685174627;3828.617138286149;3939.842406303716;4003.7597744135446;4028.4762980812307;4085.264652362603;55964;57140.71429642908;57406.42593574095;57440;57551.424485755444;47560.048799023825;48119.75940120277;48167.27749083767;48224;48776.512234877904;43469;45200.54799452029;45867.77066114648;45924.540754592694;46012;7710.383169346551;7714.344280735976;7852.528848269122;7903.486273392211;7985.08171560278;33723.3255334887;33785;33797.83101084479;34658.826705867315;35151.82424087863;40053;42354.36468452914;43595.34606980834;43956.340654889565;43979.78010109929;10126.189904807745;10475.109615682448;10495.265331426726;10632.362058276529;10877.12982961377;11194;11430.885691142983;11456.656300311004;11564.13269004845;11570.247933884608;10035.09684128432;10329.675773412806;10378.844317335397;10399.636012739518;10741.946290268499;10408.219383546113;10628;10670.413127277763;10715.981981711724;10908.836367454653;10147.137493313152;10171.712158808932;10362.689119326433;10455;10571.320619643346;8800.779980500538;9301.627934882528;9454.857747730523;9523.428594284365;9530.285228608021;8202.41819146238;8255.793605159919;8578.323282675186;8765.474071555727;9108.635654573744 16:18:25 INFO - PROCESS | 25875 | __end_tp_report 16:18:25 INFO - PROCESS | 25875 | __start_cc_report 16:18:25 INFO - PROCESS | 25875 | _x_x_mozilla_cycle_collect,809 16:18:25 INFO - PROCESS | 25875 | __end_cc_report 16:18:25 INFO - PROCESS | 25875 | __startTimestamp1456532305490__endTimestamp 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | ------- Summary: start ------- 16:18:25 INFO - PROCESS | 25875 | Number of tests: 6 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#0] dojo.html Cycles:165 Average:5091.92 Median:5282.26 stddev:548.86 (10.4%) stddev-sans-first:527.60 16:18:25 INFO - PROCESS | 25875 | Values: 3090.3 3117.5 3159.7 3169.9 3193.1 4956.6 4965.0 4988.4 5072.7 5149.5 4998.7 5047.4 5125.2 5152.8 5157.4 4641.0 4644.8 4660.4 4683.9 4908.7 4666.0 4793.3 4822.0 4835.8 4898.7 4658.6 4722.2 4731.2 4739.9 4762.7 4616.5 4622.6 4645.3 4645.8 4660.7 4613.6 4622.5 4626.6 4723.6 4800.0 4895.6 4904.7 4925.7 4934.8 4945.4 5448.1 5458.1 5461.7 5462.3 5512.1 5361.0 5497.8 5568.0 5590.2 5665.5 5211.9 5255.3 5257.3 5261.3 5274.9 5656.6 5689.0 5702.9 5703.4 5708.5 5227.7 5325.7 5347.6 5409.2 5420.1 5459.1 5464.4 5466.2 5469.9 5472.0 5344.3 5437.5 5445.4 5451.2 5492.6 5528.5 5548.8 5560.1 5563.3 5621.5 4182.8 4219.4 4221.8 4226.1 4255.7 3731.2 3767.4 3827.3 3838.6 3861.9 5097.3 5114.8 5116.8 5160.4 5160.9 5376.7 5382.2 5386.9 5401.3 5433.7 5051.9 5123.5 5185.0 5200.2 5306.8 4644.1 4662.6 4667.4 4693.0 4701.6 5670.2 5680.3 5680.8 5693.3 5720.5 5397.4 5414.8 5460.4 5465.8 5500.7 5674.5 5681.3 5687.9 5689.5 5698.8 5386.8 5388.8 5391.6 5393.2 5398.0 5387.6 5408.6 5495.4 5530.4 5555.5 5296.1 5304.6 5307.8 5309.6 5314.7 5286.5 5291.5 5303.6 5305.2 5348.8 5210.9 5282.3 5304.2 5347.5 5373.0 5247.3 5322.9 5330.8 5331.0 5382.9 5106.1 5220.0 5223.5 5229.9 5237.7 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#1] ext.html Cycles:180 Average:45612.89 Median:37446.34 stddev:75615.14 (201.9%) stddev-sans-first:75751.43 16:18:25 INFO - PROCESS | 25875 | Values: 510.7 513.6 516.9 528.2 556.3 28500.3 37502.2 37637.2 37716.4 37807.1 39753.2 40024.8 40121.8 40256.8 40293.0 8496.2 8692.2 8698.4 8703.3 8740.9 8429.2 8539.1 8575.1 8575.1 8775.9 8766.5 8823.4 8846.7 8851.4 8852.1 8718.6 8776.3 8793.8 8796.6 8798.6 8652.2 8730.7 8758.8 8796.3 8799.7 40172.4 40595.0 40662.2 40699.6 40703.8 3330.0 3340.0 3383.5 3486.2 4043.8 28856.6 28931.4 29289.4 30342.5 30384.5 3380.6 3391.6 3445.0 3452.6 3471.1 265598.0 269191.7 272196.3 273067.0 273223.0 42626.6 64361.7 64453.0 65036.0 65071.0 43585.6 43902.3 43914.8 43969.6 43989.0 14776.1 14965.6 15032.9 15035.5 15046.9 11708.6 11994.8 12030.8 12033.8 12039.7 14791.3 14896.5 14897.6 14929.8 15021.7 5985.3 6100.7 6119.4 6165.2 6206.5 915.4 921.4 1005.0 1036.3 1046.9 28299.2 28312.7 28417.1 28697.0 28720.0 1041.8 1058.1 1123.3 1124.0 1191.3 14392.9 14810.9 14823.9 14861.2 15047.4 308414.0 310349.0 311828.0 312310.0 312522.0 52345.7 52972.7 53021.5 53045.5 53090.5 1169.8 1323.6 1331.5 1352.8 1356.4 25297.9 26747.9 26880.6 26885.0 26985.5 39101.2 49328.8 50228.0 50338.5 50348.0 279042.0 284903.1 286422.0 287018.0 288333.0 37335.4 43028.8 43097.4 43807.3 45448.3 40452.4 41011.6 41238.6 41262.8 41877.8 33213.3 33614.0 34812.7 37035.0 38227.4 37388.5 37390.4 37951.6 38044.2 38585.2 36890.4 37563.0 38304.8 38947.2 39348.4 28977.0 30757.8 30922.2 31086.4 33314.0 25583.6 25685.2 25709.1 25749.2 25970.1 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#2] jquery.html Cycles:180 Average:23939.34 Median:45822.16 stddev:66074.23 (144.2%) stddev-sans-first:66235.85 16:18:25 INFO - PROCESS | 25875 | Values: 354.9 356.7 359.4 362.0 365.3 14188.1 16893.0 17309.3 17324.3 18480.5 14561.0 14584.9 14916.7 15085.4 15448.2 5269.6 5312.2 5377.8 5400.8 5403.0 5208.6 5333.8 5407.4 5411.1 5420.8 5356.3 5359.7 5361.7 5369.4 5395.6 5353.0 5366.6 5462.8 5635.5 5636.1 4993.8 4995.7 4997.3 5019.7 5030.4 11537.3 13748.9 20156.5 20162.1 20212.5 2085.1 2223.4 2231.0 2378.5 2527.5 8632.0 8774.0 9037.3 9158.9 9231.8 1738.4 1859.7 1867.4 1870.8 1871.9 62170.0 62612.4 62964.4 64033.7 64663.4 9414.2 9480.2 9510.0 9615.7 9694.5 11869.3 12329.2 12365.3 12390.8 12408.4 7083.5 7256.4 7309.5 7328.9 7368.8 6923.4 6941.4 6975.8 7023.8 7062.1 4487.1 4493.5 4502.4 4523.1 4565.3 1614.6 1634.7 1723.1 1725.5 1738.1 889.6 900.4 920.0 960.6 978.5 16259.0 16627.7 16944.0 17157.6 17282.8 936.6 938.9 943.5 949.4 954.1 9163.1 9488.1 9500.3 9634.0 9737.4 391093.0 396228.0 401020.0 409750.0 410205.0 71968.0 75869.0 76298.6 77032.0 78129.0 951.1 954.6 967.8 968.5 982.7 13900.7 14538.5 14567.0 14649.7 15051.8 31690.0 32708.2 32789.8 32805.8 32988.2 41461.0 44851.8 45751.5 45892.8 46776.8 7421.9 7546.7 7653.8 7764.5 7780.5 9256.9 9685.6 11172.4 12174.3 12503.1 10296.6 10467.5 10513.3 10729.4 10756.4 10274.8 10332.6 10341.4 10651.5 10894.2 10232.0 10523.8 10744.9 10794.6 11007.9 7318.9 7342.0 7497.4 7575.2 7843.4 10039.7 10622.2 10866.9 10921.8 10951.7 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#3] mootools.html Cycles:180 Average:5206.90 Median:6129.80 stddev:2687.51 (43.8%) stddev-sans-first:2679.40 16:18:25 INFO - PROCESS | 25875 | Values: 1348.5 1403.4 1421.2 1550.0 1754.1 6885.4 7023.3 7031.1 7057.9 7082.6 7252.0 7415.1 7437.7 7437.8 7440.0 1910.1 2111.3 2112.7 2138.0 2172.4 2153.7 2187.2 2190.2 2191.3 2191.8 2129.4 2143.2 2146.8 2148.6 2149.8 2150.3 2173.6 2179.0 2185.8 2186.1 2130.2 2156.2 2171.9 2172.8 2175.8 7304.2 7345.7 7348.2 7349.3 7365.2 4425.2 4508.2 4540.4 4544.9 4545.5 2924.6 2962.4 2999.7 3007.7 3064.7 915.8 920.7 921.2 932.2 962.6 10001.8 10150.3 10191.8 10195.1 10200.5 4012.5 4065.3 4130.5 4138.1 4147.6 8737.0 8745.7 8758.2 8796.4 8835.7 4013.4 4552.9 4558.2 4574.6 4579.2 4005.2 4102.8 4109.9 4126.1 4131.9 3500.3 3569.7 3582.7 3594.2 3661.2 1147.1 1153.5 1158.1 1165.2 1166.0 1065.1 1078.1 1085.6 1228.0 1333.9 7023.9 7109.0 7112.1 7116.5 7137.0 1112.5 1127.6 1132.4 1140.5 1152.3 5476.9 5737.5 5738.6 5740.4 5745.1 8742.2 8870.5 8905.0 8967.1 8991.8 8972.9 9004.6 9024.2 9048.0 9113.7 7043.5 7079.2 7194.8 7201.9 7203.9 6893.5 6941.2 6952.7 6962.1 6967.6 8005.6 8086.8 8096.8 8231.0 8267.0 8221.8 8417.9 8440.3 8528.5 8532.8 5618.6 5719.7 5722.0 6264.4 6305.3 7000.2 7085.0 7146.0 7147.5 7177.0 6346.0 6409.3 6443.0 6500.4 6579.5 6273.9 6386.4 6437.0 6484.0 6518.5 6695.0 6734.9 6747.0 6812.5 6855.2 6086.7 6114.3 6123.8 6264.2 6304.2 6135.8 6152.3 6178.5 6201.2 6225.9 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#4] prototype.html Cycles:180 Average:5062.53 Median:5861.78 stddev:1565.73 (26.7%) stddev-sans-first:1528.56 16:18:25 INFO - PROCESS | 25875 | Values: 287.5 291.3 293.3 299.9 303.2 5755.1 5799.2 5812.9 5820.7 5835.6 5682.7 5693.0 5700.6 5712.2 5716.1 4186.1 4273.9 4372.9 4376.8 4390.1 4376.6 4385.1 4394.7 4398.2 4399.3 4354.3 4357.0 4359.6 4362.9 4368.5 4160.6 4254.4 4335.2 4335.7 4338.7 3731.5 3740.1 3751.4 3755.5 3755.9 5468.2 5473.8 5475.2 5476.6 5477.4 4996.0 4997.4 4998.1 4999.9 5001.1 6027.6 6033.4 6036.7 6042.8 6049.1 3902.9 4044.0 4145.1 4145.8 4150.0 6298.3 6312.9 6334.2 6334.9 6339.3 4152.5 4153.1 4153.7 4154.9 4156.6 4202.5 4203.1 4204.3 4206.8 4207.3 4942.2 4945.0 4945.8 4946.0 4952.9 6083.7 6114.9 6122.1 6122.9 6132.1 1426.8 1458.5 1466.8 1469.5 1469.8 901.5 929.5 949.6 952.7 971.6 5808.4 5857.8 5864.9 5867.4 5874.1 6252.5 6259.8 6263.3 6265.0 6278.6 5854.7 5857.2 5859.1 5864.5 5864.6 3301.6 3347.9 3360.0 3371.6 3375.7 6394.5 6459.2 6533.9 6538.0 6543.4 6346.4 6372.6 6378.0 6379.6 6380.0 6513.0 6516.7 6521.6 6527.5 6529.6 6228.1 6229.9 6231.3 6238.9 6240.4 6053.8 6113.1 6171.1 6178.2 6181.8 6519.9 6573.1 6573.5 6574.8 6582.5 4184.2 4223.7 4227.7 4230.2 4239.5 6293.5 6319.7 6320.3 6326.4 6328.9 6136.7 6141.0 6141.3 6145.4 6148.0 5989.3 6095.6 6103.5 6144.4 6161.5 6009.0 6036.1 6044.0 6052.3 6052.4 6168.7 6180.7 6196.8 6219.0 6238.0 5840.5 5890.6 5950.2 6005.2 6021.3 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | [#5] yui.html Cycles:180 Average:13580.47 Median:24810.62 stddev:15761.73 (63.5%) stddev-sans-first:15776.28 16:18:25 INFO - PROCESS | 25875 | Values: 703.5 752.0 760.2 810.7 818.2 13421.7 13622.0 13642.7 13644.5 13647.5 12222.0 12348.6 12448.7 12579.9 12580.2 682.7 809.6 828.1 838.8 851.4 830.7 838.7 839.6 839.9 840.5 880.9 890.3 892.0 892.1 895.7 724.7 872.7 881.1 881.8 889.2 657.0 657.2 657.9 658.5 658.8 13712.8 13774.2 13786.5 13799.9 13802.1 12982.6 13189.6 13437.5 13488.3 13570.0 10731.6 10735.2 10779.6 10873.4 10922.6 3754.5 3797.6 3815.6 3821.2 3828.1 51179.2 51220.0 51282.0 51632.7 51672.7 10395.3 10524.2 10562.9 10650.4 10733.3 17838.6 17911.6 17975.8 18037.5 18062.8 7888.1 7931.8 7981.9 7987.4 8212.2 4090.9 4186.3 4216.7 4312.4 4420.7 2945.0 2985.2 2996.2 3000.2 3006.7 520.6 520.6 536.2 540.5 547.2 526.5 569.6 599.2 678.6 681.9 8676.0 8678.5 8722.0 8729.6 8814.6 596.5 640.0 674.0 693.8 703.9 3828.6 3939.8 4003.8 4028.5 4085.3 55964.0 57140.7 57406.4 57440.0 57551.4 47560.0 48119.8 48167.3 48224.0 48776.5 43469.0 45200.5 45867.8 45924.5 46012.0 7710.4 7714.3 7852.5 7903.5 7985.1 33723.3 33785.0 33797.8 34658.8 35151.8 40053.0 42354.4 43595.3 43956.3 43979.8 10126.2 10475.1 10495.3 10632.4 10877.1 11194.0 11430.9 11456.7 11564.1 11570.2 10035.1 10329.7 10378.8 10399.6 10741.9 10408.2 10628.0 10670.4 10716.0 10908.8 10147.1 10171.7 10362.7 10455.0 10571.3 8800.8 9301.6 9454.9 9523.4 9530.3 8202.4 8255.8 8578.3 8765.5 9108.6 16:18:25 INFO - PROCESS | 25875 | -------- Summary: end -------- 16:18:25 INFO - PROCESS | 25875 | 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:25 INFO - PROCESS | 25875 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:26 INFO - TEST-INFO | 25875: exit 0 16:18:26 INFO - TEST-OK | dromaeo_css | took 1112865ms 16:18:26 INFO - TEST-START | kraken 16:18:26 INFO - operating with platform_type : linux_ 16:18:26 INFO - Initialising browser for kraken test... 16:18:26 INFO - TEST-INFO | started process 26063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGFBJbB/profile http://localhost:48307/getInfo.html) 16:18:30 INFO - PROCESS | 26063 | __metrics Screen width/height:1600/1200 16:18:30 INFO - PROCESS | 26063 | colorDepth:24 16:18:30 INFO - PROCESS | 26063 | Browser inner width/height: 1024/697 16:18:30 INFO - PROCESS | 26063 | __metrics 16:18:31 INFO - PROCESS | 26063 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:31 INFO - PROCESS | 26063 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:18:32 INFO - TEST-INFO | 26063: exit 0 16:18:32 INFO - Browser initialized. 16:18:32 INFO - Running cycle 1/1 for kraken test... 16:18:32 INFO - TEST-INFO | started process 26149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGFBJbB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:43 INFO - PROCESS | 26149 | RSS: Main: 150732800 16:18:43 INFO - PROCESS | 26149 | 16:18:46 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48307/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:46 INFO - PROCESS | 26149 | RSS: Main: 193748992 16:18:46 INFO - PROCESS | 26149 | 16:18:49 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48307/tests/kraken/driver.html?testName=audio-dft) 16:18:50 INFO - PROCESS | 26149 | RSS: Main: 184123392 16:18:50 INFO - PROCESS | 26149 | 16:18:53 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48307/tests/kraken/driver.html?testName=audio-fft) 16:18:53 INFO - PROCESS | 26149 | RSS: Main: 168206336 16:18:53 INFO - PROCESS | 26149 | 16:18:55 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48307/tests/kraken/driver.html?testName=audio-oscillator) 16:18:56 INFO - PROCESS | 26149 | RSS: Main: 170704896 16:18:56 INFO - PROCESS | 26149 | 16:18:58 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48307/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:59 INFO - PROCESS | 26149 | RSS: Main: 171937792 16:18:59 INFO - PROCESS | 26149 | 16:19:02 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48307/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:02 INFO - PROCESS | 26149 | RSS: Main: 173404160 16:19:02 INFO - PROCESS | 26149 | 16:19:06 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48307/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:06 INFO - PROCESS | 26149 | RSS: Main: 173678592 16:19:06 INFO - PROCESS | 26149 | 16:19:09 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48307/tests/kraken/driver.html?testName=json-parse-financial) 16:19:10 INFO - PROCESS | 26149 | RSS: Main: 172429312 16:19:10 INFO - PROCESS | 26149 | 16:19:11 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48307/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:12 INFO - PROCESS | 26149 | RSS: Main: 184049664 16:19:12 INFO - PROCESS | 26149 | 16:19:13 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:14 INFO - PROCESS | 26149 | RSS: Main: 181202944 16:19:14 INFO - PROCESS | 26149 | 16:19:16 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:17 INFO - PROCESS | 26149 | RSS: Main: 192860160 16:19:17 INFO - PROCESS | 26149 | 16:19:19 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:20 INFO - PROCESS | 26149 | RSS: Main: 196898816 16:19:20 INFO - PROCESS | 26149 | 16:19:22 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:23 INFO - PROCESS | 26149 | RSS: Main: 197193728 16:19:23 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:48307/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48307/tests/kraken/driver.html?testName=ai-astar) 16:19:25 INFO - PROCESS | 26149 | RSS: Main: 257150976 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | __start_tp_report 16:19:25 INFO - PROCESS | 26149 | _x_x_mozilla_page_load 16:19:25 INFO - PROCESS | 26149 | _x_x_mozilla_page_load_details 16:19:25 INFO - PROCESS | 26149 | |i|pagename|runs| 16:19:25 INFO - PROCESS | 26149 | |0;ai-astar;117;111;107;115;111;113;102;110;111;111 16:19:25 INFO - PROCESS | 26149 | |1;audio-beat-detection;160;126;153;163;128;154;160;130;175;128 16:19:25 INFO - PROCESS | 26149 | |2;audio-dft;160;161;164;162;162;162;160;162;162;161 16:19:25 INFO - PROCESS | 26149 | |3;audio-fft;73;74;97;106;77;73;74;128;101;73 16:19:25 INFO - PROCESS | 26149 | |4;audio-oscillator;96;96;144;96;96;95;138;95;95;140 16:19:25 INFO - PROCESS | 26149 | |5;imaging-gaussian-blur;119;115;114;114;114;114;114;115;114;115 16:19:25 INFO - PROCESS | 26149 | |6;imaging-darkroom;147;146;148;146;146;145;146;146;147;146 16:19:25 INFO - PROCESS | 26149 | |7;imaging-desaturate;96;97;96;96;96;97;95;96;96;96 16:19:25 INFO - PROCESS | 26149 | |8;json-parse-financial;56;57;56;55;58;56;56;64;54;55 16:19:25 INFO - PROCESS | 26149 | |9;json-stringify-tinderbox;69;68;69;69;68;68;68;67;68;68 16:19:25 INFO - PROCESS | 26149 | |10;stanford-crypto-aes;82;82;84;82;82;82;83;82;83;91 16:19:25 INFO - PROCESS | 26149 | |11;stanford-crypto-ccm;121;114;113;116;118;119;122;115;123;124 16:19:25 INFO - PROCESS | 26149 | |12;stanford-crypto-pbkdf2;154;143;152;157;147;140;154;151;151;148 16:19:25 INFO - PROCESS | 26149 | |13;stanford-crypto-sha256-iterative;68;68;70;68;71;69;69;68;67;67 16:19:25 INFO - PROCESS | 26149 | __end_tp_report 16:19:25 INFO - PROCESS | 26149 | __start_cc_report 16:19:25 INFO - PROCESS | 26149 | _x_x_mozilla_cycle_collect,1081 16:19:25 INFO - PROCESS | 26149 | __end_cc_report 16:19:25 INFO - PROCESS | 26149 | __startTimestamp1456532365335__endTimestamp 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | ------- Summary: start ------- 16:19:25 INFO - PROCESS | 26149 | Number of tests: 14 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:4.13 (3.7%) stddev-sans-first:3.72 16:19:25 INFO - PROCESS | 26149 | Values: 117.0 111.0 107.0 115.0 111.0 113.0 102.0 110.0 111.0 111.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#1] audio-beat-detection Cycles:10 Average:147.70 Median:157.00 stddev:17.98 (11.5%) stddev-sans-first:18.51 16:19:25 INFO - PROCESS | 26149 | Values: 160.0 126.0 153.0 163.0 128.0 154.0 160.0 130.0 175.0 128.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.09 16:19:25 INFO - PROCESS | 26149 | Values: 160.0 161.0 164.0 162.0 162.0 162.0 160.0 162.0 162.0 161.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#3] audio-fft Cycles:10 Average:87.60 Median:73.50 stddev:19.32 (26.3%) stddev-sans-first:19.76 16:19:25 INFO - PROCESS | 26149 | Values: 73.0 74.0 97.0 106.0 77.0 73.0 74.0 128.0 101.0 73.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:95.50 stddev:21.83 (22.9%) stddev-sans-first:22.64 16:19:25 INFO - PROCESS | 26149 | Values: 96.0 96.0 144.0 96.0 96.0 95.0 138.0 95.0 95.0 140.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:1.55 (1.4%) stddev-sans-first:0.50 16:19:25 INFO - PROCESS | 26149 | Values: 119.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 16:19:25 INFO - PROCESS | 26149 | Values: 147.0 146.0 148.0 146.0 146.0 145.0 146.0 146.0 147.0 146.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:19:25 INFO - PROCESS | 26149 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 96.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:2.79 (5.0%) stddev-sans-first:2.95 16:19:25 INFO - PROCESS | 26149 | Values: 56.0 57.0 56.0 55.0 58.0 56.0 56.0 64.0 54.0 55.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 16:19:25 INFO - PROCESS | 26149 | Values: 69.0 68.0 69.0 69.0 68.0 68.0 68.0 67.0 68.0 68.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:2.79 (3.4%) stddev-sans-first:2.92 16:19:25 INFO - PROCESS | 26149 | Values: 82.0 82.0 84.0 82.0 82.0 82.0 83.0 82.0 83.0 91.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:120.00 stddev:3.92 (3.3%) stddev-sans-first:4.06 16:19:25 INFO - PROCESS | 26149 | Values: 121.0 114.0 113.0 116.0 118.0 119.0 122.0 115.0 123.0 124.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.50 stddev:5.25 (3.5%) stddev-sans-first:5.33 16:19:25 INFO - PROCESS | 26149 | Values: 154.0 143.0 152.0 157.0 147.0 140.0 154.0 151.0 151.0 148.0 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.27 (1.9%) stddev-sans-first:1.33 16:19:25 INFO - PROCESS | 26149 | Values: 68.0 68.0 70.0 68.0 71.0 69.0 69.0 68.0 67.0 67.0 16:19:25 INFO - PROCESS | 26149 | -------- Summary: end -------- 16:19:25 INFO - PROCESS | 26149 | 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:25 INFO - PROCESS | 26149 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:26 INFO - TEST-INFO | 26149: exit 0 16:19:26 INFO - TEST-OK | kraken | took 60020ms 16:19:26 INFO - SUITE-END | took 1172s 16:19:26 INFO - Completed test suite (00:19:33) 16:19:26 INFO - Working with test: dromaeo_css 16:19:26 INFO - Generating results file: dromaeo_css 16:19:26 INFO - Working with test: kraken 16:19:26 INFO - Generating results file: kraken 16:19:26 INFO - javascript benchmark 16:19:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 16:19:26 INFO - process_Request line: dromaeo_css 6688.00 graph.html#tests=[[72,63,35]] 16:19:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:26 INFO - process_Request line: kraken 1518.90 graph.html#tests=[[232,63,35]] 16:19:26 INFO - RETURN: dromaeo_css: 6688.00 16:19:26 INFO - RETURN: kraken: 1518.90 16:19:26 INFO - javascript benchmark 16:19:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.2892334763005, 3117.5323701444768, 3159.69982851629, 3169.8890538831147, 3193.105930339505, 4956.5786908112805, 4964.999999999995, 4988.35151430314, 5072.695638261707, 5149.485051494858, 4998.7250701211415, 5047.4447810740885, 5125.154349532323, 5152.845414637567, 5157.355330583677, 4640.955784948394, 4644.837430689927, 4660.394148760656, 4683.882902927437, 4908.705477671351, 4665.9766701166445, 4793.32893394925, 4822.011487645024, 4835.806567737286, 4898.7060776353355, 4658.580727734503, 4722.220833562458, 4731.1720448921305, 4739.881502962419, 4762.714237145765, 4616.469106052779, 4622.583967442946, 4645.279981602857, 4645.7909394077005, 4660.720356778605, 4613.561711637422, 4622.514635963209, 4626.560476754703, 4723.645726570521, 4800.0, 4895.559399654013, 4904.6566740327835, 4925.655204135712, 4934.80260789568, 4945.406551213841, 5448.101063324547, 5458.099413596752, 5461.713676214776, 5462.317210348707, 5512.062949298589, 5361.0, 5497.8075767347955, 5567.9977604031255, 5590.18942253375, 5665.5467562594895, 5211.895762084737, 5255.316808814868, 5257.263983042377, 5261.263423120766, 5274.894502109936, 5656.604037717402, 5688.9715551422805, 5702.857428564236, 5703.429657034263, 5708.4862362387585, 5227.738613069331, 5325.653832500952, 5347.572194224453, 5409.215663728737, 5420.105682562333, 5459.099248624012, 5464.371597266286, 5466.1527463243265, 5469.945300546943, 5472.0, 5344.305240318734, 5437.483439073281, 5445.401005889349, 5451.209574611738, 5492.588055895744, 5528.474794894479, 5548.750306236229, 5560.138178582245, 5563.304586926634, 5621.49406553404, 4182.832686692498, 4219.367094935723, 4221.810018549173, 4226.112516371535, 4255.744655320691, 3731.235096805203, 3767.4348847672522, 3827.349350610403, 3838.5777564467885, 3861.884143475644, 5097.260897169964, 5114.769835357418, 5116.795328186905, 5160.432352441228, 5160.948390516121, 5376.650517716336, 5382.219578161144, 5386.892262154814, 5401.3248343957, 5433.701146436984, 5051.87370315745, 5123.513266239701, 5184.974075129676, 5200.193969934666, 5306.814261500829, 4644.0944015916575, 4662.6269898408045, 4667.439907211156, 4693.0, 4701.553352431513, 5670.177824215466, 5680.261565996394, 5680.801171958961, 5693.259876216065, 5720.513756330675, 5397.433269506802, 5414.810481633124, 5460.372057213472, 5465.754041068082, 5500.697461639648, 5674.460926212003, 5681.318241811009, 5687.943120568907, 5689.54483641316, 5698.800541981011, 5386.757595908115, 5388.811391601275, 5391.622586418913, 5393.191021346673, 5397.9730101350815, 5387.568994480511, 5408.648437851527, 5495.422980586981, 5530.446955304437, 5555.527780138734, 5296.073187192149, 5304.575633949352, 5307.840764777063, 5309.628326017296, 5314.681119132864, 5286.524212820865, 5291.523762861361, 5303.575713942798, 5305.151175811851, 5348.7593058311695, 5210.895782084262, 5282.260483532232, 5304.230886521355, 5347.51872331492, 5373.0, 5247.344081989751, 5322.946770532245, 5330.840074797762, 5331.0, 5382.865428364165, 5106.131957567297, 5220.008198442284, 5223.4515375884985, 5229.895402092013, 5237.685738855528], "unit": "score", "name": "dojo.html", "value": 5057.776988580524}, {"lowerIsBetter": false, "replicates": [510.7037918007556, 513.5557742552693, 516.886285017296, 528.2472476720673, 556.3407362275701, 28500.28749281269, 37502.249955000916, 37637.247255054914, 37716.43425348622, 37807.05482362942, 39753.20493590134, 40024.79987600065, 40121.799391003005, 40256.79871600645, 40293.0, 8496.1503849615, 8692.174243446863, 8698.39111262212, 8703.347248956323, 8740.8688869667, 8429.241368276855, 8539.06070332263, 8575.056743758181, 8575.056743758181, 8775.868361974575, 8766.517841518715, 8823.382363234576, 8846.690365837198, 8851.380403371766, 8852.070532594082, 8718.564071796385, 8776.297896168291, 8793.7801554961, 8796.648134074629, 8798.604062817156, 8652.178043085896, 8730.69442569507, 8758.781030474225, 8796.25231855293, 8799.692010779656, 40172.397414038816, 40595.0, 40662.18675626471, 40699.59300407017, 40703.79648101741, 3329.966700333014, 3339.9980005998104, 3383.543221665093, 3486.1981744198724, 4043.8382464701376, 28856.567151492745, 28931.421371572662, 29289.41421171586, 30342.54486182709, 30384.54423183654, 3380.628130905623, 3391.5590973173576, 3444.9655503444897, 3452.6202117767025, 3471.1322169457635, 265598.0, 269191.6540417305, 272196.30724002875, 273067.0, 273223.0, 42626.57373426288, 64361.67819160968, 64453.0, 65036.0, 65071.0, 43585.56414435879, 43902.34146487805, 43914.78042609766, 43969.560304396546, 43989.0, 14776.113433194043, 14965.625859353604, 15032.924835375754, 15035.473758418402, 15046.924765376103, 11708.648740537797, 11994.820077698841, 12030.81953770694, 12033.819492707617, 12039.699007524707, 14791.260436978324, 14896.478623248135, 14897.627559310888, 14929.776053359208, 15021.69956600862, 5985.34161242263, 6100.664463454464, 6119.418655227746, 6165.167702360124, 6206.534509911684, 915.3729695158837, 921.3918813583003, 1005.0, 1036.3367444835312, 1046.9214808889365, 28299.15102546927, 28312.71687283142, 28417.147485575464, 28697.0, 28720.0, 1041.7760181561, 1058.111186603257, 1123.3203911633507, 1123.9550417983353, 1191.2792760379846, 14392.85607143936, 14810.851891481163, 14823.925880370745, 14861.182634954965, 15047.398104075934, 308414.0, 310349.0, 311828.0, 312310.0, 312522.0, 52345.7382713084, 52972.735136324074, 53021.469785302426, 53045.469545304826, 53090.46909530855, 1169.7543515861594, 1323.6095351871222, 1331.4807225182187, 1352.7767918293569, 1356.4438580182275, 25297.87351063233, 26747.86626066935, 26880.59679104854, 26885.0, 26985.460290794468, 39101.21797563976, 49328.75335623299, 50227.99544009173, 50338.49661503338, 50348.0, 279042.0, 284903.05678602296, 286422.0, 287018.0, 288333.0, 37335.43996840104, 43028.78485607552, 43097.35353969756, 43807.34288985732, 45448.31827522524, 40452.3932141024, 41011.58988410197, 41238.58761412468, 41262.79368603138, 41877.79061104797, 33213.335733284715, 33614.0, 34812.65187348094, 37035.0, 38227.42658860064, 37388.4672389612, 37390.439143412324, 37951.62048379481, 38044.23911521809, 38585.22829543337, 36890.44664330091, 37563.0, 38304.80847595744, 38947.2210555793, 39348.40977385284, 28977.0, 30757.846210768803, 30922.158436285365, 31086.37827243488, 33314.0, 25583.6162457567, 25685.229443116736, 25709.13622664546, 25749.227523174333, 25970.09104681327], "unit": "score", "name": "ext.html", "value": 18033.604418028593}, {"lowerIsBetter": false, "replicates": [354.91659460026887, 356.71997481976655, 359.4087725691238, 361.97466177367596, 365.344207148169, 14188.07777494462, 16892.999999999985, 17309.307627694892, 17324.307027718874, 18480.537986550342, 14560.985201077188, 14584.927075364609, 14916.701665966673, 15085.360061989162, 15448.15035173065, 5269.578433725303, 5312.229726689628, 5377.78488860447, 5400.78396864125, 5403.0, 5208.583313334924, 5333.839984800462, 5407.3781515125875, 5411.107167317407, 5420.756065977041, 5356.330458692663, 5359.651622644536, 5361.651492652984, 5369.355677318707, 5395.59533035022, 5353.0, 5366.570674346043, 5462.754176062067, 5635.464630860103, 5636.126400407943, 4993.7503124843615, 4995.725235112068, 4997.325361076281, 5019.723915184663, 5030.396352437694, 11537.307761534335, 13748.862511374859, 20156.49608759778, 20162.092705828272, 20212.494687632927, 2085.0825636719796, 2223.3663405929233, 2231.0295021665465, 2378.5124049569795, 2527.481866217421, 8631.956840215758, 8774.0, 9037.277017838556, 9158.908410915872, 9231.769205769842, 1738.4089409600797, 1859.748933893934, 1867.4304337177155, 1870.803565625617, 1871.8876867388, 62169.99999999955, 62612.37387626157, 62964.370356296306, 64033.67983160101, 64663.4413021624, 9414.2468602513, 9480.24158067353, 9509.952450237704, 9615.711528654152, 9694.51527423626, 11869.287842729464, 12329.198602091015, 12365.258084514959, 12390.81413778794, 12408.441620127116, 7083.539569927938, 7256.4146804368065, 7309.5248808827255, 7328.890066649004, 7368.815779605553, 6923.446124310043, 6941.375276225164, 6975.79072627822, 7023.789286321418, 7062.117235345582, 4487.125010622897, 4493.483249426358, 4502.3921770560555, 4523.095380923828, 4565.269556870885, 1614.5802091456305, 1634.7302695055182, 1723.1039859273358, 1725.5427311762394, 1738.1135620833213, 889.564113584339, 900.4372267332917, 919.9632014719336, 960.558143254111, 978.500964508106, 16259.0, 16627.66744665124, 16944.0, 17157.57106072358, 17282.82717172837, 936.5598168860624, 938.8685584018243, 943.4575119306427, 949.3734135470694, 954.1365064616533, 9163.129502697233, 9488.098630630078, 9500.287478439144, 9633.951830240803, 9737.415755054719, 391093.0, 396228.0, 401020.0, 409750.0, 410205.0, 71968.0, 75869.0, 76298.61850690823, 77032.0, 78129.0, 951.1012093571646, 954.6086104697041, 967.849983252597, 968.5399435268191, 982.7101005203625, 13900.721985560434, 14538.491152809602, 14567.0, 14649.707005860037, 15051.774223386878, 31690.0, 32708.182295441853, 32789.83605081959, 32805.83597081999, 32988.1752956178, 41461.0, 44851.775741122394, 45751.542484574726, 45892.77053614844, 46776.7661161692, 7421.888671669822, 7546.735864244725, 7653.770386888402, 7764.495307804975, 7780.49426787257, 9256.861147082664, 9685.564149613143, 11172.385518796544, 12174.330411827434, 12503.06227032958, 10296.639617613348, 10467.528961196613, 10513.316634418738, 10729.409882456228, 10756.354618722902, 10274.845877311996, 10332.586696532055, 10341.37951722869, 10651.520681569504, 10894.182936279969, 10232.0, 10523.78952420932, 10744.946275268574, 10794.56821727122, 11007.889921100686, 7318.890216646861, 7341.963290183515, 7497.437692173218, 7575.166731659403, 7843.4117441191, 10039.749006274902, 10622.150227981898, 10866.945665271624, 10921.836172457579, 10951.726206844893], "unit": "score", "name": "jquery.html", "value": 8096.664351903376}, {"lowerIsBetter": false, "replicates": [1348.5414958913968, 1403.4035534897669, 1421.2325344314072, 1549.9845001549988, 1754.149237619754, 6885.4147397471215, 7023.262557431466, 7031.085958825352, 7057.858842823141, 7082.610456424907, 7252.0, 7415.147258065324, 7437.739679111232, 7437.814054648637, 7439.962800186005, 1910.1213441816712, 2111.313823007521, 2112.6936594193835, 2138.016512404296, 2172.391730315514, 2153.6984822124837, 2187.2344679362254, 2190.1786829938774, 2191.298784388996, 2191.8356123290737, 2129.4356995396233, 2143.164165975263, 2146.8067873891346, 2148.559545293211, 2149.849510534263, 2150.3441450357554, 2173.608750424923, 2178.9891050544807, 2185.7595664476894, 2186.1364760919428, 2130.2224687988773, 2156.2453141400383, 2171.880546569938, 2172.8153106985924, 2175.8041776240216, 7304.160021597531, 7345.669444874993, 7348.191698913115, 7349.265073492661, 7365.189829118793, 4425.159219748238, 4508.188526065307, 4540.409746732904, 4544.909101817978, 4545.454545454533, 2924.6344206974127, 2962.3630919352445, 2999.685033071518, 3007.6541197762317, 3064.724174824254, 915.7985243246475, 920.7329874336434, 921.2215677752289, 932.1610550504532, 962.5668449197819, 10001.849972250422, 10150.289479736495, 10191.847122293171, 10195.133413659847, 10200.48997550127, 4012.498437695288, 4065.2682517147196, 4130.524989626231, 4138.089620283533, 4147.564505726855, 8736.995245546716, 8745.693900713572, 8758.167974042455, 8796.384253102222, 8835.734927952171, 4013.4381186633896, 4552.908941821212, 4558.247889098328, 4574.565416285448, 4579.198640237945, 4005.1989602079702, 4102.794860256975, 4109.938350924738, 4126.133511962522, 4131.938020929689, 3500.2824420993634, 3569.7322700797026, 3582.695470885004, 3594.2452085062428, 3661.212839239576, 1147.1167201255155, 1153.5155234801402, 1158.102470585303, 1165.1727273635813, 1166.0147175636573, 1065.1159537583787, 1078.126717358926, 1085.592902661502, 1227.975440491203, 1333.9399727012308, 7023.89464158038, 7109.0, 7112.146542414944, 7116.466265030143, 7137.0, 1112.4993752811267, 1127.610974213895, 1132.3828513460185, 1140.4753813246, 1152.343164396286, 5476.918770867124, 5737.454941780524, 5738.598298119092, 5740.425957404226, 5745.1382292656435, 8742.21320081183, 8870.51212183336, 8905.020447750741, 8967.058458861857, 8991.775205619912, 8972.8654070189, 9004.639814407481, 9024.232940200025, 9048.009437923647, 9113.726588202364, 7043.506954513237, 7079.1858936223, 7194.820129496805, 7201.855962880818, 7203.89194162088, 6893.517453778388, 6941.167059952838, 6952.687129079305, 6962.1297337832775, 6967.581945083311, 8005.639746211551, 8086.838263234585, 8096.757097287091, 8230.958845205736, 8266.958665206635, 8221.79445513867, 8417.873731893904, 8440.282575981111, 8528.488290702579, 8532.786680333042, 5618.634788738719, 5719.656820590778, 5721.971390143022, 6264.373562643699, 6305.337939516285, 7000.194977577644, 7085.0, 7146.0, 7147.46394020461, 7176.96411517939, 6345.968270158804, 6409.2949775525585, 6442.967785161044, 6500.414962653384, 6579.4736421087155, 6273.874522509615, 6386.361363863576, 6437.0, 6483.967580162069, 6518.543701940818, 6694.966525167343, 6734.898976515454, 6747.0, 6812.455003599799, 6855.177378714586, 6086.72609732572, 6114.327423983447, 6123.755049797958, 6264.154339164154, 6304.243490781136, 6135.84660383494, 6152.323244443197, 6178.536609754196, 6201.1628430163155, 6225.937740622536], "unit": "score", "name": "mootools.html", "value": 4291.7689679433615}, {"lowerIsBetter": false, "replicates": [287.5155363212986, 291.25293621859936, 293.25220687247526, 299.94301082794254, 303.1662926950885, 5755.0504166812425, 5799.246098007258, 5812.912806307903, 5820.708964551766, 5835.5915085944, 5682.659040457565, 5693.0, 5700.600957932947, 5712.200291959129, 5716.14257861321, 4186.141840922619, 4273.850415235467, 4372.890677733066, 4376.759278239696, 4390.100029493946, 4376.627986621141, 4385.10105428388, 4394.670399720034, 4398.208322501949, 4399.27411977025, 4354.346847972798, 4356.97821510892, 4359.585839345273, 4362.8691139265875, 4368.5194628590825, 4160.604742549468, 4254.4043833863125, 4335.154644844257, 4335.653147748172, 4338.652907767371, 3731.4589384539363, 3740.139767853409, 3751.362268414376, 3755.455458958436, 3755.924881502382, 5468.152436372368, 5473.75368108436, 5475.178723191513, 5476.58925580579, 5477.370102438231, 4995.975020124913, 4997.375328083989, 4998.050370429607, 4999.875003124915, 5001.124803159432, 6027.578069535134, 6033.3664965178905, 6036.698165091771, 6042.848928776772, 6049.122877182828, 3902.863399780994, 4044.0496483326397, 4145.108801607669, 4145.7927103645, 4149.958500415018, 6298.275698294663, 6312.905306420407, 6334.239891213084, 6334.904976425358, 6339.270983836872, 4152.460180176618, 4153.1486045360625, 4153.6677065834665, 4154.937675934863, 4156.584341565819, 4202.537720850704, 4203.138356636882, 4204.306289462204, 4206.768627725443, 4207.305794543866, 4942.159832828428, 4945.0, 4945.826896058621, 4946.0, 4952.90094198114, 6083.695815209222, 6114.908276375858, 6122.081687746784, 6122.938770612237, 6132.110843927606, 1426.764583843675, 1458.4603696632314, 1466.8459811719615, 1469.5077149154938, 1469.772185311257, 901.486152892858, 929.4516235420999, 949.5821838391224, 952.6808519146025, 971.5627967414691, 5808.419158084158, 5857.7949771757785, 5864.941350586525, 5867.413258674183, 5874.060150375919, 6252.531060170505, 6259.78090766821, 6263.31103578606, 6264.968675156595, 6278.591891527036, 5854.7072646367515, 5857.15071314657, 5859.091840764689, 5864.47219750216, 5864.560157988168, 3301.620313663959, 3347.8660853565584, 3359.9584128919623, 3371.561696979377, 3375.7130643895543, 6394.520410969196, 6459.160309159779, 6533.869322613521, 6537.967310163419, 6543.44380727634, 6346.365363463709, 6372.58578192416, 6378.043293505918, 6379.617222966637, 6379.96810015947, 6513.023046542961, 6516.674166291667, 6521.6413097279155, 6527.510436717265, 6529.640869752209, 6228.128062071404, 6229.906551401642, 6231.2522497300615, 6238.937610623836, 6240.438360547572, 6053.818385448443, 6113.1135985281, 6171.074338849208, 6178.196834411498, 6181.752729890754, 6519.934800651933, 6573.079768832272, 6573.5398522103, 6574.76988305407, 6582.473402127914, 4184.163167366478, 4223.683223758292, 4227.66178705709, 4230.217409779078, 4239.491261048694, 6293.465055470337, 6319.747210111544, 6320.336364681642, 6326.43062124411, 6328.936710632835, 6136.662483563447, 6141.017437210025, 6141.263048434216, 6145.35473775265, 6148.047052706837, 5989.341172471112, 6095.634261944298, 6103.481204097701, 6144.38556144382, 6161.476274516537, 6008.969955150371, 6036.094585812163, 6043.969780151071, 6052.334243233153, 6052.425019623305, 6168.660723660062, 6180.721867515883, 6196.845078873064, 6219.0, 6238.0, 5840.503557197686, 5890.587658864009, 5950.19672344228, 6005.219321488178, 6021.307549631673], "unit": "score", "name": "prototype.html", "value": 4535.795993057095}, {"lowerIsBetter": false, "replicates": [703.5110598134296, 752.0223709178067, 760.1793704078732, 810.7284059839953, 818.1818181818186, 13421.664458388545, 13622.046456748032, 13642.727145457085, 13644.45422183114, 13647.454101835914, 12222.0, 12348.567800126997, 12448.688782780435, 12579.874201257984, 12580.182288151263, 682.740558587736, 809.5992483720566, 828.1387357148558, 838.8490071787106, 851.4167795060373, 830.7092517618845, 838.6980686952692, 839.6221700234888, 839.9034111077243, 840.5251033166242, 880.9339299552527, 890.2566357091804, 891.9554022298859, 892.1123482135284, 895.7088946092514, 724.6775185042658, 872.668386013314, 881.0616693221698, 881.7575166829141, 889.1597440418807, 657.0177584511187, 657.2244751193638, 657.9111819904299, 658.499540349338, 658.7793089315037, 13712.794308085387, 13774.173549586956, 13786.517471888435, 13799.862001379957, 13802.102863313852, 12982.610521684364, 13189.604311870658, 13437.529686460926, 13488.325583720873, 13570.0, 10731.570737170503, 10735.248532602722, 10779.5688172473, 10873.401962892116, 10922.563097476092, 3754.530683664542, 3797.639224273717, 3815.5802861685193, 3821.2357528494135, 3828.062124779419, 51179.232311514985, 51220.0, 51281.974360512955, 51632.74183629058, 51672.741636291576, 10395.272330936761, 10524.158067354594, 10562.947185264178, 10650.360978341168, 10733.317049584035, 17838.643227135643, 17911.641767164583, 17975.831570947845, 18037.458876233733, 18062.819371806112, 7888.1323054463965, 7931.841363172704, 7981.920180798234, 7987.400944929153, 8212.17878212174, 4090.9181816363507, 4186.28833098374, 4216.746995180299, 4312.396264522969, 4420.690551661417, 2945.0428610701606, 2985.1939976206304, 2996.161074899032, 3000.1749518882484, 3006.6842981487066, 520.625149892077, 520.6485622204997, 536.1609081786991, 540.4838379347714, 547.2393373211239, 526.4787860018554, 569.6126633888995, 599.2210126835184, 678.5521555773166, 681.8510809286369, 8676.0, 8678.522681252593, 8722.0, 8729.563521824011, 8814.559272036373, 596.5108610938988, 640.0303540136697, 674.0, 693.8161387232387, 703.9225685174627, 3828.617138286149, 3939.842406303716, 4003.7597744135446, 4028.4762980812307, 4085.264652362603, 55964.0, 57140.71429642908, 57406.42593574095, 57440.0, 57551.424485755444, 47560.048799023825, 48119.75940120277, 48167.27749083767, 48224.0, 48776.512234877904, 43469.0, 45200.54799452029, 45867.77066114648, 45924.540754592694, 46012.0, 7710.383169346551, 7714.344280735976, 7852.528848269122, 7903.486273392211, 7985.08171560278, 33723.3255334887, 33785.0, 33797.83101084479, 34658.826705867315, 35151.82424087863, 40053.0, 42354.36468452914, 43595.34606980834, 43956.340654889565, 43979.78010109929, 10126.189904807745, 10475.109615682448, 10495.265331426726, 10632.362058276529, 10877.12982961377, 11194.0, 11430.885691142983, 11456.656300311004, 11564.13269004845, 11570.247933884608, 10035.09684128432, 10329.675773412806, 10378.844317335397, 10399.636012739518, 10741.946290268499, 10408.219383546113, 10628.0, 10670.413127277763, 10715.981981711724, 10908.836367454653, 10147.137493313152, 10171.712158808932, 10362.689119326433, 10455.0, 10571.320619643346, 8800.779980500538, 9301.627934882528, 9454.857747730523, 9523.428594284365, 9530.285228608021, 8202.41819146238, 8255.793605159919, 8578.323282675186, 8765.474071555727, 9108.635654573744], "unit": "score", "name": "yui.html", "value": 6224.436187107669}], "name": "dromaeo_css", "value": 6688.003344833202}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 111.0, 107.0, 115.0, 111.0, 113.0, 102.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [160.0, 126.0, 153.0, 163.0, 128.0, 154.0, 160.0, 130.0, 175.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 164.0, 162.0, 162.0, 162.0, 160.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 97.0, 106.0, 77.0, 73.0, 74.0, 128.0, 101.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 96.0, 96.0, 95.0, 138.0, 95.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 114.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 55.0, 58.0, 56.0, 56.0, 64.0, 54.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 84.0, 82.0, 82.0, 82.0, 83.0, 82.0, 83.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [121.0, 114.0, 113.0, 116.0, 118.0, 119.0, 122.0, 115.0, 123.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [154.0, 143.0, 152.0, 157.0, 147.0, 140.0, 154.0, 151.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 68.0, 71.0, 69.0, 69.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1518.9}]} 16:19:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1518.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6688.00"}}} 16:19:26 INFO - Return code: 0 16:19:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:26 INFO - # TBPL SUCCESS # 16:19:26 INFO - Running post-action listener: _resource_record_post_action 16:19:26 INFO - Running post-run listener: _resource_record_post_run 16:19:27 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 545595392; Read time: 0; Write time: 538664 16:19:27 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 233345024; Read time: 0; Write time: 307808 16:19:27 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292769792; Read time: 0; Write time: 225900 16:19:27 INFO - Running post-run listener: _upload_blobber_files 16:19:27 INFO - Blob upload gear active. 16:19:27 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:19:27 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 16:19:27 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'] 16:19:27 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 16:19:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:29 INFO - (blobuploader) - INFO - Done attempting. 16:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:29 INFO - (blobuploader) - INFO - Done attempting. 16:19:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:29 INFO - Return code: 0 16:19:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:19:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bef390b29317076643a98f7d21ab98c0b434f3ea530deadb29433337ae3568bc2ae46f7318c1d1f66c74c570ba4b8b0277c4b3d4ee8d5561e41f4a27167a811a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/274bd7e8375bf2e42fb53cfe7f0509b1702414f47d86bd16f2e7d534b4b2801bf5146bac10d0ff2525b6e3eb5efa8ba961fd970c5d07a1a0de915254914ddea2"} 16:19:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:19:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:19:29 INFO - Contents: 16:19:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bef390b29317076643a98f7d21ab98c0b434f3ea530deadb29433337ae3568bc2ae46f7318c1d1f66c74c570ba4b8b0277c4b3d4ee8d5561e41f4a27167a811a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/274bd7e8375bf2e42fb53cfe7f0509b1702414f47d86bd16f2e7d534b4b2801bf5146bac10d0ff2525b6e3eb5efa8ba961fd970c5d07a1a0de915254914ddea2"} 16:19:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:29 INFO - Copying logs to upload dir... 16:19:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:19:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.408121 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-26 16:19:29.584754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:29.588056) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 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/bef390b29317076643a98f7d21ab98c0b434f3ea530deadb29433337ae3568bc2ae46f7318c1d1f66c74c570ba4b8b0277c4b3d4ee8d5561e41f4a27167a811a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/274bd7e8375bf2e42fb53cfe7f0509b1702414f47d86bd16f2e7d534b4b2801bf5146bac10d0ff2525b6e3eb5efa8ba961fd970c5d07a1a0de915254914ddea2"} build_url:https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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/bef390b29317076643a98f7d21ab98c0b434f3ea530deadb29433337ae3568bc2ae46f7318c1d1f66c74c570ba4b8b0277c4b3d4ee8d5561e41f4a27167a811a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/274bd7e8375bf2e42fb53cfe7f0509b1702414f47d86bd16f2e7d534b4b2801bf5146bac10d0ff2525b6e3eb5efa8ba961fd970c5d07a1a0de915254914ddea2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:29.615617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:29.615969) ========= 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=7de08804244eb36560b44971000001c3-1456529635.592504-1876714100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:29.702612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:19:29.703354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:19:29.704020) ========= ========= Total master_lag: 0.35 =========