builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1456757971.26 results: success (0) buildid: 20160229043018 builduid: a016f65ab75a4546aa69586598a0e51e revision: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.262681) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.263106) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.263399) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003748 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.278737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.278999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.297741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.297993) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.346906) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.347160) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.347484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.347779) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 06:59:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-02-29 06:59:31 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.525131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.525438) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.574822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:31.575147) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9da51cb4974e03cdd8fa45a34086fe1033abfeaf --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9da51cb4974e03cdd8fa45a34086fe1033abfeaf --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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 06:59:32,059 truncating revision to first 12 chars 2016-02-29 06:59:32,059 Setting DEBUG logging. 2016-02-29 06:59:32,059 attempt 1/10 2016-02-29 06:59:32,059 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9da51cb4974e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 06:59:32,329 unpacking tar archive at: mozilla-central-9da51cb4974e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.593333 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:32.182883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:32.183171) ========= echo 9da51cb4974e03cdd8fa45a34086fe1033abfeaf in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9da51cb4974e03cdd8fa45a34086fe1033abfeaf'] 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9da51cb4974e03cdd8fa45a34086fe1033abfeaf program finished with exit code 0 elapsedTime=0.004683 script_repo_revision: '9da51cb4974e03cdd8fa45a34086fe1033abfeaf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:32.233573) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:32.233852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 06:59:32.243291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-29 06:59:32.243554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:32 INFO - MultiFileLogger online at 20160229 06:59:32 in /builds/slave/test-pgo 06:59:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:59:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:59:32 INFO - {'append_to_log': False, 06:59:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:59:32 INFO - 'blob_upload_branch': 'Firefox', 06:59:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:59:32 INFO - 'branch': 'Firefox', 06:59:32 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:32 INFO - 'config_files': ('talos/linux_config.py',), 06:59:32 INFO - 'default_actions': ('clobber', 06:59:32 INFO - 'read-buildbot-config', 06:59:32 INFO - 'download-and-extract', 06:59:32 INFO - 'populate-webroot', 06:59:32 INFO - 'create-virtualenv', 06:59:32 INFO - 'install', 06:59:32 INFO - 'run-tests'), 06:59:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:32 INFO - 'download_minidump_stackwalk': True, 06:59:32 INFO - 'download_symbols': 'ondemand', 06:59:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:32 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:32 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:32 INFO - 'installer_path': 'installer.exe', 06:59:32 INFO - 'log_level': 'info', 06:59:32 INFO - 'log_name': 'talos', 06:59:32 INFO - 'log_to_console': True, 06:59:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:32 INFO - 'opt_config_files': (), 06:59:32 INFO - 'pip_index': False, 06:59:32 INFO - 'sps_profile': False, 06:59:32 INFO - 'sps_profile_interval': 0, 06:59:32 INFO - 'suite': 'dromaeojs', 06:59:32 INFO - 'system_bits': '32', 06:59:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:32 INFO - 'title': 'talos-linux64-ix-036', 06:59:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:32 INFO - 'use_talos_json': True, 06:59:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:59:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:32 INFO - 'work_dir': 'build'} 06:59:32 INFO - ##### 06:59:32 INFO - ##### Running clobber step. 06:59:32 INFO - ##### 06:59:32 INFO - Running pre-action listener: _resource_record_pre_action 06:59:32 INFO - Running main action method: clobber 06:59:32 INFO - rmtree: /builds/slave/test-pgo/build 06:59:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:59:33 INFO - Running post-action listener: _resource_record_post_action 06:59:33 INFO - ##### 06:59:33 INFO - ##### Running read-buildbot-config step. 06:59:33 INFO - ##### 06:59:33 INFO - Running pre-action listener: _resource_record_pre_action 06:59:33 INFO - Running main action method: read_buildbot_config 06:59:33 INFO - Using buildbot properties: 06:59:33 INFO - { 06:59:33 INFO - "project": "", 06:59:33 INFO - "product": "firefox", 06:59:33 INFO - "script_repo_revision": "production", 06:59:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:59:33 INFO - "repository": "", 06:59:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:59:33 INFO - "buildid": "20160229043018", 06:59:33 INFO - "pgo_build": "True", 06:59:33 INFO - "basedir": "/builds/slave/test-pgo", 06:59:33 INFO - "buildnumber": 208, 06:59:33 INFO - "slavename": "talos-linux64-ix-036", 06:59:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:59:33 INFO - "platform": "ubuntu64_hw", 06:59:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:59:33 INFO - "branch": "mozilla-central", 06:59:33 INFO - "repo_path": "mozilla-central", 06:59:33 INFO - "revision": "9da51cb4974e03cdd8fa45a34086fe1033abfeaf", 06:59:33 INFO - "stage_platform": "linux64-pgo", 06:59:33 INFO - "builduid": "a016f65ab75a4546aa69586598a0e51e", 06:59:33 INFO - "slavebuilddir": "test" 06:59:33 INFO - } 06:59:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:59:33 INFO - Running post-action listener: _resource_record_post_action 06:59:33 INFO - ##### 06:59:33 INFO - ##### Running download-and-extract step. 06:59:33 INFO - ##### 06:59:33 INFO - Running pre-action listener: _resource_record_pre_action 06:59:33 INFO - Running main action method: download_and_extract 06:59:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:33 INFO - https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/test_packages.json 06:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/test_packages.json 06:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:59:35 INFO - Downloaded 1448 bytes. 06:59:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:59:35 INFO - Using the following test package requirements: 06:59:35 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:35 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:35 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:59:35 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'jsshell-linux-x86_64.zip'], 06:59:35 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:35 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:35 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:35 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:35 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:35 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:35 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:35 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:35 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:35 INFO - https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:38 INFO - Downloaded 23372199 bytes. 06:59:38 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'] 06:59:38 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 06:59:39 INFO - Return code: 0 06:59:39 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 06:59:39 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')]} 06:59:39 INFO - https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:40 INFO - Downloaded 23372199 bytes. 06:59:40 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'] 06:59:40 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 06:59:42 INFO - Return code: 0 06:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:42 INFO - https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:43 INFO - Downloaded 10713410 bytes. 06:59:43 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'] 06:59:43 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 06:59:43 INFO - Return code: 0 06:59:43 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')]} 06:59:43 INFO - https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/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 06:59:44 INFO - Downloaded 56638391 bytes. 06:59:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:59:44 INFO - mkdir: /builds/slave/test-pgo/properties 06:59:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:59:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:59:44 INFO - Contents: 06:59:44 INFO - build_url:https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:59:45 INFO - Running post-action listener: _resource_record_post_action 06:59:45 INFO - Running post-action listener: set_extra_try_arguments 06:59:45 INFO - ##### 06:59:45 INFO - ##### Running populate-webroot step. 06:59:45 INFO - ##### 06:59:45 INFO - Running pre-action listener: _resource_record_pre_action 06:59:45 INFO - Running main action method: populate_webroot 06:59:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:45 INFO - '--tppagecycles', 06:59:45 INFO - '7'], 06:59:45 INFO - 'tests': ['tsvgm']}}, 06:59:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:59:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:59:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'tests': ['damp', 'tps']}, 06:59:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['damp', 'tps']}, 06:59:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:59:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:45 INFO - 'other': {'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'other_l64': {'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'other_nol64': {'tests': ['a11yr', 06:59:45 INFO - 'ts_paint', 06:59:45 INFO - 'tpaint', 06:59:45 INFO - 'sessionrestore', 06:59:45 INFO - 'sessionrestore_no_auto_restore']}, 06:59:45 INFO - 'svgr': {'tests': ['tsvgx', 06:59:45 INFO - 'tsvgr_opacity', 06:59:45 INFO - 'tart', 06:59:45 INFO - 'tscrollx', 06:59:45 INFO - 'cart']}, 06:59:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['tsvgx', 06:59:45 INFO - 'tsvgr_opacity', 06:59:45 INFO - 'tart', 06:59:45 INFO - 'tscrollx', 06:59:45 INFO - 'cart']}, 06:59:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'tests': ['tp5o']}, 06:59:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'talos_options': ['--e10s'], 06:59:45 INFO - 'tests': ['tp5o']}, 06:59:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'talos_options': ['--xperf_path', 06:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:45 INFO - 'tests': ['tp5n']}, 06:59:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:45 INFO - 'talos_options': ['--e10s', 06:59:45 INFO - '--xperf_path', 06:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:45 INFO - 'tests': ['tp5n']}}, 06:59:45 INFO - 'talos.zip': {'path': '', 06:59:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:45 INFO - Running post-action listener: _resource_record_post_action 06:59:45 INFO - ##### 06:59:45 INFO - ##### Running create-virtualenv step. 06:59:45 INFO - ##### 06:59:45 INFO - Running pre-action listener: _resource_record_pre_action 06:59:45 INFO - Running main action method: create_virtualenv 06:59:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:59:45 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 06:59:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:45 INFO - Using real prefix '/usr' 06:59:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:59:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:48 INFO - Installing pip.................done. 06:59:48 INFO - Return code: 0 06:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:59:48 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')]} 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:48 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')]} 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:48 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:48 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 06:59:48 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 06:59:48 INFO - Using env: {'DISPLAY': ':0', 06:59:48 INFO - 'HOME': '/home/cltbld', 06:59:48 INFO - 'LANG': 'en_US.UTF-8', 06:59:48 INFO - 'LANGUAGE': 'en_US:en', 06:59:48 INFO - 'LOGNAME': 'cltbld', 06:59:48 INFO - 'MAIL': '/var/mail/cltbld', 06:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:48 INFO - 'MOZ_NO_REMOTE': '1', 06:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:48 INFO - 'NO_EM_RESTART': '1', 06:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:48 INFO - 'SHELL': '/bin/bash', 06:59:48 INFO - 'SHLVL': '1', 06:59:48 INFO - 'TERM': 'linux', 06:59:48 INFO - 'TMOUT': '86400', 06:59:48 INFO - 'USER': 'cltbld', 06:59:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:48 INFO - '_': '/tools/buildbot/bin/python'} 06:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:48 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 06:59:48 INFO - Cleaning up... 06:59:48 INFO - Return code: 0 06:59:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:59:48 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')]} 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:48 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')]} 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:48 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:48 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 06:59:48 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 06:59:48 INFO - Using env: {'DISPLAY': ':0', 06:59:48 INFO - 'HOME': '/home/cltbld', 06:59:48 INFO - 'LANG': 'en_US.UTF-8', 06:59:48 INFO - 'LANGUAGE': 'en_US:en', 06:59:48 INFO - 'LOGNAME': 'cltbld', 06:59:48 INFO - 'MAIL': '/var/mail/cltbld', 06:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:48 INFO - 'MOZ_NO_REMOTE': '1', 06:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:48 INFO - 'NO_EM_RESTART': '1', 06:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:48 INFO - 'SHELL': '/bin/bash', 06:59:48 INFO - 'SHLVL': '1', 06:59:48 INFO - 'TERM': 'linux', 06:59:48 INFO - 'TMOUT': '86400', 06:59:48 INFO - 'USER': 'cltbld', 06:59:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:48 INFO - '_': '/tools/buildbot/bin/python'} 06:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:48 INFO - Downloading/unpacking psutil>=0.7.1 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:50 INFO - Installing collected packages: psutil 06:59:50 INFO - Running setup.py install for psutil 06:59:50 INFO - building 'psutil._psutil_linux' extension 06:59:50 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 06:59:50 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 06:59:50 INFO - building 'psutil._psutil_posix' extension 06:59:50 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 06:59:50 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 06:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:51 INFO - Successfully installed psutil 06:59:51 INFO - Cleaning up... 06:59:51 INFO - Return code: 0 06:59:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:51 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 06:59:51 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 06:59:51 INFO - Using env: {'DISPLAY': ':0', 06:59:51 INFO - 'HOME': '/home/cltbld', 06:59:51 INFO - 'LANG': 'en_US.UTF-8', 06:59:51 INFO - 'LANGUAGE': 'en_US:en', 06:59:51 INFO - 'LOGNAME': 'cltbld', 06:59:51 INFO - 'MAIL': '/var/mail/cltbld', 06:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:51 INFO - 'MOZ_NO_REMOTE': '1', 06:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:51 INFO - 'NO_EM_RESTART': '1', 06:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:51 INFO - 'SHELL': '/bin/bash', 06:59:51 INFO - 'SHLVL': '1', 06:59:51 INFO - 'TERM': 'linux', 06:59:51 INFO - 'TMOUT': '86400', 06:59:51 INFO - 'USER': 'cltbld', 06:59:51 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:51 INFO - '_': '/tools/buildbot/bin/python'} 06:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:59:51 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 06:59:51 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 06:59:51 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 06:59:51 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 06:59:51 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 06:59:51 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 06:59:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:59:53 INFO - Installing collected packages: mozsystemmonitor 06:59:53 INFO - Running setup.py install for mozsystemmonitor 06:59:53 INFO - Successfully installed mozsystemmonitor 06:59:53 INFO - Cleaning up... 06:59:53 INFO - Return code: 0 06:59:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:59:53 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')]} 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 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')]} 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:53 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:53 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 06:59:53 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 06:59:53 INFO - Using env: {'DISPLAY': ':0', 06:59:53 INFO - 'HOME': '/home/cltbld', 06:59:53 INFO - 'LANG': 'en_US.UTF-8', 06:59:53 INFO - 'LANGUAGE': 'en_US:en', 06:59:53 INFO - 'LOGNAME': 'cltbld', 06:59:53 INFO - 'MAIL': '/var/mail/cltbld', 06:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:53 INFO - 'MOZ_NO_REMOTE': '1', 06:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:53 INFO - 'NO_EM_RESTART': '1', 06:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:53 INFO - 'SHELL': '/bin/bash', 06:59:53 INFO - 'SHLVL': '1', 06:59:53 INFO - 'TERM': 'linux', 06:59:53 INFO - 'TMOUT': '86400', 06:59:53 INFO - 'USER': 'cltbld', 06:59:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:53 INFO - '_': '/tools/buildbot/bin/python'} 06:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:53 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 06:59:53 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 06:59:53 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 06:59:53 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 06:59:53 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 06:59:53 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 06:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:59:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:55 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 06:59:56 INFO - Downloading docopt-0.6.1.tar.gz 06:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:56 INFO - Running setup.py install for blobuploader 06:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:59:56 INFO - Running setup.py install for requests 06:59:56 INFO - Running setup.py install for docopt 06:59:56 INFO - Successfully installed blobuploader requests docopt 06:59:56 INFO - Cleaning up... 06:59:56 INFO - Return code: 0 06:59:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:56 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 06:59:56 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 06:59:56 INFO - Using env: {'DISPLAY': ':0', 06:59:56 INFO - 'HOME': '/home/cltbld', 06:59:56 INFO - 'LANG': 'en_US.UTF-8', 06:59:56 INFO - 'LANGUAGE': 'en_US:en', 06:59:56 INFO - 'LOGNAME': 'cltbld', 06:59:56 INFO - 'MAIL': '/var/mail/cltbld', 06:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:56 INFO - 'MOZ_NO_REMOTE': '1', 06:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:56 INFO - 'NO_EM_RESTART': '1', 06:59:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:56 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:56 INFO - 'SHELL': '/bin/bash', 06:59:56 INFO - 'SHLVL': '1', 06:59:56 INFO - 'TERM': 'linux', 06:59:56 INFO - 'TMOUT': '86400', 06:59:56 INFO - 'USER': 'cltbld', 06:59:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:56 INFO - '_': '/tools/buildbot/bin/python'} 06:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:59:56 INFO - Running setup.py (path:/tmp/pip-M8fqBs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:59:57 INFO - Running setup.py (path:/tmp/pip-cm5Nor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:59:57 INFO - Running setup.py (path:/tmp/pip-japBH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:59:57 INFO - Running setup.py (path:/tmp/pip-rKMBVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:59:57 INFO - Running setup.py (path:/tmp/pip-ToVdhv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:59:57 INFO - Running setup.py (path:/tmp/pip-f6_w1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:59:57 INFO - Running setup.py (path:/tmp/pip-alsD2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:59:57 INFO - Running setup.py (path:/tmp/pip-Oh1Vr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:59:57 INFO - Running setup.py (path:/tmp/pip-MOcyg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:59:57 INFO - Running setup.py (path:/tmp/pip-Rueavy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:59:57 INFO - Running setup.py (path:/tmp/pip-AGzrHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:59:57 INFO - Running setup.py (path:/tmp/pip-vP4Lzr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:59:57 INFO - Running setup.py (path:/tmp/pip-oTHauv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:59:57 INFO - Running setup.py (path:/tmp/pip-oLATe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:59:57 INFO - Running setup.py (path:/tmp/pip-rfosIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:59:58 INFO - Running setup.py (path:/tmp/pip-rUo1WF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:59:58 INFO - Running setup.py (path:/tmp/pip-ohOwS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:58 INFO - Running setup.py install for manifestparser 06:59:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Running setup.py install for mozcrash 06:59:58 INFO - Running setup.py install for mozdebug 06:59:58 INFO - Running setup.py install for mozdevice 06:59:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Running setup.py install for mozfile 06:59:58 INFO - Running setup.py install for mozhttpd 06:59:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Running setup.py install for mozinfo 06:59:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Running setup.py install for mozInstall 06:59:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:59:58 INFO - Running setup.py install for mozleak 06:59:59 INFO - Running setup.py install for mozlog 06:59:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Running setup.py install for moznetwork 06:59:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Running setup.py install for mozprocess 06:59:59 INFO - Running setup.py install for mozprofile 06:59:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Running setup.py install for mozrunner 06:59:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Running setup.py install for mozscreenshot 06:59:59 INFO - Running setup.py install for moztest 06:59:59 INFO - Running setup.py install for mozversion 06:59:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:59:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:59 INFO - Cleaning up... 06:59:59 INFO - Return code: 0 06:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', '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 06:59:59 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 06:59:59 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 06:59:59 INFO - Using env: {'DISPLAY': ':0', 06:59:59 INFO - 'HOME': '/home/cltbld', 06:59:59 INFO - 'LANG': 'en_US.UTF-8', 06:59:59 INFO - 'LANGUAGE': 'en_US:en', 06:59:59 INFO - 'LOGNAME': 'cltbld', 06:59:59 INFO - 'MAIL': '/var/mail/cltbld', 06:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:59 INFO - 'MOZ_NO_REMOTE': '1', 06:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:59 INFO - 'NO_EM_RESTART': '1', 06:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 06:59:59 INFO - 'SHELL': '/bin/bash', 06:59:59 INFO - 'SHLVL': '1', 06:59:59 INFO - 'TERM': 'linux', 06:59:59 INFO - 'TMOUT': '86400', 06:59:59 INFO - 'USER': 'cltbld', 06:59:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 06:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:59 INFO - '_': '/tools/buildbot/bin/python'} 07:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:00 INFO - Running setup.py (path:/tmp/pip-OkAV1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:00 INFO - Running setup.py (path:/tmp/pip-rHEONk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:00 INFO - Running setup.py (path:/tmp/pip-7QRKCU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:00 INFO - Running setup.py (path:/tmp/pip-4Jna_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:00 INFO - Running setup.py (path:/tmp/pip-hD4i3d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:00 INFO - Running setup.py (path:/tmp/pip-Zg3acb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:00 INFO - Running setup.py (path:/tmp/pip-2VzpT5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:00 INFO - Running setup.py (path:/tmp/pip-2NmH4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:00 INFO - Running setup.py (path:/tmp/pip-X4UVci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:00 INFO - Running setup.py (path:/tmp/pip-jLIv1s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:00 INFO - Running setup.py (path:/tmp/pip-nddWab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 07:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:00 INFO - Running setup.py (path:/tmp/pip-mcurJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:01 INFO - Running setup.py (path:/tmp/pip-DIuMZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:01 INFO - Running setup.py (path:/tmp/pip-anG0b6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:01 INFO - Running setup.py (path:/tmp/pip-quJJii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:01 INFO - Running setup.py (path:/tmp/pip-3qRM6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:01 INFO - Running setup.py (path:/tmp/pip-N42Qjg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:03 INFO - Downloading blessings-1.6.tar.gz 07:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:03 INFO - Installing collected packages: blessings 07:00:03 INFO - Running setup.py install for blessings 07:00:03 INFO - Successfully installed blessings 07:00:03 INFO - Cleaning up... 07:00:04 INFO - Return code: 0 07:00:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:00:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:04 INFO - Reading from file tmpfile_stdout 07:00:04 INFO - Current package versions: 07:00:04 INFO - argparse == 1.2.1 07:00:04 INFO - blessings == 1.6 07:00:04 INFO - blobuploader == 1.2.4 07:00:04 INFO - docopt == 0.6.1 07:00:04 INFO - manifestparser == 1.1 07:00:04 INFO - mozInstall == 1.12 07:00:04 INFO - mozcrash == 0.16 07:00:04 INFO - mozdebug == 0.1 07:00:04 INFO - mozdevice == 0.48 07:00:04 INFO - mozfile == 1.2 07:00:04 INFO - mozhttpd == 0.7 07:00:04 INFO - mozinfo == 0.9 07:00:04 INFO - mozleak == 0.1 07:00:04 INFO - mozlog == 3.1 07:00:04 INFO - moznetwork == 0.27 07:00:04 INFO - mozprocess == 0.22 07:00:04 INFO - mozprofile == 0.28 07:00:04 INFO - mozrunner == 6.11 07:00:04 INFO - mozscreenshot == 0.1 07:00:04 INFO - mozsystemmonitor == 0.0 07:00:04 INFO - moztest == 0.7 07:00:04 INFO - mozversion == 1.4 07:00:04 INFO - psutil == 3.1.1 07:00:04 INFO - requests == 1.2.3 07:00:04 INFO - wsgiref == 0.1.2 07:00:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:04 INFO - Using env: {'DISPLAY': ':0', 07:00:04 INFO - 'HOME': '/home/cltbld', 07:00:04 INFO - 'LANG': 'en_US.UTF-8', 07:00:04 INFO - 'LANGUAGE': 'en_US:en', 07:00:04 INFO - 'LOGNAME': 'cltbld', 07:00:04 INFO - 'MAIL': '/var/mail/cltbld', 07:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:04 INFO - 'MOZ_NO_REMOTE': '1', 07:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:04 INFO - 'NO_EM_RESTART': '1', 07:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:04 INFO - 'SHELL': '/bin/bash', 07:00:04 INFO - 'SHLVL': '1', 07:00:04 INFO - 'TERM': 'linux', 07:00:04 INFO - 'TMOUT': '86400', 07:00:04 INFO - 'USER': 'cltbld', 07:00:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 07:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:04 INFO - '_': '/tools/buildbot/bin/python'} 07:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 07:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:00:04 INFO - Cleaning up... 07:00:04 INFO - Return code: 0 07:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:00:04 INFO - Using env: {'DISPLAY': ':0', 07:00:04 INFO - 'HOME': '/home/cltbld', 07:00:04 INFO - 'LANG': 'en_US.UTF-8', 07:00:04 INFO - 'LANGUAGE': 'en_US:en', 07:00:04 INFO - 'LOGNAME': 'cltbld', 07:00:04 INFO - 'MAIL': '/var/mail/cltbld', 07:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:04 INFO - 'MOZ_NO_REMOTE': '1', 07:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:04 INFO - 'NO_EM_RESTART': '1', 07:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:04 INFO - 'SHELL': '/bin/bash', 07:00:04 INFO - 'SHLVL': '1', 07:00:04 INFO - 'TERM': 'linux', 07:00:04 INFO - 'TMOUT': '86400', 07:00:04 INFO - 'USER': 'cltbld', 07:00:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 07:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:04 INFO - '_': '/tools/buildbot/bin/python'} 07:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:04 INFO - Downloading/unpacking jsonschema 07:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 07:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:06 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:06 INFO - warning: no files found matching '*.txt' 07:00:06 INFO - no previously-included directories found matching 'build' 07:00:06 INFO - no previously-included directories found matching 'dist' 07:00:06 INFO - no previously-included directories found matching '.git*' 07:00:06 INFO - Installing collected packages: jsonschema, functools32 07:00:06 INFO - Running setup.py install for functools32 07:00:07 INFO - warning: no files found matching '*.txt' 07:00:07 INFO - no previously-included directories found matching 'build' 07:00:07 INFO - no previously-included directories found matching 'dist' 07:00:07 INFO - no previously-included directories found matching '.git*' 07:00:07 INFO - Successfully installed jsonschema functools32 07:00:07 INFO - Cleaning up... 07:00:07 INFO - Return code: 0 07:00:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:07 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 0x7f4d879b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedd670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, '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': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:00:07 INFO - Using env: {'DISPLAY': ':0', 07:00:07 INFO - 'HOME': '/home/cltbld', 07:00:07 INFO - 'LANG': 'en_US.UTF-8', 07:00:07 INFO - 'LANGUAGE': 'en_US:en', 07:00:07 INFO - 'LOGNAME': 'cltbld', 07:00:07 INFO - 'MAIL': '/var/mail/cltbld', 07:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:07 INFO - 'MOZ_NO_REMOTE': '1', 07:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:07 INFO - 'NO_EM_RESTART': '1', 07:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:07 INFO - 'SHELL': '/bin/bash', 07:00:07 INFO - 'SHLVL': '1', 07:00:07 INFO - 'TERM': 'linux', 07:00:07 INFO - 'TMOUT': '86400', 07:00:07 INFO - 'USER': 'cltbld', 07:00:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 07:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:07 INFO - '_': '/tools/buildbot/bin/python'} 07:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:07 INFO - Downloading/unpacking flake8 07:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:09 INFO - no previously-included directories found matching 'docs/_build' 07:00:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:09 INFO - Running setup.py install for pep8 07:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:09 INFO - no previously-included directories found matching 'docs/_build' 07:00:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:10 INFO - Cleaning up... 07:00:10 INFO - Return code: 0 07:00:10 INFO - Running post-action listener: _resource_record_post_action 07:00:10 INFO - Running post-action listener: _start_resource_monitoring 07:00:10 INFO - Starting resource monitoring. 07:00:10 INFO - ##### 07:00:10 INFO - ##### Running install step. 07:00:10 INFO - ##### 07:00:10 INFO - Running pre-action listener: _resource_record_pre_action 07:00:10 INFO - Running main action method: install 07:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:10 INFO - Reading from file tmpfile_stdout 07:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:00:10 INFO - Reading from file tmpfile_stdout 07:00:10 INFO - Output received: 07:00:10 INFO - Usage: mozinstall [options] installer 07:00:10 INFO - Options: 07:00:10 INFO - -h, --help show this help message and exit 07:00:10 INFO - -d DEST, --destination=DEST 07:00:10 INFO - Directory to install application into. [default: 07:00:10 INFO - "/builds/slave/test-pgo"] 07:00:10 INFO - --app=APP Application being installed. [default: firefox] 07:00:10 INFO - mkdir: /builds/slave/test-pgo/build/application 07:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:00:26 INFO - Reading from file tmpfile_stdout 07:00:26 INFO - Output received: 07:00:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:00:26 INFO - Running post-action listener: _resource_record_post_action 07:00:26 INFO - ##### 07:00:26 INFO - ##### Running run-tests step. 07:00:26 INFO - ##### 07:00:26 INFO - Running pre-action listener: _resource_record_pre_action 07:00:26 INFO - Running main action method: run_tests 07:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:00:26 INFO - Python 2.7.3 07:00:26 INFO - Return code: 0 07:00:26 INFO - grabbing minidump binary from tooltool 07:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:26 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 0xf6c8c0>, '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 0xf6d7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6dc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:00:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:00:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:00:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:26 INFO - Return code: 0 07:00:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:00:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:00:27 INFO - Return code: 0 07:00:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:00:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:00:27 INFO - Using env: {'DISPLAY': ':0', 07:00:27 INFO - 'HOME': '/home/cltbld', 07:00:27 INFO - 'LANG': 'en_US.UTF-8', 07:00:27 INFO - 'LANGUAGE': 'en_US:en', 07:00:27 INFO - 'LOGNAME': 'cltbld', 07:00:27 INFO - 'MAIL': '/var/mail/cltbld', 07:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:27 INFO - 'MOZ_NO_REMOTE': '1', 07:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:27 INFO - 'NO_EM_RESTART': '1', 07:00:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:00:27 INFO - 'SHELL': '/bin/bash', 07:00:27 INFO - 'SHLVL': '1', 07:00:27 INFO - 'TERM': 'linux', 07:00:27 INFO - 'TMOUT': '86400', 07:00:27 INFO - 'USER': 'cltbld', 07:00:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815', 07:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:27 INFO - '_': '/tools/buildbot/bin/python'} 07:00:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:00:27 INFO - mozversion application_buildid: 20160229043018 07:00:27 INFO - mozversion application_changeset: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf 07:00:27 INFO - mozversion application_display_name: Nightly 07:00:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:27 INFO - mozversion application_name: Firefox 07:00:27 INFO - mozversion application_remotingname: firefox 07:00:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:00:27 INFO - mozversion application_vendor: Mozilla 07:00:27 INFO - mozversion application_version: 47.0a1 07:00:27 INFO - mozversion platform_buildid: 20160229043018 07:00:27 INFO - mozversion platform_changeset: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf 07:00:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:00:27 INFO - mozversion platform_version: 47.0a1 07:00:27 INFO - using testdate: 1456758027 07:00:27 INFO - actual date: 1456758027 07:00:28 INFO - starting webserver on 'localhost:36501' 07:00:28 INFO - SUITE-START | Running 2 tests 07:00:28 INFO - TEST-START | dromaeo_css 07:00:28 INFO - operating with platform_type : linux_ 07:00:28 INFO - Initialising browser for dromaeo_css test... 07:00:28 INFO - TEST-INFO | started process 13568 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Zi3m3/profile http://localhost:36501/getInfo.html) 07:00:32 INFO - PROCESS | 13568 | __metrics Screen width/height:1600/1200 07:00:32 INFO - PROCESS | 13568 | colorDepth:24 07:00:32 INFO - PROCESS | 13568 | Browser inner width/height: 1024/697 07:00:32 INFO - PROCESS | 13568 | __metrics 07:00:33 INFO - PROCESS | 13568 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:00:33 INFO - PROCESS | 13568 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:00:34 INFO - TEST-INFO | 13568: exit 0 07:00:34 INFO - Browser initialized. 07:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:34 INFO - TEST-INFO | started process 13662 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Zi3m3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:46 INFO - PROCESS | 13662 | RSS: Main: 153022464 07:00:46 INFO - PROCESS | 13662 | 07:01:37 INFO - PROCESS | 13662 | 1456758097581 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:03:45 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36501/tests/dromaeo/cssquery-ext.html) 07:03:46 INFO - PROCESS | 13662 | RSS: Main: 279674880 07:03:46 INFO - PROCESS | 13662 | 07:06:48 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-ext.html (next: http://localhost:36501/tests/dromaeo/cssquery-jquery.html) 07:06:49 INFO - PROCESS | 13662 | RSS: Main: 245985280 07:06:49 INFO - PROCESS | 13662 | 07:09:51 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36501/tests/dromaeo/cssquery-mootools.html) 07:09:51 INFO - PROCESS | 13662 | RSS: Main: 231317504 07:09:51 INFO - PROCESS | 13662 | 07:12:53 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36501/tests/dromaeo/cssquery-prototype.html) 07:12:54 INFO - PROCESS | 13662 | RSS: Main: 220217344 07:12:54 INFO - PROCESS | 13662 | 07:15:56 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36501/tests/dromaeo/cssquery-yui.html) 07:15:57 INFO - PROCESS | 13662 | RSS: Main: 214798336 07:15:57 INFO - PROCESS | 13662 | 07:18:59 INFO - PROCESS | 13662 | Cycle 1(1): loaded http://localhost:36501/tests/dromaeo/cssquery-yui.html (next: http://localhost:36501/tests/dromaeo/cssquery-dojo.html) 07:19:00 INFO - PROCESS | 13662 | RSS: Main: 273154048 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | __start_tp_report 07:19:00 INFO - PROCESS | 13662 | _x_x_mozilla_page_load 07:19:00 INFO - PROCESS | 13662 | _x_x_mozilla_page_load_details 07:19:00 INFO - PROCESS | 13662 | |i|pagename|runs| 07:19:00 INFO - PROCESS | 13662 | |0;dojo.html;3075.923101922452;3110.471219892618;3149.7637677174203;3160.936781264375;3184.79298845575;4907.484714105021;4960.826371077013;4982.825601103962;5028.522290382408;5043.873903152418;4929.901401971958;4993.625478089149;5021.071101846152;5028.7485625718755;5037.06814239365;4507.526709695484;4520.073384956085;4625.375574297477;4658.510856360084;4724.716517008973;4636.188666983265;4645.210314246569;4689.859304220862;4690.390249267591;4736.171170045245;4424.402705634747;4451.977740111295;4516.18708632446;4519.118771839492;4592.357070010201;4502.684812063157;4539.795709193061;4543.0459603483305;4552.817887284505;4564.406627138484;4503.392042074311;4518.593326600589;4524.61540769035;4541.818327266906;4546.499885012679;4850.078485087822;4880.145974454456;4885.36490256268;4896.877578060541;4901.852944411673;5369.677819330814;5388.91916621251;5389.757460914268;5448.210009548633;5451.127819548893;5340.198970154508;5351.678899266018;5355.410904800468;5358.223057656657;5358.97320513395;4929.975350123263;4971.477994810565;5010.599152067826;5016.698998060128;5061.16490779021;5373.9731301343245;5376.758045887945;5379.596530260246;5407.972960135174;5428;5183.922241166386;5189.143791274473;5195.220716892421;5202.115640341151;5232.2674825524455;5203.7918483261;5255.369355677343;5288.8413347599635;5341.198820177005;5375.059364611177;5356.544693701079;5372.516473517402;5377.596680248997;5378.811741589026;5379.677219366772;5319.654222475527;5343.545798607084;5344.278522399426;5344.385395679469;5395.81114660985;3996.800159991989;4094.0583665757044;4119.258533464005;4172.144710334374;4181.435506206684;3742.73800833939;3745.3445647011663;3759.1353988582778;3785.886423407302;3796.487474190949;5100.51545103222;5117.897642047213;5125.077486052546;5132.358455193101;5175.81884634036;5200.063988482034;5294.682319060792;5303.7348132593215;5357;5368.32895888014;5088.084144853962;5098.209777484496;5114.130597798383;5123.897522049539;5166.095933211673;4447.644188464915;4603.033362993742;4629.537046295411;4632.814687412466;4665.790039448233;5503.11950087984;5520.392756796829;5549.556035517149;5589.580781441408;5609.607327487037;5244.632875698664;5261.500157485033;5261.979734065677;5263.973680131575;5277.630565860353;5437.646552974044;5510.586705996986;5518;5589.860253493695;5660.547156227574;5330.733463326741;5349.786008559614;5351.438098999549;5374.677519348852;5396.028714831368;5392.595555333287;5393.784248630168;5417.83746487606;5422.674639521641;5475.151351540518;5069;5174.353205849269;5241.659292145999;5283.418823929288;5308.761105750174;5210.088234558862;5234.319538459976;5236.240745092016;5244.344456942882;5262.342207224097;5083.898322033465;5086.567641750345;5112.693238405707;5135.409427915837;5174.637775355689;5091.465396133501;5098.592112631055;5180.171172612364;5199.532042116228;5259.39516955555;5069.518395752398;5116.769745361393;5154.175331946871;5159.871003224949;5195.376554813447 07:19:00 INFO - PROCESS | 13662 | |1;ext.html;511.7390131033173;520.6875874475315;523.829755329518;546.9644473109245;547.2557322042022;28846.134615961502;35808.462873056924;36160.63839361606;36246.275074498495;36312;39660.60339396605;39868.202635947266;40068;40085;40156.397654035216;8301.667933282677;8606.956965215166;8609.827803443928;8611.095834937336;8614.483131012159;8552.5296108714;8699.260562852134;8718.38971272008;8722.781930451725;8723.781905452382;8656.8701469478;8729.694460693878;8745.737627871174;8749.431286966326;8750.6937257196;8617.784555386103;8626.439281446686;8670.523121228392;8696.565171741418;8696.739097827076;8614.698485552975;8725.650973961034;8728.127187281285;8731.388802783807;8759.956200219021;37891.62108378936;38264;38367.616323836686;38395;38397.80801096005;3290.50642403639;3300.405926933151;3748.1379282765115;3798.582155962842;4055.3105971984833;29649.555256670952;29819.552706709415;29992.250193745112;30039.849800750857;31281.687183128106;3386.8306584670913;3407.71034462071;3432.7940323580665;3492.1444246159854;3599.046252743025;252028.83769298595;255160;255199.72400138067;255665;256378;51019.489805101475;55698.72150639221;56895.431045689016;57065;57106.71446642823;57720.42279577234;58022;58294.376753046214;58405.70797145987;58417.707911461024;15514;15755.763663545056;15786.605334866721;15789.131597762233;15793.842061579468;9962.551685174185;10095.798084038279;11470.827937580943;11802.232854864405;11926.522939082513;18210.36263730763;18450.16974236136;18522.259109635732;18551.81448185528;18586;7124.893126603105;7411.5553066816165;7439.776806695808;7467.51461155034;7493.775186744407;902.3503077783985;912.7535565397438;968.651285537206;970.4322971061866;1058.571278632155;28567.428651426853;28789.424211515652;28824.279393015342;29144.85427572891;29334.89311496392;1037.6316407675167;1073.2487258918632;1088.4231357380602;1098.9780204395868;1109.7946879827095;14386.712265754835;15063.698726025417;15153.848461515243;15218.695626087638;15403.152826594422;301045;301236;302347;302662;303539;51507.48492515102;51509;51717.7414112927;51742.99999999925;51786.741066294424;1349.8795999320541;1383.384393944685;1399.7060617270283;1400.4468235047302;1405.36758458694;27363.58954615722;28663.574684352807;29099;29224.56163157597;29250.561241581818;45474.77262613798;45618;45763.31355029744;45820.31269531026;45822;289418;289581;290060;290623;365136.44044917665;31137.37725245437;31256.21859453441;31356;31618.209544761565;31750;39612.80193599014;40386;40658.59341406548;40689.18621627492;41141.382879257435;33745.49381759325;34001.65998340084;34126.488102677984;34250.31499369949;34687;33715.662843372236;34297.65702342945;34329.65670343365;34376.656233437345;34670;33341.83329083339;33620.831895841344;34146.48780268248;34449;34473.65526344805;29370;29624;30546;30916.845415772776;30933;22973.88513057424;23523.303127886233;23530.76469235286;23585.646215307126;23779 07:19:00 INFO - PROCESS | 13662 | |2;jquery.html;344.1104744236151;347.860855657737;349.24388698467817;352.4061955604806;354.90417587251426;15638.921805390972;16015.439459618916;16605.335786568554;16611.252493637785;16613.916930415347;16126.113063781488;16339.83660163398;16750.162491875417;16762.239964803703;16939.153042347894;5110.948890511103;5135.12702840518;5323.893522129555;5333.519983201511;5362.8123015694455;5295.391030031538;5346.117890548055;5357.196420536911;5386.084365657847;5387.084195686723;5116.565091967187;5321.4412486688925;5322.8137015204475;5323.414424413311;5330.813421530247;5284.841454756363;5289.709066001368;5318.175682769177;5320.0157970775335;5324.281222035014;4705.764711764398;4732.384789977315;4734.19518681825;4750.524947505256;4752.120857641347;18109;19972.90013549923;20188.596228075505;20659;20716;2054.41449186981;2088.7702352741185;2167.826573874086;2202.7994742865176;2285.6914316567218;8859.689910853089;8919;8970.686025989058;9069.455832650063;9322.906770932272;1792.1308165539704;1829.1494455078318;1844.9169787359467;1870.326682394337;1885.208212550732;47265.479749527636;48875.266870996966;57441.71279143619;62923.37076629221;63753.04370434447;9979.700608981742;10006.099451049295;10067.395956242648;10143.898561014295;10232.795344093076;13033.478660853649;13114;13187.274699891406;13187.60437186886;13211.801822972662;7133.607651579109;7358.632068396666;7417;7475.514091584029;7512.474126811071;7255.52839065459;7275.599842008741;7363.521371110861;7369.557826530426;7376.450945301547;4194.706370554093;4335.609795118455;4337.652987760972;4402.669799765031;4408.845690400884;1798.3256278895415;1842.4564753397513;1862.9906850465932;1867.6544839204519;1879.4361691492497;888.4225253585221;938.6198589571235;964.2093483343591;985.6451677396132;986.0533887467967;16249.837501625068;16745.832541674426;17031;17195.57011074708;17380;914.492456686532;915.665781989569;919.9586018629178;921.6774129054777;1006.3710181136789;9415.199708024895;9601.951990240004;9710.70867873965;9832.869220039644;9892.604295828087;312651;318571;403799;410054;413271;74939;75074.62462687651;78479.60760196163;78893.21106788973;79090;1039.9948000259951;1050.5062620568322;1072.1583556907947;1111.716512289361;1112.1492058575197;15499.965033917082;15603.765943510629;15653;15899.205039747734;15991.600209994844;33733;33878.491822622185;33915.830420847735;34525.13687157841;34931;49511.50488495069;49570;49853.25220121629;49886.750566246934;50069;7272.7454539093;7427.962860185665;7585.2035536267895;7597.240275972579;8019.318357939641;9619.663311784054;12574.37128143571;12672;12726.300053497147;12753.171043882117;7486.326230639269;7692.307692307719;7787.688492460238;8429.452085614415;10778.191635627203;7864;8009.7172305892545;8116.553589552631;8270.83458330818;8379.413441059067;7804.648790804314;7818.631739445461;8017.8797318039105;8405.201505856934;8468.49189048659;10538.473076346;11429.59996400122;11436.199466037298;11443.828342574701;11462.885371146182;7649.158592554926;11461.713457163638;11624.593139240085;11659.475323610628;11866.347350895438 07:19:00 INFO - PROCESS | 13662 | |3;mootools.html;1178.2694729267855;1434.799128122063;1452.397255139117;1628.4951664983855;1784.8215178482146;7299.270072992705;7478.513896596717;7481.438892083088;7495.512791668538;7502.287282708147;7486.663100160492;7597.2402759724;7665.310122089011;7667.079950405959;7677.270659287373;1821.772278465192;2032.8983550822475;2079.1059844266997;2098.08733201058;2110.2297661353573;2077.428707105543;2085.8539902206853;2087.561612061469;2094.1309356616985;2100.411884672294;2077.221042109209;2083.052211243888;2116.555523340093;2120.0883620043373;2120.39568722914;2117.2060477321006;2125.38363874477;2134.3063504361144;2138.871667699943;2148.151480165334;2071.337172104927;2072.58548290341;2074.1392322186425;2074.263636409068;2074.522859742268;7743.457957942946;7777.883331750028;7792.571408572526;7794.844103117963;7801.1028731696015;4333.739975601443;4514.277715565494;4514.683972121953;4525.615322697575;4541.636669066466;2846.402255526342;2922.7954043216982;2948.7346138847392;2963.229560314312;2968.317287023975;903.3549627253999;915.5742579700404;915.6566287642135;915.7939463620633;961.2550273537994;10756.408397538133;10847.945760271226;10857.294275872044;10859.891401085966;10860.294080884796;3932.193900250499;3966.6628336591134;4045.292073887058;4054.9797251013556;4057.9391309130388;9130.452172869649;9171.35800493959;9212.585433655502;9220.631174752934;9222.216111630587;3987.481627388479;4579.9084018319445;4591.288350305708;4593.28804035375;4594.908101837945;3905.062784931653;3910.9608903911167;3972.5828787977425;3975;3986.4618276532296;3368.9663103368653;3394.9830250848586;3430.9485357719655;3452.3267962747527;3452.9482057769155;1069.8609180806445;1075.8386242063752;1087.037971395321;1088.542812018938;1097.385464140068;912.4616476279027;920.894097178833;926.2266007883493;929.8837645294338;1127.9154063445274;7414.6292685365515;7459.291367320096;7460.179380268166;7500.549967001997;7501.924980750232;431.1484817485441;438.32935608519017;1186.1756079524648;1191.4936152135308;1214.4595654933469;5694.316681998187;5756.7121643917635;5795;5799.88400231993;5807.245058142415;8897.510636914902;9002.144796244347;9026.232770214605;9039.774005649911;9140.6800761973;8972;8985.236254918274;9140.725778226664;9155;9157.175854173156;7003.194632617212;7019.2629773873;7072.575645461392;7079.716811327592;7154.034205382311;7251.637418129178;7262.237465066092;7273.854522909618;7277.199508054216;7278.927210727825;8208.302294304813;8332.333413326798;8452.197041281068;8556.74329770108;8596.312295016258;8558.614862331086;8564.229219370287;8651.52416617092;8725.04024557311;8730.301575873787;6011.128386383863;6551.70517326731;6641.966790166019;6736.730530778714;6804.081449004321;7358.77923662291;7369.926300736924;7401.4078873688895;7407;7423.331900129015;6561.278259391559;6739.157605299338;6753.696083676345;6862.142232220973;6887.862242755016;6611.404973552403;6613.2394774601535;6648.867022659617;6686.765963191265;6767.1879374475375;7099.680514376969;7155.105611798525;7222.3860971817985;7224.169220539705;7232.566046037255;6568.310327415553;6629.900551491828;6644.83387915306;6648.867022659617;6656.600603963778;6416.390442907917;6479.125318081999;6488.059231411325;6489.448396886318;6494.2856285807575 07:19:00 INFO - PROCESS | 13662 | |4;prototype.html;305.5828793696604;310.7265606266485;319.80971322063374;322.47758631017757;323.44206244228707;5661.575381846363;5825.271841019872;5842.620229685072;5849.181114643953;5871.9412805871925;5682.289713785777;5788.6237394569325;5802.100674395465;5809.7385617647205;5813.30240371155;4163.875083747493;4279.2083464559155;4292.871213863574;4385.298352263639;4398.142362239365;4265.104328091104;4289.785510724467;4369.279068953619;4373.518912919576;4386.363977223301;4320.567943205686;4322.524522302544;4323.308270676693;4327.285997810358;4334.501532323791;4144.585541445831;4240.23675738367;4329.177456283296;4331.696781225315;4345.739255644671;3702.4816525686424;3731.7201209909094;3734;3734.5705243897028;3741.4387841823673;5424.620276580641;5501.834944951658;5517;5522.30971128609;5524.06090964533;5037.798488060474;5041.59667226621;5046.293518907356;5046.419661738873;5053.722045287508;6073.605215660968;6075.392460753934;6083.300420451616;6083.513318934519;6087.2086628738425;4169.0411205422615;4170.416141740159;4170.9582904170875;4172.123853990665;4172.207280616673;6103.29812071613;6194.349593292684;6300.117983482316;6315.715792789336;6316.905246421307;4151.107511884959;4166.979165104155;4187.602177793105;4190.371444283382;4208.452901122896;4277.486701595766;4294.3558466230315;4298.828046878152;4302.591253830881;4303.763293018851;5010.448850626428;5014.89970200594;5023.422306434733;5027.84916452507;5032.0690672225755;6088.8782224356155;6142.447179753754;6147;6149.538784591084;6150.200473938359;1447.2691290898028;1482.5848762346561;1505.8343582205948;1506.909585424878;1508.2232650185163;967.6951760195657;993.3543196922059;1005.2460654509118;1013.7921726046143;1014.9238807089498;5671.291088613923;5752.884942301214;5764.884702306014;5846.532277417797;5850.64896106235;6241.719122639402;6241.843953901189;6242.875142497124;6258.468030217391;6259.78090766821;5858.765649374062;5897.5871688982215;5916.497097746654;5917.52659787216;5921.585489015813;3371.460566309379;3408.0287118171204;3410.5566276384407;3413.8293085345636;3415.0608582639975;6535;6701.832454188684;6706;6707.094542236833;6709.664516774142;6420.390062944013;6462.741490340334;6489.383508566679;6497.545171838021;6525.053867189231;6662.333766623396;6670;6671.699773510204;6674.83312917181;6680.5991640501725;6270.993282149669;6278.309385967448;6311.873762524816;6330.461910737639;6340.619562826245;6274.560780745304;6279.434850863444;6284.277308109443;6286.654234017173;6297.149884765681;6533.869322613426;6667.733290668319;6686.899696504459;6689.899651505329;6694.129763130956;4212.073343864345;4227.387028880857;4230.196262710076;4232.449781528381;4235.618794308527;6278.121063051268;6305.684715764285;6323.6838158090995;6332.873342533216;6337.746490140527;6132.6627035513475;6135.987562052212;6136.693165341804;6138.693065346804;6140.263168419819;5941.435563621449;6115.938840611537;6132.724027418866;6135.754569817336;6143.293521245114;5976.193213916065;6015.669138197266;6020.54845886569;6025.78909738157;6032.819015429544;6056.66688332146;6066.059760737093;6086.300075491198;6094.238220222473;6094.603850749687;6018.307894592178;6083.939160608337;6088.573799833969;6089.177960975212;6090.330063693079 07:19:00 INFO - PROCESS | 13662 | |5;yui.html;718.4611541343992;721.8339781850177;820.8029724224147;848.1815048478221;865.4417900454205;13629.727405451897;13833.239171845556;13894.23581703006;13904.791428128587;13947.232902190375;12725.999999999976;13304.800427993589;13718.382672779724;13765;13825.446982120704;787.8857565652977;793.3335997761878;795.9920400795976;800.3597122302164;801.3348920396057;807.475141158246;810.6352141536303;810.7891948093479;811.4319976016811;811.6550466051934;850.7490290364358;852.6887685994599;852.735651947895;854.0050840770494;854.0520022774715;840.6343240690288;841.5960339037297;842.0653075086649;842.4776638484179;842.4860834890711;632.1371328137105;632.5540493951798;632.5603705424732;632.5666918161029;632.9303776584572;12128.151029427943;12176.57381991626;12201.328926909016;12204.816927746091;12213.084018698544;11527.365994870279;11663.183577149603;11663.300201987908;11698.47356868943;11715.648530544097;9214.493202873839;9455.054494550559;9469.66856160031;9477.431354118775;9524.952375238148;3607.440846668744;3678.319510890467;3693.298273328059;3698.815059247027;3800.429935509668;50382;50604;50775;50812;51057;8287.792805179799;8528.701495447629;8575.656973721107;9051.27589792815;9147.908520914838;17490.300387984593;17514.47456576305;17560.56098597545;17570.29718811259;17584.912075439795;6008.609440386361;6061.454469097803;6841.589504629738;7030.086088808423;7173.856522869618;3939.665128464055;3994.8601798936897;4043.7775922323967;4050.18996200761;4127.814248358831;3013.2316259353724;3053.175642576492;3054.465468542996;3060.709232622897;3062.6324841018773;501.74411050363847;516.2776382283776;522.3548917087394;523.5602094240837;527.5199568392744;647.4658406814397;663.7842701122155;665.5673812022225;669.5915491550151;677.664556044761;8071.5964201789675;8417.326613870875;8490;8523.147685231428;8773.780655483664;470.18657722140205;594.9613275137102;634.5780056262626;670.5004771445305;687.1342108942669;3840.7695538267794;3889.688824894058;3893.7079719021185;3918.7648741075627;3992.5208974923194;55415.445845541835;55533.72233138889;55622.72188639031;55686.16470752942;55767;45001.77499112483;46938.530614693416;50701.746491268044;50995.49004509982;51415;40985.1802963945;45872.31191532063;45908.770456147504;46075.76962115235;46898.76550617293;8649.308055355683;8711.869321960048;8755.562221888753;8889.19997200255;8918.405125313793;34062;34490.82754586211;34939;35127.29745405129;35374.823125884206;42503.574964249965;44129;44278;44402.777986111156;44617.33074003957;10684.145268378355;10777.730556736144;10849.511771970123;10870.619528316787;11076.335419874833;11817.881821182022;11820.92705727567;11837;11854.170208085352;12686.175398599062;11212.943935280271;11354.716132096764;11406.372649504357;11423.543058277575;11825.231359961575;10091.293609447268;10579.735506612396;11384.658460246206;11430.657080287605;11717.179797414099;10793.460326983777;11065.114790816555;11084.889151108386;11300.321980681185;11423;9754.878189008356;9759.141766095747;9890.307678462439;9919.256055795988;10194.592216311265;8829.779255518664;9072.909270907207;9676;9718.878698048176;9883.802323953625 07:19:00 INFO - PROCESS | 13662 | __end_tp_report 07:19:00 INFO - PROCESS | 13662 | __start_cc_report 07:19:00 INFO - PROCESS | 13662 | _x_x_mozilla_cycle_collect,1022 07:19:00 INFO - PROCESS | 13662 | __end_cc_report 07:19:00 INFO - PROCESS | 13662 | __startTimestamp1456759140100__endTimestamp 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | ------- Summary: start ------- 07:19:00 INFO - PROCESS | 13662 | Number of tests: 6 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#0] dojo.html Cycles:165 Average:4978.05 Median:5154.18 stddev:525.31 (10.2%) stddev-sans-first:505.28 07:19:00 INFO - PROCESS | 13662 | Values: 3075.9 3110.5 3149.8 3160.9 3184.8 4907.5 4960.8 4982.8 5028.5 5043.9 4929.9 4993.6 5021.1 5028.7 5037.1 4507.5 4520.1 4625.4 4658.5 4724.7 4636.2 4645.2 4689.9 4690.4 4736.2 4424.4 4452.0 4516.2 4519.1 4592.4 4502.7 4539.8 4543.0 4552.8 4564.4 4503.4 4518.6 4524.6 4541.8 4546.5 4850.1 4880.1 4885.4 4896.9 4901.9 5369.7 5388.9 5389.8 5448.2 5451.1 5340.2 5351.7 5355.4 5358.2 5359.0 4930.0 4971.5 5010.6 5016.7 5061.2 5374.0 5376.8 5379.6 5408.0 5428.0 5183.9 5189.1 5195.2 5202.1 5232.3 5203.8 5255.4 5288.8 5341.2 5375.1 5356.5 5372.5 5377.6 5378.8 5379.7 5319.7 5343.5 5344.3 5344.4 5395.8 3996.8 4094.1 4119.3 4172.1 4181.4 3742.7 3745.3 3759.1 3785.9 3796.5 5100.5 5117.9 5125.1 5132.4 5175.8 5200.1 5294.7 5303.7 5357.0 5368.3 5088.1 5098.2 5114.1 5123.9 5166.1 4447.6 4603.0 4629.5 4632.8 4665.8 5503.1 5520.4 5549.6 5589.6 5609.6 5244.6 5261.5 5262.0 5264.0 5277.6 5437.6 5510.6 5518.0 5589.9 5660.5 5330.7 5349.8 5351.4 5374.7 5396.0 5392.6 5393.8 5417.8 5422.7 5475.2 5069.0 5174.4 5241.7 5283.4 5308.8 5210.1 5234.3 5236.2 5244.3 5262.3 5083.9 5086.6 5112.7 5135.4 5174.6 5091.5 5098.6 5180.2 5199.5 5259.4 5069.5 5116.8 5154.2 5159.9 5195.4 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#1] ext.html Cycles:180 Average:45111.36 Median:34412.83 stddev:75485.60 (219.4%) stddev-sans-first:75623.08 07:19:00 INFO - PROCESS | 13662 | Values: 511.7 520.7 523.8 547.0 547.3 28846.1 35808.5 36160.6 36246.3 36312.0 39660.6 39868.2 40068.0 40085.0 40156.4 8301.7 8607.0 8609.8 8611.1 8614.5 8552.5 8699.3 8718.4 8722.8 8723.8 8656.9 8729.7 8745.7 8749.4 8750.7 8617.8 8626.4 8670.5 8696.6 8696.7 8614.7 8725.7 8728.1 8731.4 8760.0 37891.6 38264.0 38367.6 38395.0 38397.8 3290.5 3300.4 3748.1 3798.6 4055.3 29649.6 29819.6 29992.3 30039.8 31281.7 3386.8 3407.7 3432.8 3492.1 3599.0 252028.8 255160.0 255199.7 255665.0 256378.0 51019.5 55698.7 56895.4 57065.0 57106.7 57720.4 58022.0 58294.4 58405.7 58417.7 15514.0 15755.8 15786.6 15789.1 15793.8 9962.6 10095.8 11470.8 11802.2 11926.5 18210.4 18450.2 18522.3 18551.8 18586.0 7124.9 7411.6 7439.8 7467.5 7493.8 902.4 912.8 968.7 970.4 1058.6 28567.4 28789.4 28824.3 29144.9 29334.9 1037.6 1073.2 1088.4 1099.0 1109.8 14386.7 15063.7 15153.8 15218.7 15403.2 301045.0 301236.0 302347.0 302662.0 303539.0 51507.5 51509.0 51717.7 51743.0 51786.7 1349.9 1383.4 1399.7 1400.4 1405.4 27363.6 28663.6 29099.0 29224.6 29250.6 45474.8 45618.0 45763.3 45820.3 45822.0 289418.0 289581.0 290060.0 290623.0 365136.4 31137.4 31256.2 31356.0 31618.2 31750.0 39612.8 40386.0 40658.6 40689.2 41141.4 33745.5 34001.7 34126.5 34250.3 34687.0 33715.7 34297.7 34329.7 34376.7 34670.0 33341.8 33620.8 34146.5 34449.0 34473.7 29370.0 29624.0 30546.0 30916.8 30933.0 22973.9 23523.3 23530.8 23585.6 23779.0 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#2] jquery.html Cycles:180 Average:23249.40 Median:25998.93 stddev:61738.57 (237.5%) stddev-sans-first:61887.81 07:19:00 INFO - PROCESS | 13662 | Values: 344.1 347.9 349.2 352.4 354.9 15638.9 16015.4 16605.3 16611.3 16613.9 16126.1 16339.8 16750.2 16762.2 16939.2 5110.9 5135.1 5323.9 5333.5 5362.8 5295.4 5346.1 5357.2 5386.1 5387.1 5116.6 5321.4 5322.8 5323.4 5330.8 5284.8 5289.7 5318.2 5320.0 5324.3 4705.8 4732.4 4734.2 4750.5 4752.1 18109.0 19972.9 20188.6 20659.0 20716.0 2054.4 2088.8 2167.8 2202.8 2285.7 8859.7 8919.0 8970.7 9069.5 9322.9 1792.1 1829.1 1844.9 1870.3 1885.2 47265.5 48875.3 57441.7 62923.4 63753.0 9979.7 10006.1 10067.4 10143.9 10232.8 13033.5 13114.0 13187.3 13187.6 13211.8 7133.6 7358.6 7417.0 7475.5 7512.5 7255.5 7275.6 7363.5 7369.6 7376.5 4194.7 4335.6 4337.7 4402.7 4408.8 1798.3 1842.5 1863.0 1867.7 1879.4 888.4 938.6 964.2 985.6 986.1 16249.8 16745.8 17031.0 17195.6 17380.0 914.5 915.7 920.0 921.7 1006.4 9415.2 9602.0 9710.7 9832.9 9892.6 312651.0 318571.0 403799.0 410054.0 413271.0 74939.0 75074.6 78479.6 78893.2 79090.0 1040.0 1050.5 1072.2 1111.7 1112.1 15500.0 15603.8 15653.0 15899.2 15991.6 33733.0 33878.5 33915.8 34525.1 34931.0 49511.5 49570.0 49853.3 49886.8 50069.0 7272.7 7428.0 7585.2 7597.2 8019.3 9619.7 12574.4 12672.0 12726.3 12753.2 7486.3 7692.3 7787.7 8429.5 10778.2 7864.0 8009.7 8116.6 8270.8 8379.4 7804.6 7818.6 8017.9 8405.2 8468.5 10538.5 11429.6 11436.2 11443.8 11462.9 7649.2 11461.7 11624.6 11659.5 11866.3 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#3] mootools.html Cycles:180 Average:5342.77 Median:6612.32 stddev:2872.16 (43.4%) stddev-sans-first:2863.16 07:19:00 INFO - PROCESS | 13662 | Values: 1178.3 1434.8 1452.4 1628.5 1784.8 7299.3 7478.5 7481.4 7495.5 7502.3 7486.7 7597.2 7665.3 7667.1 7677.3 1821.8 2032.9 2079.1 2098.1 2110.2 2077.4 2085.9 2087.6 2094.1 2100.4 2077.2 2083.1 2116.6 2120.1 2120.4 2117.2 2125.4 2134.3 2138.9 2148.2 2071.3 2072.6 2074.1 2074.3 2074.5 7743.5 7777.9 7792.6 7794.8 7801.1 4333.7 4514.3 4514.7 4525.6 4541.6 2846.4 2922.8 2948.7 2963.2 2968.3 903.4 915.6 915.7 915.8 961.3 10756.4 10847.9 10857.3 10859.9 10860.3 3932.2 3966.7 4045.3 4055.0 4057.9 9130.5 9171.4 9212.6 9220.6 9222.2 3987.5 4579.9 4591.3 4593.3 4594.9 3905.1 3911.0 3972.6 3975.0 3986.5 3369.0 3395.0 3430.9 3452.3 3452.9 1069.9 1075.8 1087.0 1088.5 1097.4 912.5 920.9 926.2 929.9 1127.9 7414.6 7459.3 7460.2 7500.5 7501.9 431.1 438.3 1186.2 1191.5 1214.5 5694.3 5756.7 5795.0 5799.9 5807.2 8897.5 9002.1 9026.2 9039.8 9140.7 8972.0 8985.2 9140.7 9155.0 9157.2 7003.2 7019.3 7072.6 7079.7 7154.0 7251.6 7262.2 7273.9 7277.2 7278.9 8208.3 8332.3 8452.2 8556.7 8596.3 8558.6 8564.2 8651.5 8725.0 8730.3 6011.1 6551.7 6642.0 6736.7 6804.1 7358.8 7369.9 7401.4 7407.0 7423.3 6561.3 6739.2 6753.7 6862.1 6887.9 6611.4 6613.2 6648.9 6686.8 6767.2 7099.7 7155.1 7222.4 7224.2 7232.6 6568.3 6629.9 6644.8 6648.9 6656.6 6416.4 6479.1 6488.1 6489.4 6494.3 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#4] prototype.html Cycles:180 Average:5094.03 Median:5849.92 stddev:1571.92 (26.9%) stddev-sans-first:1534.69 07:19:00 INFO - PROCESS | 13662 | Values: 305.6 310.7 319.8 322.5 323.4 5661.6 5825.3 5842.6 5849.2 5871.9 5682.3 5788.6 5802.1 5809.7 5813.3 4163.9 4279.2 4292.9 4385.3 4398.1 4265.1 4289.8 4369.3 4373.5 4386.4 4320.6 4322.5 4323.3 4327.3 4334.5 4144.6 4240.2 4329.2 4331.7 4345.7 3702.5 3731.7 3734.0 3734.6 3741.4 5424.6 5501.8 5517.0 5522.3 5524.1 5037.8 5041.6 5046.3 5046.4 5053.7 6073.6 6075.4 6083.3 6083.5 6087.2 4169.0 4170.4 4171.0 4172.1 4172.2 6103.3 6194.3 6300.1 6315.7 6316.9 4151.1 4167.0 4187.6 4190.4 4208.5 4277.5 4294.4 4298.8 4302.6 4303.8 5010.4 5014.9 5023.4 5027.8 5032.1 6088.9 6142.4 6147.0 6149.5 6150.2 1447.3 1482.6 1505.8 1506.9 1508.2 967.7 993.4 1005.2 1013.8 1014.9 5671.3 5752.9 5764.9 5846.5 5850.6 6241.7 6241.8 6242.9 6258.5 6259.8 5858.8 5897.6 5916.5 5917.5 5921.6 3371.5 3408.0 3410.6 3413.8 3415.1 6535.0 6701.8 6706.0 6707.1 6709.7 6420.4 6462.7 6489.4 6497.5 6525.1 6662.3 6670.0 6671.7 6674.8 6680.6 6271.0 6278.3 6311.9 6330.5 6340.6 6274.6 6279.4 6284.3 6286.7 6297.1 6533.9 6667.7 6686.9 6689.9 6694.1 4212.1 4227.4 4230.2 4232.4 4235.6 6278.1 6305.7 6323.7 6332.9 6337.7 6132.7 6136.0 6136.7 6138.7 6140.3 5941.4 6115.9 6132.7 6135.8 6143.3 5976.2 6015.7 6020.5 6025.8 6032.8 6056.7 6066.1 6086.3 6094.2 6094.6 6018.3 6083.9 6088.6 6089.2 6090.3 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | [#5] yui.html Cycles:180 Average:13527.66 Median:50493.00 stddev:15753.14 (31.2%) stddev-sans-first:15767.96 07:19:00 INFO - PROCESS | 13662 | Values: 718.5 721.8 820.8 848.2 865.4 13629.7 13833.2 13894.2 13904.8 13947.2 12726.0 13304.8 13718.4 13765.0 13825.4 787.9 793.3 796.0 800.4 801.3 807.5 810.6 810.8 811.4 811.7 850.7 852.7 852.7 854.0 854.1 840.6 841.6 842.1 842.5 842.5 632.1 632.6 632.6 632.6 632.9 12128.2 12176.6 12201.3 12204.8 12213.1 11527.4 11663.2 11663.3 11698.5 11715.6 9214.5 9455.1 9469.7 9477.4 9525.0 3607.4 3678.3 3693.3 3698.8 3800.4 50382.0 50604.0 50775.0 50812.0 51057.0 8287.8 8528.7 8575.7 9051.3 9147.9 17490.3 17514.5 17560.6 17570.3 17584.9 6008.6 6061.5 6841.6 7030.1 7173.9 3939.7 3994.9 4043.8 4050.2 4127.8 3013.2 3053.2 3054.5 3060.7 3062.6 501.7 516.3 522.4 523.6 527.5 647.5 663.8 665.6 669.6 677.7 8071.6 8417.3 8490.0 8523.1 8773.8 470.2 595.0 634.6 670.5 687.1 3840.8 3889.7 3893.7 3918.8 3992.5 55415.4 55533.7 55622.7 55686.2 55767.0 45001.8 46938.5 50701.7 50995.5 51415.0 40985.2 45872.3 45908.8 46075.8 46898.8 8649.3 8711.9 8755.6 8889.2 8918.4 34062.0 34490.8 34939.0 35127.3 35374.8 42503.6 44129.0 44278.0 44402.8 44617.3 10684.1 10777.7 10849.5 10870.6 11076.3 11817.9 11820.9 11837.0 11854.2 12686.2 11212.9 11354.7 11406.4 11423.5 11825.2 10091.3 10579.7 11384.7 11430.7 11717.2 10793.5 11065.1 11084.9 11300.3 11423.0 9754.9 9759.1 9890.3 9919.3 10194.6 8829.8 9072.9 9676.0 9718.9 9883.8 07:19:00 INFO - PROCESS | 13662 | -------- Summary: end -------- 07:19:00 INFO - PROCESS | 13662 | 07:19:00 INFO - PROCESS | 13662 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:00 INFO - PROCESS | 13662 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:00 INFO - PROCESS | 13662 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:00 INFO - PROCESS | 13662 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:00 INFO - PROCESS | 13662 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:00 INFO - TEST-INFO | 13662: exit 0 07:19:00 INFO - TEST-OK | dromaeo_css | took 1112846ms 07:19:00 INFO - TEST-START | kraken 07:19:00 INFO - operating with platform_type : linux_ 07:19:00 INFO - Initialising browser for kraken test... 07:19:00 INFO - TEST-INFO | started process 13856 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGfEbVq/profile http://localhost:36501/getInfo.html) 07:19:05 INFO - PROCESS | 13856 | __metrics Screen width/height:1600/1200 07:19:05 INFO - PROCESS | 13856 | colorDepth:24 07:19:05 INFO - PROCESS | 13856 | Browser inner width/height: 1024/697 07:19:05 INFO - PROCESS | 13856 | __metrics 07:19:06 INFO - PROCESS | 13856 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:19:06 INFO - PROCESS | 13856 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:19:06 INFO - TEST-INFO | 13856: exit 0 07:19:06 INFO - Browser initialized. 07:19:06 INFO - Running cycle 1/1 for kraken test... 07:19:06 INFO - TEST-INFO | started process 13942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGfEbVq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:18 INFO - PROCESS | 13942 | RSS: Main: 153534464 07:19:18 INFO - PROCESS | 13942 | 07:19:21 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36501/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:21 INFO - PROCESS | 13942 | RSS: Main: 194732032 07:19:21 INFO - PROCESS | 13942 | 07:19:24 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36501/tests/kraken/driver.html?testName=audio-dft) 07:19:24 INFO - PROCESS | 13942 | RSS: Main: 184676352 07:19:24 INFO - PROCESS | 13942 | 07:19:27 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36501/tests/kraken/driver.html?testName=audio-fft) 07:19:28 INFO - PROCESS | 13942 | RSS: Main: 170520576 07:19:28 INFO - PROCESS | 13942 | 07:19:30 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36501/tests/kraken/driver.html?testName=audio-oscillator) 07:19:30 INFO - PROCESS | 13942 | RSS: Main: 172068864 07:19:30 INFO - PROCESS | 13942 | 07:19:33 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:33 INFO - PROCESS | 13942 | RSS: Main: 174710784 07:19:33 INFO - PROCESS | 13942 | 07:19:36 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36501/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:37 INFO - PROCESS | 13942 | RSS: Main: 175763456 07:19:37 INFO - PROCESS | 13942 | 07:19:40 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36501/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:41 INFO - PROCESS | 13942 | RSS: Main: 176181248 07:19:41 INFO - PROCESS | 13942 | 07:19:44 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36501/tests/kraken/driver.html?testName=json-parse-financial) 07:19:44 INFO - PROCESS | 13942 | RSS: Main: 175390720 07:19:44 INFO - PROCESS | 13942 | 07:19:46 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:46 INFO - PROCESS | 13942 | RSS: Main: 185454592 07:19:46 INFO - PROCESS | 13942 | 07:19:48 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:49 INFO - PROCESS | 13942 | RSS: Main: 182923264 07:19:49 INFO - PROCESS | 13942 | 07:19:51 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:52 INFO - PROCESS | 13942 | RSS: Main: 194945024 07:19:52 INFO - PROCESS | 13942 | 07:19:54 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:55 INFO - PROCESS | 13942 | RSS: Main: 200069120 07:19:55 INFO - PROCESS | 13942 | 07:19:57 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:58 INFO - PROCESS | 13942 | RSS: Main: 200761344 07:19:58 INFO - PROCESS | 13942 | 07:19:59 INFO - PROCESS | 13942 | Cycle 1(1): loaded http://localhost:36501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36501/tests/kraken/driver.html?testName=ai-astar) 07:20:00 INFO - PROCESS | 13942 | RSS: Main: 259985408 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | __start_tp_report 07:20:00 INFO - PROCESS | 13942 | _x_x_mozilla_page_load 07:20:00 INFO - PROCESS | 13942 | _x_x_mozilla_page_load_details 07:20:00 INFO - PROCESS | 13942 | |i|pagename|runs| 07:20:00 INFO - PROCESS | 13942 | |0;ai-astar;110;112;106;111;111;113;102;111;111;110 07:20:00 INFO - PROCESS | 13942 | |1;audio-beat-detection;152;124;152;165;130;153;150;126;170;132 07:20:00 INFO - PROCESS | 13942 | |2;audio-dft;160;162;161;160;161;161;162;165;162;162 07:20:00 INFO - PROCESS | 13942 | |3;audio-fft;72;73;97;94;72;72;72;125;91;74 07:20:00 INFO - PROCESS | 13942 | |4;audio-oscillator;96;96;137;95;95;97;144;96;95;150 07:20:00 INFO - PROCESS | 13942 | |5;imaging-gaussian-blur;119;115;115;115;115;115;115;114;115;115 07:20:00 INFO - PROCESS | 13942 | |6;imaging-darkroom;146;145;146;146;146;146;145;145;146;147 07:20:00 INFO - PROCESS | 13942 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;97 07:20:00 INFO - PROCESS | 13942 | |8;json-parse-financial;58;61;56;56;58;56;58;66;55;56 07:20:00 INFO - PROCESS | 13942 | |9;json-stringify-tinderbox;69;69;68;69;68;68;68;68;69;68 07:20:00 INFO - PROCESS | 13942 | |10;stanford-crypto-aes;82;81;90;83;82;82;82;83;83;81 07:20:00 INFO - PROCESS | 13942 | |11;stanford-crypto-ccm;118;124;119;119;116;120;126;119;119;115 07:20:00 INFO - PROCESS | 13942 | |12;stanford-crypto-pbkdf2;160;142;152;164;152;149;163;153;145;143 07:20:00 INFO - PROCESS | 13942 | |13;stanford-crypto-sha256-iterative;69;70;71;72;70;70;68;70;69;69 07:20:00 INFO - PROCESS | 13942 | __end_tp_report 07:20:00 INFO - PROCESS | 13942 | __start_cc_report 07:20:00 INFO - PROCESS | 13942 | _x_x_mozilla_cycle_collect,1096 07:20:00 INFO - PROCESS | 13942 | __end_cc_report 07:20:00 INFO - PROCESS | 13942 | __startTimestamp1456759200184__endTimestamp 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | ------- Summary: start ------- 07:20:00 INFO - PROCESS | 13942 | Number of tests: 14 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:3.46 07:20:00 INFO - PROCESS | 13942 | Values: 110.0 112.0 106.0 111.0 111.0 113.0 102.0 111.0 111.0 110.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:152.00 stddev:16.35 (10.8%) stddev-sans-first:17.17 07:20:00 INFO - PROCESS | 13942 | Values: 152.0 124.0 152.0 165.0 130.0 153.0 150.0 126.0 170.0 132.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 07:20:00 INFO - PROCESS | 13942 | Values: 160.0 162.0 161.0 160.0 161.0 161.0 162.0 165.0 162.0 162.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#3] audio-fft Cycles:10 Average:84.20 Median:73.50 stddev:17.62 (24.0%) stddev-sans-first:18.13 07:20:00 INFO - PROCESS | 13942 | Values: 72.0 73.0 97.0 94.0 72.0 72.0 72.0 125.0 91.0 74.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:95.50 stddev:23.37 (24.5%) stddev-sans-first:24.23 07:20:00 INFO - PROCESS | 13942 | Values: 96.0 96.0 137.0 95.0 95.0 97.0 144.0 96.0 95.0 150.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.34 (1.2%) stddev-sans-first:0.33 07:20:00 INFO - PROCESS | 13942 | Values: 119.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:20:00 INFO - PROCESS | 13942 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 147.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:20:00 INFO - PROCESS | 13942 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 97.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:3.30 (5.7%) stddev-sans-first:3.50 07:20:00 INFO - PROCESS | 13942 | Values: 58.0 61.0 56.0 56.0 58.0 56.0 58.0 66.0 55.0 56.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:20:00 INFO - PROCESS | 13942 | Values: 69.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.60 (3.2%) stddev-sans-first:2.74 07:20:00 INFO - PROCESS | 13942 | Values: 82.0 81.0 90.0 83.0 82.0 82.0 82.0 83.0 83.0 81.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:119.00 stddev:3.31 (2.8%) stddev-sans-first:3.46 07:20:00 INFO - PROCESS | 13942 | Values: 118.0 124.0 119.0 119.0 116.0 120.0 126.0 119.0 119.0 115.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:152.50 stddev:7.94 (5.2%) stddev-sans-first:7.92 07:20:00 INFO - PROCESS | 13942 | Values: 160.0 142.0 152.0 164.0 152.0 149.0 163.0 153.0 145.0 143.0 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.17 07:20:00 INFO - PROCESS | 13942 | Values: 69.0 70.0 71.0 72.0 70.0 70.0 68.0 70.0 69.0 69.0 07:20:00 INFO - PROCESS | 13942 | -------- Summary: end -------- 07:20:00 INFO - PROCESS | 13942 | 07:20:00 INFO - PROCESS | 13942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:20:00 INFO - PROCESS | 13942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:20:00 INFO - PROCESS | 13942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:20:00 INFO - PROCESS | 13942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:20:00 INFO - PROCESS | 13942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 07:20:01 INFO - TEST-INFO | 13942: exit 0 07:20:01 INFO - TEST-OK | kraken | took 60274ms 07:20:01 INFO - SUITE-END | took 1173s 07:20:01 INFO - Completed test suite (00:19:33) 07:20:01 INFO - Working with test: dromaeo_css 07:20:01 INFO - Generating results file: dromaeo_css 07:20:01 INFO - Working with test: kraken 07:20:01 INFO - Generating results file: kraken 07:20:01 INFO - javascript benchmark 07:20:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:20:01 INFO - process_Request line: dromaeo_css 6666.66 graph.html#tests=[[72,1,35]] 07:20:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:20:01 INFO - process_Request line: kraken 1519.00 graph.html#tests=[[232,1,35]] 07:20:01 INFO - RETURN: dromaeo_css: 6666.66 07:20:01 INFO - RETURN: kraken: 1519.00 07:20:01 INFO - javascript benchmark 07:20:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3075.923101922452, 3110.471219892618, 3149.7637677174203, 3160.936781264375, 3184.79298845575, 4907.484714105021, 4960.826371077013, 4982.825601103962, 5028.522290382408, 5043.873903152418, 4929.901401971958, 4993.625478089149, 5021.071101846152, 5028.7485625718755, 5037.06814239365, 4507.526709695484, 4520.073384956085, 4625.375574297477, 4658.510856360084, 4724.716517008973, 4636.188666983265, 4645.210314246569, 4689.859304220862, 4690.390249267591, 4736.171170045245, 4424.402705634747, 4451.977740111295, 4516.18708632446, 4519.118771839492, 4592.357070010201, 4502.684812063157, 4539.795709193061, 4543.0459603483305, 4552.817887284505, 4564.406627138484, 4503.392042074311, 4518.593326600589, 4524.61540769035, 4541.818327266906, 4546.499885012679, 4850.078485087822, 4880.145974454456, 4885.36490256268, 4896.877578060541, 4901.852944411673, 5369.677819330814, 5388.91916621251, 5389.757460914268, 5448.210009548633, 5451.127819548893, 5340.198970154508, 5351.678899266018, 5355.410904800468, 5358.223057656657, 5358.97320513395, 4929.975350123263, 4971.477994810565, 5010.599152067826, 5016.698998060128, 5061.16490779021, 5373.9731301343245, 5376.758045887945, 5379.596530260246, 5407.972960135174, 5428.0, 5183.922241166386, 5189.143791274473, 5195.220716892421, 5202.115640341151, 5232.2674825524455, 5203.7918483261, 5255.369355677343, 5288.8413347599635, 5341.198820177005, 5375.059364611177, 5356.544693701079, 5372.516473517402, 5377.596680248997, 5378.811741589026, 5379.677219366772, 5319.654222475527, 5343.545798607084, 5344.278522399426, 5344.385395679469, 5395.81114660985, 3996.800159991989, 4094.0583665757044, 4119.258533464005, 4172.144710334374, 4181.435506206684, 3742.73800833939, 3745.3445647011663, 3759.1353988582778, 3785.886423407302, 3796.487474190949, 5100.51545103222, 5117.897642047213, 5125.077486052546, 5132.358455193101, 5175.81884634036, 5200.063988482034, 5294.682319060792, 5303.7348132593215, 5357.0, 5368.32895888014, 5088.084144853962, 5098.209777484496, 5114.130597798383, 5123.897522049539, 5166.095933211673, 4447.644188464915, 4603.033362993742, 4629.537046295411, 4632.814687412466, 4665.790039448233, 5503.11950087984, 5520.392756796829, 5549.556035517149, 5589.580781441408, 5609.607327487037, 5244.632875698664, 5261.500157485033, 5261.979734065677, 5263.973680131575, 5277.630565860353, 5437.646552974044, 5510.586705996986, 5518.0, 5589.860253493695, 5660.547156227574, 5330.733463326741, 5349.786008559614, 5351.438098999549, 5374.677519348852, 5396.028714831368, 5392.595555333287, 5393.784248630168, 5417.83746487606, 5422.674639521641, 5475.151351540518, 5069.0, 5174.353205849269, 5241.659292145999, 5283.418823929288, 5308.761105750174, 5210.088234558862, 5234.319538459976, 5236.240745092016, 5244.344456942882, 5262.342207224097, 5083.898322033465, 5086.567641750345, 5112.693238405707, 5135.409427915837, 5174.637775355689, 5091.465396133501, 5098.592112631055, 5180.171172612364, 5199.532042116228, 5259.39516955555, 5069.518395752398, 5116.769745361393, 5154.175331946871, 5159.871003224949, 5195.376554813447], "unit": "score", "name": "dojo.html", "value": 4946.250735543841}, {"lowerIsBetter": false, "replicates": [511.7390131033173, 520.6875874475315, 523.829755329518, 546.9644473109245, 547.2557322042022, 28846.134615961502, 35808.462873056924, 36160.63839361606, 36246.275074498495, 36312.0, 39660.60339396605, 39868.202635947266, 40068.0, 40085.0, 40156.397654035216, 8301.667933282677, 8606.956965215166, 8609.827803443928, 8611.095834937336, 8614.483131012159, 8552.5296108714, 8699.260562852134, 8718.38971272008, 8722.781930451725, 8723.781905452382, 8656.8701469478, 8729.694460693878, 8745.737627871174, 8749.431286966326, 8750.6937257196, 8617.784555386103, 8626.439281446686, 8670.523121228392, 8696.565171741418, 8696.739097827076, 8614.698485552975, 8725.650973961034, 8728.127187281285, 8731.388802783807, 8759.956200219021, 37891.62108378936, 38264.0, 38367.616323836686, 38395.0, 38397.80801096005, 3290.50642403639, 3300.405926933151, 3748.1379282765115, 3798.582155962842, 4055.3105971984833, 29649.555256670952, 29819.552706709415, 29992.250193745112, 30039.849800750857, 31281.687183128106, 3386.8306584670913, 3407.71034462071, 3432.7940323580665, 3492.1444246159854, 3599.046252743025, 252028.83769298595, 255160.0, 255199.72400138067, 255665.0, 256378.0, 51019.489805101475, 55698.72150639221, 56895.431045689016, 57065.0, 57106.71446642823, 57720.42279577234, 58022.0, 58294.376753046214, 58405.70797145987, 58417.707911461024, 15514.0, 15755.763663545056, 15786.605334866721, 15789.131597762233, 15793.842061579468, 9962.551685174185, 10095.798084038279, 11470.827937580943, 11802.232854864405, 11926.522939082513, 18210.36263730763, 18450.16974236136, 18522.259109635732, 18551.81448185528, 18586.0, 7124.893126603105, 7411.5553066816165, 7439.776806695808, 7467.51461155034, 7493.775186744407, 902.3503077783985, 912.7535565397438, 968.651285537206, 970.4322971061866, 1058.571278632155, 28567.428651426853, 28789.424211515652, 28824.279393015342, 29144.85427572891, 29334.89311496392, 1037.6316407675167, 1073.2487258918632, 1088.4231357380602, 1098.9780204395868, 1109.7946879827095, 14386.712265754835, 15063.698726025417, 15153.848461515243, 15218.695626087638, 15403.152826594422, 301045.0, 301236.0, 302347.0, 302662.0, 303539.0, 51507.48492515102, 51509.0, 51717.7414112927, 51742.99999999925, 51786.741066294424, 1349.8795999320541, 1383.384393944685, 1399.7060617270283, 1400.4468235047302, 1405.36758458694, 27363.58954615722, 28663.574684352807, 29099.0, 29224.56163157597, 29250.561241581818, 45474.77262613798, 45618.0, 45763.31355029744, 45820.31269531026, 45822.0, 289418.0, 289581.0, 290060.0, 290623.0, 365136.44044917665, 31137.37725245437, 31256.21859453441, 31356.0, 31618.209544761565, 31750.0, 39612.80193599014, 40386.0, 40658.59341406548, 40689.18621627492, 41141.382879257435, 33745.49381759325, 34001.65998340084, 34126.488102677984, 34250.31499369949, 34687.0, 33715.662843372236, 34297.65702342945, 34329.65670343365, 34376.656233437345, 34670.0, 33341.83329083339, 33620.831895841344, 34146.48780268248, 34449.0, 34473.65526344805, 29370.0, 29624.0, 30546.0, 30916.845415772776, 30933.0, 22973.88513057424, 23523.303127886233, 23530.76469235286, 23585.646215307126, 23779.0], "unit": "score", "name": "ext.html", "value": 17967.391328623216}, {"lowerIsBetter": false, "replicates": [344.1104744236151, 347.860855657737, 349.24388698467817, 352.4061955604806, 354.90417587251426, 15638.921805390972, 16015.439459618916, 16605.335786568554, 16611.252493637785, 16613.916930415347, 16126.113063781488, 16339.83660163398, 16750.162491875417, 16762.239964803703, 16939.153042347894, 5110.948890511103, 5135.12702840518, 5323.893522129555, 5333.519983201511, 5362.8123015694455, 5295.391030031538, 5346.117890548055, 5357.196420536911, 5386.084365657847, 5387.084195686723, 5116.565091967187, 5321.4412486688925, 5322.8137015204475, 5323.414424413311, 5330.813421530247, 5284.841454756363, 5289.709066001368, 5318.175682769177, 5320.0157970775335, 5324.281222035014, 4705.764711764398, 4732.384789977315, 4734.19518681825, 4750.524947505256, 4752.120857641347, 18109.0, 19972.90013549923, 20188.596228075505, 20659.0, 20716.0, 2054.41449186981, 2088.7702352741185, 2167.826573874086, 2202.7994742865176, 2285.6914316567218, 8859.689910853089, 8919.0, 8970.686025989058, 9069.455832650063, 9322.906770932272, 1792.1308165539704, 1829.1494455078318, 1844.9169787359467, 1870.326682394337, 1885.208212550732, 47265.479749527636, 48875.266870996966, 57441.71279143619, 62923.37076629221, 63753.04370434447, 9979.700608981742, 10006.099451049295, 10067.395956242648, 10143.898561014295, 10232.795344093076, 13033.478660853649, 13114.0, 13187.274699891406, 13187.60437186886, 13211.801822972662, 7133.607651579109, 7358.632068396666, 7417.0, 7475.514091584029, 7512.474126811071, 7255.52839065459, 7275.599842008741, 7363.521371110861, 7369.557826530426, 7376.450945301547, 4194.706370554093, 4335.609795118455, 4337.652987760972, 4402.669799765031, 4408.845690400884, 1798.3256278895415, 1842.4564753397513, 1862.9906850465932, 1867.6544839204519, 1879.4361691492497, 888.4225253585221, 938.6198589571235, 964.2093483343591, 985.6451677396132, 986.0533887467967, 16249.837501625068, 16745.832541674426, 17031.0, 17195.57011074708, 17380.0, 914.492456686532, 915.665781989569, 919.9586018629178, 921.6774129054777, 1006.3710181136789, 9415.199708024895, 9601.951990240004, 9710.70867873965, 9832.869220039644, 9892.604295828087, 312651.0, 318571.0, 403799.0, 410054.0, 413271.0, 74939.0, 75074.62462687651, 78479.60760196163, 78893.21106788973, 79090.0, 1039.9948000259951, 1050.5062620568322, 1072.1583556907947, 1111.716512289361, 1112.1492058575197, 15499.965033917082, 15603.765943510629, 15653.0, 15899.205039747734, 15991.600209994844, 33733.0, 33878.491822622185, 33915.830420847735, 34525.13687157841, 34931.0, 49511.50488495069, 49570.0, 49853.25220121629, 49886.750566246934, 50069.0, 7272.7454539093, 7427.962860185665, 7585.2035536267895, 7597.240275972579, 8019.318357939641, 9619.663311784054, 12574.37128143571, 12672.0, 12726.300053497147, 12753.171043882117, 7486.326230639269, 7692.307692307719, 7787.688492460238, 8429.452085614415, 10778.191635627203, 7864.0, 8009.7172305892545, 8116.553589552631, 8270.83458330818, 8379.413441059067, 7804.648790804314, 7818.631739445461, 8017.8797318039105, 8405.201505856934, 8468.49189048659, 10538.473076346, 11429.59996400122, 11436.199466037298, 11443.828342574701, 11462.885371146182, 7649.158592554926, 11461.713457163638, 11624.593139240085, 11659.475323610628, 11866.347350895438], "unit": "score", "name": "jquery.html", "value": 8144.186112884246}, {"lowerIsBetter": false, "replicates": [1178.2694729267855, 1434.799128122063, 1452.397255139117, 1628.4951664983855, 1784.8215178482146, 7299.270072992705, 7478.513896596717, 7481.438892083088, 7495.512791668538, 7502.287282708147, 7486.663100160492, 7597.2402759724, 7665.310122089011, 7667.079950405959, 7677.270659287373, 1821.772278465192, 2032.8983550822475, 2079.1059844266997, 2098.08733201058, 2110.2297661353573, 2077.428707105543, 2085.8539902206853, 2087.561612061469, 2094.1309356616985, 2100.411884672294, 2077.221042109209, 2083.052211243888, 2116.555523340093, 2120.0883620043373, 2120.39568722914, 2117.2060477321006, 2125.38363874477, 2134.3063504361144, 2138.871667699943, 2148.151480165334, 2071.337172104927, 2072.58548290341, 2074.1392322186425, 2074.263636409068, 2074.522859742268, 7743.457957942946, 7777.883331750028, 7792.571408572526, 7794.844103117963, 7801.1028731696015, 4333.739975601443, 4514.277715565494, 4514.683972121953, 4525.615322697575, 4541.636669066466, 2846.402255526342, 2922.7954043216982, 2948.7346138847392, 2963.229560314312, 2968.317287023975, 903.3549627253999, 915.5742579700404, 915.6566287642135, 915.7939463620633, 961.2550273537994, 10756.408397538133, 10847.945760271226, 10857.294275872044, 10859.891401085966, 10860.294080884796, 3932.193900250499, 3966.6628336591134, 4045.292073887058, 4054.9797251013556, 4057.9391309130388, 9130.452172869649, 9171.35800493959, 9212.585433655502, 9220.631174752934, 9222.216111630587, 3987.481627388479, 4579.9084018319445, 4591.288350305708, 4593.28804035375, 4594.908101837945, 3905.062784931653, 3910.9608903911167, 3972.5828787977425, 3975.0, 3986.4618276532296, 3368.9663103368653, 3394.9830250848586, 3430.9485357719655, 3452.3267962747527, 3452.9482057769155, 1069.8609180806445, 1075.8386242063752, 1087.037971395321, 1088.542812018938, 1097.385464140068, 912.4616476279027, 920.894097178833, 926.2266007883493, 929.8837645294338, 1127.9154063445274, 7414.6292685365515, 7459.291367320096, 7460.179380268166, 7500.549967001997, 7501.924980750232, 431.1484817485441, 438.32935608519017, 1186.1756079524648, 1191.4936152135308, 1214.4595654933469, 5694.316681998187, 5756.7121643917635, 5795.0, 5799.88400231993, 5807.245058142415, 8897.510636914902, 9002.144796244347, 9026.232770214605, 9039.774005649911, 9140.6800761973, 8972.0, 8985.236254918274, 9140.725778226664, 9155.0, 9157.175854173156, 7003.194632617212, 7019.2629773873, 7072.575645461392, 7079.716811327592, 7154.034205382311, 7251.637418129178, 7262.237465066092, 7273.854522909618, 7277.199508054216, 7278.927210727825, 8208.302294304813, 8332.333413326798, 8452.197041281068, 8556.74329770108, 8596.312295016258, 8558.614862331086, 8564.229219370287, 8651.52416617092, 8725.04024557311, 8730.301575873787, 6011.128386383863, 6551.70517326731, 6641.966790166019, 6736.730530778714, 6804.081449004321, 7358.77923662291, 7369.926300736924, 7401.4078873688895, 7407.0, 7423.331900129015, 6561.278259391559, 6739.157605299338, 6753.696083676345, 6862.142232220973, 6887.862242755016, 6611.404973552403, 6613.2394774601535, 6648.867022659617, 6686.765963191265, 6767.1879374475375, 7099.680514376969, 7155.105611798525, 7222.3860971817985, 7224.169220539705, 7232.566046037255, 6568.310327415553, 6629.900551491828, 6644.83387915306, 6648.867022659617, 6656.600603963778, 6416.390442907917, 6479.125318081999, 6488.059231411325, 6489.448396886318, 6494.2856285807575], "unit": "score", "name": "mootools.html", "value": 4299.051060044821}, {"lowerIsBetter": false, "replicates": [305.5828793696604, 310.7265606266485, 319.80971322063374, 322.47758631017757, 323.44206244228707, 5661.575381846363, 5825.271841019872, 5842.620229685072, 5849.181114643953, 5871.9412805871925, 5682.289713785777, 5788.6237394569325, 5802.100674395465, 5809.7385617647205, 5813.30240371155, 4163.875083747493, 4279.2083464559155, 4292.871213863574, 4385.298352263639, 4398.142362239365, 4265.104328091104, 4289.785510724467, 4369.279068953619, 4373.518912919576, 4386.363977223301, 4320.567943205686, 4322.524522302544, 4323.308270676693, 4327.285997810358, 4334.501532323791, 4144.585541445831, 4240.23675738367, 4329.177456283296, 4331.696781225315, 4345.739255644671, 3702.4816525686424, 3731.7201209909094, 3734.0, 3734.5705243897028, 3741.4387841823673, 5424.620276580641, 5501.834944951658, 5517.0, 5522.30971128609, 5524.06090964533, 5037.798488060474, 5041.59667226621, 5046.293518907356, 5046.419661738873, 5053.722045287508, 6073.605215660968, 6075.392460753934, 6083.300420451616, 6083.513318934519, 6087.2086628738425, 4169.0411205422615, 4170.416141740159, 4170.9582904170875, 4172.123853990665, 4172.207280616673, 6103.29812071613, 6194.349593292684, 6300.117983482316, 6315.715792789336, 6316.905246421307, 4151.107511884959, 4166.979165104155, 4187.602177793105, 4190.371444283382, 4208.452901122896, 4277.486701595766, 4294.3558466230315, 4298.828046878152, 4302.591253830881, 4303.763293018851, 5010.448850626428, 5014.89970200594, 5023.422306434733, 5027.84916452507, 5032.0690672225755, 6088.8782224356155, 6142.447179753754, 6147.0, 6149.538784591084, 6150.200473938359, 1447.2691290898028, 1482.5848762346561, 1505.8343582205948, 1506.909585424878, 1508.2232650185163, 967.6951760195657, 993.3543196922059, 1005.2460654509118, 1013.7921726046143, 1014.9238807089498, 5671.291088613923, 5752.884942301214, 5764.884702306014, 5846.532277417797, 5850.64896106235, 6241.719122639402, 6241.843953901189, 6242.875142497124, 6258.468030217391, 6259.78090766821, 5858.765649374062, 5897.5871688982215, 5916.497097746654, 5917.52659787216, 5921.585489015813, 3371.460566309379, 3408.0287118171204, 3410.5566276384407, 3413.8293085345636, 3415.0608582639975, 6535.0, 6701.832454188684, 6706.0, 6707.094542236833, 6709.664516774142, 6420.390062944013, 6462.741490340334, 6489.383508566679, 6497.545171838021, 6525.053867189231, 6662.333766623396, 6670.0, 6671.699773510204, 6674.83312917181, 6680.5991640501725, 6270.993282149669, 6278.309385967448, 6311.873762524816, 6330.461910737639, 6340.619562826245, 6274.560780745304, 6279.434850863444, 6284.277308109443, 6286.654234017173, 6297.149884765681, 6533.869322613426, 6667.733290668319, 6686.899696504459, 6689.899651505329, 6694.129763130956, 4212.073343864345, 4227.387028880857, 4230.196262710076, 4232.449781528381, 4235.618794308527, 6278.121063051268, 6305.684715764285, 6323.6838158090995, 6332.873342533216, 6337.746490140527, 6132.6627035513475, 6135.987562052212, 6136.693165341804, 6138.693065346804, 6140.263168419819, 5941.435563621449, 6115.938840611537, 6132.724027418866, 6135.754569817336, 6143.293521245114, 5976.193213916065, 6015.669138197266, 6020.54845886569, 6025.78909738157, 6032.819015429544, 6056.66688332146, 6066.059760737093, 6086.300075491198, 6094.238220222473, 6094.603850749687, 6018.307894592178, 6083.939160608337, 6088.573799833969, 6089.177960975212, 6090.330063693079], "unit": "score", "name": "prototype.html", "value": 4577.85719545566}, {"lowerIsBetter": false, "replicates": [718.4611541343992, 721.8339781850177, 820.8029724224147, 848.1815048478221, 865.4417900454205, 13629.727405451897, 13833.239171845556, 13894.23581703006, 13904.791428128587, 13947.232902190375, 12725.999999999976, 13304.800427993589, 13718.382672779724, 13765.0, 13825.446982120704, 787.8857565652977, 793.3335997761878, 795.9920400795976, 800.3597122302164, 801.3348920396057, 807.475141158246, 810.6352141536303, 810.7891948093479, 811.4319976016811, 811.6550466051934, 850.7490290364358, 852.6887685994599, 852.735651947895, 854.0050840770494, 854.0520022774715, 840.6343240690288, 841.5960339037297, 842.0653075086649, 842.4776638484179, 842.4860834890711, 632.1371328137105, 632.5540493951798, 632.5603705424732, 632.5666918161029, 632.9303776584572, 12128.151029427943, 12176.57381991626, 12201.328926909016, 12204.816927746091, 12213.084018698544, 11527.365994870279, 11663.183577149603, 11663.300201987908, 11698.47356868943, 11715.648530544097, 9214.493202873839, 9455.054494550559, 9469.66856160031, 9477.431354118775, 9524.952375238148, 3607.440846668744, 3678.319510890467, 3693.298273328059, 3698.815059247027, 3800.429935509668, 50382.0, 50604.0, 50775.0, 50812.0, 51057.0, 8287.792805179799, 8528.701495447629, 8575.656973721107, 9051.27589792815, 9147.908520914838, 17490.300387984593, 17514.47456576305, 17560.56098597545, 17570.29718811259, 17584.912075439795, 6008.609440386361, 6061.454469097803, 6841.589504629738, 7030.086088808423, 7173.856522869618, 3939.665128464055, 3994.8601798936897, 4043.7775922323967, 4050.18996200761, 4127.814248358831, 3013.2316259353724, 3053.175642576492, 3054.465468542996, 3060.709232622897, 3062.6324841018773, 501.74411050363847, 516.2776382283776, 522.3548917087394, 523.5602094240837, 527.5199568392744, 647.4658406814397, 663.7842701122155, 665.5673812022225, 669.5915491550151, 677.664556044761, 8071.5964201789675, 8417.326613870875, 8490.0, 8523.147685231428, 8773.780655483664, 470.18657722140205, 594.9613275137102, 634.5780056262626, 670.5004771445305, 687.1342108942669, 3840.7695538267794, 3889.688824894058, 3893.7079719021185, 3918.7648741075627, 3992.5208974923194, 55415.445845541835, 55533.72233138889, 55622.72188639031, 55686.16470752942, 55767.0, 45001.77499112483, 46938.530614693416, 50701.746491268044, 50995.49004509982, 51415.0, 40985.1802963945, 45872.31191532063, 45908.770456147504, 46075.76962115235, 46898.76550617293, 8649.308055355683, 8711.869321960048, 8755.562221888753, 8889.19997200255, 8918.405125313793, 34062.0, 34490.82754586211, 34939.0, 35127.29745405129, 35374.823125884206, 42503.574964249965, 44129.0, 44278.0, 44402.777986111156, 44617.33074003957, 10684.145268378355, 10777.730556736144, 10849.511771970123, 10870.619528316787, 11076.335419874833, 11817.881821182022, 11820.92705727567, 11837.0, 11854.170208085352, 12686.175398599062, 11212.943935280271, 11354.716132096764, 11406.372649504357, 11423.543058277575, 11825.231359961575, 10091.293609447268, 10579.735506612396, 11384.658460246206, 11430.657080287605, 11717.179797414099, 10793.460326983777, 11065.114790816555, 11084.889151108386, 11300.321980681185, 11423.0, 9754.878189008356, 9759.141766095747, 9890.307678462439, 9919.256055795988, 10194.592216311265, 8829.779255518664, 9072.909270907207, 9676.0, 9718.878698048176, 9883.802323953625], "unit": "score", "name": "yui.html", "value": 6162.598217926741}], "name": "dromaeo_css", "value": 6666.65613054975}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 111.0, 111.0, 113.0, 102.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [152.0, 124.0, 152.0, 165.0, 130.0, 153.0, 150.0, 126.0, 170.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 97.0, 94.0, 72.0, 72.0, 72.0, 125.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 95.0, 95.0, 97.0, 144.0, 96.0, 95.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 56.0, 56.0, 58.0, 56.0, 58.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 90.0, 83.0, 82.0, 82.0, 82.0, 83.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 119.0, 119.0, 116.0, 120.0, 126.0, 119.0, 119.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [160.0, 142.0, 152.0, 164.0, 152.0, 149.0, 163.0, 153.0, 145.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.3}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 72.0, 70.0, 70.0, 68.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1519.0}]} 07:20:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1519.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6666.66"}}} 07:20:01 INFO - Return code: 0 07:20:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:20:01 INFO - # TBPL SUCCESS # 07:20:01 INFO - Running post-action listener: _resource_record_post_action 07:20:01 INFO - Running post-run listener: _resource_record_post_run 07:20:02 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539348992; Read time: 16; Write time: 776124 07:20:02 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 240803840; Read time: 0; Write time: 504324 07:20:02 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296226816; Read time: 16; Write time: 271604 07:20:02 INFO - Running post-run listener: _upload_blobber_files 07:20:02 INFO - Blob upload gear active. 07:20:02 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:20:02 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:20:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:20:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:20:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:03 INFO - (blobuploader) - INFO - Done attempting. 07:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:04 INFO - (blobuploader) - INFO - Done attempting. 07:20:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:04 INFO - Return code: 0 07:20:04 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:20:04 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6382012b52805186921749125758850d03a3e812fc1da2679dc0fbe95600963b9e0a0368cb8c9364aafb509c261a72f43458b78964078ce16f188b7d8daeb32b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c6bcfd787b0d1d866860513863283f204727c8a540d1bd074f388bcf3f53ab271dc3e72701cfd6e342ebc6b7ec859cfc4b72be4ffd57e5ea88c82bf68b06b1"} 07:20:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:20:04 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:20:04 INFO - Contents: 07:20:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6382012b52805186921749125758850d03a3e812fc1da2679dc0fbe95600963b9e0a0368cb8c9364aafb509c261a72f43458b78964078ce16f188b7d8daeb32b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c6bcfd787b0d1d866860513863283f204727c8a540d1bd074f388bcf3f53ab271dc3e72701cfd6e342ebc6b7ec859cfc4b72be4ffd57e5ea88c82bf68b06b1"} 07:20:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:04 INFO - Copying logs to upload dir... 07:20:04 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:20:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.160831 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-29 07:20:04.433878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 07:20:04.437568) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6382012b52805186921749125758850d03a3e812fc1da2679dc0fbe95600963b9e0a0368cb8c9364aafb509c261a72f43458b78964078ce16f188b7d8daeb32b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c6bcfd787b0d1d866860513863283f204727c8a540d1bd074f388bcf3f53ab271dc3e72701cfd6e342ebc6b7ec859cfc4b72be4ffd57e5ea88c82bf68b06b1"} build_url:https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/b2-OrJOVRfuMz4eg3-g9bQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6382012b52805186921749125758850d03a3e812fc1da2679dc0fbe95600963b9e0a0368cb8c9364aafb509c261a72f43458b78964078ce16f188b7d8daeb32b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18c6bcfd787b0d1d866860513863283f204727c8a540d1bd074f388bcf3f53ab271dc3e72701cfd6e342ebc6b7ec859cfc4b72be4ffd57e5ea88c82bf68b06b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 07:20:04.465515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 07:20:04.466176) ========= 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=14ef55db36f7623abb31b9cf000001d5-1456757966.69690-757311815 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 07:20:05.074942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 07:20:05.075315) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 07:20:05.075911) ========= ========= Total master_lag: 0.81 =========