builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1456552478.0 results: success (0) buildid: 20160226193212 builduid: 5cf7a739e37643138f8b173cc86d09b3 revision: 8e93182402a9742f890c722ae8057e724105a21b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:37.999478) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.000842) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.001707) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009126 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.062868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.063419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.112535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.112858) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004704 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.167776) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.168087) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.168451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.168778) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 21:54:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-02-26 21:54:38 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.365434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.366212) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019544 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:38.420013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 21:54:38.420393) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8e93182402a9742f890c722ae8057e724105a21b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 8e93182402a9742f890c722ae8057e724105a21b --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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 21:54:38,809 truncating revision to first 12 chars 2016-02-26 21:54:38,809 Setting DEBUG logging. 2016-02-26 21:54:38,809 attempt 1/10 2016-02-26 21:54:38,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/8e93182402a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 21:54:39,974 unpacking tar archive at: mozilla-inbound-8e93182402a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.465238 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 21:54:39.902154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:39.902974) ========= echo 8e93182402a9742f890c722ae8057e724105a21b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8e93182402a9742f890c722ae8057e724105a21b'] 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8e93182402a9742f890c722ae8057e724105a21b program finished with exit code 0 elapsedTime=0.004844 script_repo_revision: '8e93182402a9742f890c722ae8057e724105a21b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:39.956155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:39.956466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 21:54:39.967613) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-26 21:54:39.968011) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:54:40 INFO - MultiFileLogger online at 20160226 21:54:40 in /builds/slave/test-pgo 21:54:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:54:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:54:40 INFO - {'append_to_log': False, 21:54:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:54:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:54:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:54:40 INFO - 'branch': 'Mozilla-Inbound', 21:54:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:54:40 INFO - 'config_files': ('talos/linux_config.py',), 21:54:40 INFO - 'default_actions': ('clobber', 21:54:40 INFO - 'read-buildbot-config', 21:54:40 INFO - 'download-and-extract', 21:54:40 INFO - 'populate-webroot', 21:54:40 INFO - 'create-virtualenv', 21:54:40 INFO - 'install', 21:54:40 INFO - 'run-tests'), 21:54:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:54:40 INFO - 'download_minidump_stackwalk': True, 21:54:40 INFO - 'download_symbols': 'ondemand', 21:54:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:54:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:54:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:54:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:54:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:54:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:54:40 INFO - 'installer_path': 'installer.exe', 21:54:40 INFO - 'log_level': 'info', 21:54:40 INFO - 'log_name': 'talos', 21:54:40 INFO - 'log_to_console': True, 21:54:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:54:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:54:40 INFO - 'opt_config_files': (), 21:54:40 INFO - 'pip_index': False, 21:54:40 INFO - 'sps_profile': False, 21:54:40 INFO - 'sps_profile_interval': 0, 21:54:40 INFO - 'suite': 'dromaeojs', 21:54:40 INFO - 'system_bits': '32', 21:54:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:54:40 INFO - 'title': 'talos-linux64-ix-020', 21:54:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:54:40 INFO - 'use_talos_json': True, 21:54:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:54:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:54:40 INFO - 'work_dir': 'build'} 21:54:40 INFO - ##### 21:54:40 INFO - ##### Running clobber step. 21:54:40 INFO - ##### 21:54:40 INFO - Running pre-action listener: _resource_record_pre_action 21:54:40 INFO - Running main action method: clobber 21:54:40 INFO - rmtree: /builds/slave/test-pgo/build 21:54:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:54:40 INFO - Running post-action listener: _resource_record_post_action 21:54:40 INFO - ##### 21:54:40 INFO - ##### Running read-buildbot-config step. 21:54:40 INFO - ##### 21:54:40 INFO - Running pre-action listener: _resource_record_pre_action 21:54:40 INFO - Running main action method: read_buildbot_config 21:54:40 INFO - Using buildbot properties: 21:54:40 INFO - { 21:54:40 INFO - "project": "", 21:54:40 INFO - "product": "firefox", 21:54:40 INFO - "script_repo_revision": "production", 21:54:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:54:40 INFO - "repository": "", 21:54:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:54:40 INFO - "buildid": "20160226193212", 21:54:40 INFO - "pgo_build": "True", 21:54:40 INFO - "basedir": "/builds/slave/test-pgo", 21:54:40 INFO - "buildnumber": 1543, 21:54:40 INFO - "slavename": "talos-linux64-ix-020", 21:54:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:54:40 INFO - "platform": "ubuntu64_hw", 21:54:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:54:40 INFO - "branch": "mozilla-inbound", 21:54:40 INFO - "repo_path": "integration/mozilla-inbound", 21:54:40 INFO - "revision": "8e93182402a9742f890c722ae8057e724105a21b", 21:54:40 INFO - "stage_platform": "linux64-pgo", 21:54:40 INFO - "builduid": "5cf7a739e37643138f8b173cc86d09b3", 21:54:40 INFO - "slavebuilddir": "test" 21:54:40 INFO - } 21:54:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:54:40 INFO - Running post-action listener: _resource_record_post_action 21:54:40 INFO - ##### 21:54:40 INFO - ##### Running download-and-extract step. 21:54:40 INFO - ##### 21:54:40 INFO - Running pre-action listener: _resource_record_pre_action 21:54:40 INFO - Running main action method: download_and_extract 21:54:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:40 INFO - https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:54:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/test_packages.json 21:54:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/test_packages.json 21:54:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:54:43 INFO - Downloaded 1448 bytes. 21:54:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:54:43 INFO - Using the following test package requirements: 21:54:43 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:54:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:54:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'jsshell-linux-x86_64.zip'], 21:54:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:54:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:54:43 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:54:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:54:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:54:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:54:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:54:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:54: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')]} 21:54:43 INFO - https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:54:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:54:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:47 INFO - Downloaded 23370843 bytes. 21:54:47 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'] 21:54:47 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 21:54:48 INFO - Return code: 0 21:54:48 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 21:54: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')]} 21:54:48 INFO - https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:54:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:54:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:54:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:50 INFO - Downloaded 23370843 bytes. 21:54:50 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'] 21:54:50 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 21:54:51 INFO - Return code: 0 21:54: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')]} 21:54:51 INFO - https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:52 INFO - Downloaded 10713410 bytes. 21:54:52 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'] 21:54:52 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 21:54:52 INFO - Return code: 0 21:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:52 INFO - https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:54:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:54:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:54:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/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 21:54:54 INFO - Downloaded 56627289 bytes. 21:54:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:54:54 INFO - mkdir: /builds/slave/test-pgo/properties 21:54:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:54:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:54:54 INFO - Contents: 21:54:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:54:54 INFO - Running post-action listener: _resource_record_post_action 21:54:54 INFO - Running post-action listener: set_extra_try_arguments 21:54:54 INFO - ##### 21:54:54 INFO - ##### Running populate-webroot step. 21:54:54 INFO - ##### 21:54:54 INFO - Running pre-action listener: _resource_record_pre_action 21:54:54 INFO - Running main action method: populate_webroot 21:54:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:54:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:54:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:54:54 INFO - '--tppagecycles', 21:54:54 INFO - '7'], 21:54:54 INFO - 'tests': ['tsvgm']}}, 21:54:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:54:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:54:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:54:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:54:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:54:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'tests': ['damp', 'tps']}, 21:54:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['damp', 'tps']}, 21:54:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:54:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:54:54 INFO - 'other': {'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'other_l64': {'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'other_nol64': {'tests': ['a11yr', 21:54:54 INFO - 'ts_paint', 21:54:54 INFO - 'tpaint', 21:54:54 INFO - 'sessionrestore', 21:54:54 INFO - 'sessionrestore_no_auto_restore']}, 21:54:54 INFO - 'svgr': {'tests': ['tsvgx', 21:54:54 INFO - 'tsvgr_opacity', 21:54:54 INFO - 'tart', 21:54:54 INFO - 'tscrollx', 21:54:54 INFO - 'cart']}, 21:54:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['tsvgx', 21:54:54 INFO - 'tsvgr_opacity', 21:54:54 INFO - 'tart', 21:54:54 INFO - 'tscrollx', 21:54:54 INFO - 'cart']}, 21:54:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'tests': ['tp5o']}, 21:54:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'talos_options': ['--e10s'], 21:54:54 INFO - 'tests': ['tp5o']}, 21:54:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'talos_options': ['--xperf_path', 21:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:54 INFO - 'tests': ['tp5n']}, 21:54:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:54:54 INFO - 'talos_options': ['--e10s', 21:54:54 INFO - '--xperf_path', 21:54:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:54:54 INFO - 'tests': ['tp5n']}}, 21:54:54 INFO - 'talos.zip': {'path': '', 21:54:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:54:54 INFO - Running post-action listener: _resource_record_post_action 21:54:54 INFO - ##### 21:54:54 INFO - ##### Running create-virtualenv step. 21:54:54 INFO - ##### 21:54:54 INFO - Running pre-action listener: _resource_record_pre_action 21:54:54 INFO - Running main action method: create_virtualenv 21:54:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:54:54 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 21:54:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:54:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:54:54 INFO - Using real prefix '/usr' 21:54:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:54:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:54:57 INFO - Installing pip.................done. 21:54:57 INFO - Return code: 0 21:54:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:54:57 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')]} 21:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:57 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')]} 21:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:57 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:54:57 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 21:54:57 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 21:54:57 INFO - Using env: {'DISPLAY': ':0', 21:54:57 INFO - 'HOME': '/home/cltbld', 21:54:57 INFO - 'LANG': 'en_US.UTF-8', 21:54:57 INFO - 'LANGUAGE': 'en_US:en', 21:54:57 INFO - 'LOGNAME': 'cltbld', 21:54:57 INFO - 'MAIL': '/var/mail/cltbld', 21:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:57 INFO - 'MOZ_NO_REMOTE': '1', 21:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:57 INFO - 'NO_EM_RESTART': '1', 21:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:57 INFO - 'SHELL': '/bin/bash', 21:54:57 INFO - 'SHLVL': '1', 21:54:57 INFO - 'TERM': 'linux', 21:54:57 INFO - 'TMOUT': '86400', 21:54:57 INFO - 'USER': 'cltbld', 21:54:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:57 INFO - '_': '/tools/buildbot/bin/python'} 21:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:57 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 21:54:57 INFO - Cleaning up... 21:54:57 INFO - Return code: 0 21:54:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:54:57 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')]} 21:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:57 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')]} 21:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:57 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:54:57 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 21:54:57 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 21:54:57 INFO - Using env: {'DISPLAY': ':0', 21:54:57 INFO - 'HOME': '/home/cltbld', 21:54:57 INFO - 'LANG': 'en_US.UTF-8', 21:54:57 INFO - 'LANGUAGE': 'en_US:en', 21:54:57 INFO - 'LOGNAME': 'cltbld', 21:54:57 INFO - 'MAIL': '/var/mail/cltbld', 21:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:57 INFO - 'MOZ_NO_REMOTE': '1', 21:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:57 INFO - 'NO_EM_RESTART': '1', 21:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:57 INFO - 'SHELL': '/bin/bash', 21:54:57 INFO - 'SHLVL': '1', 21:54:57 INFO - 'TERM': 'linux', 21:54:57 INFO - 'TMOUT': '86400', 21:54:57 INFO - 'USER': 'cltbld', 21:54:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:57 INFO - '_': '/tools/buildbot/bin/python'} 21:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:58 INFO - Downloading/unpacking psutil>=0.7.1 21:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:54:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:54:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:54:59 INFO - Installing collected packages: psutil 21:54:59 INFO - Running setup.py install for psutil 21:55:00 INFO - building 'psutil._psutil_linux' extension 21:55:00 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 21:55:00 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 21:55:00 INFO - building 'psutil._psutil_posix' extension 21:55:00 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 21:55:00 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 21:55:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:00 INFO - Successfully installed psutil 21:55:00 INFO - Cleaning up... 21:55:00 INFO - Return code: 0 21:55:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:55:00 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')]} 21:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:00 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')]} 21:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:00 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:00 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 21:55:00 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 21:55:00 INFO - Using env: {'DISPLAY': ':0', 21:55:00 INFO - 'HOME': '/home/cltbld', 21:55:00 INFO - 'LANG': 'en_US.UTF-8', 21:55:00 INFO - 'LANGUAGE': 'en_US:en', 21:55:00 INFO - 'LOGNAME': 'cltbld', 21:55:00 INFO - 'MAIL': '/var/mail/cltbld', 21:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:00 INFO - 'MOZ_NO_REMOTE': '1', 21:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:00 INFO - 'NO_EM_RESTART': '1', 21:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:00 INFO - 'SHELL': '/bin/bash', 21:55:00 INFO - 'SHLVL': '1', 21:55:00 INFO - 'TERM': 'linux', 21:55:00 INFO - 'TMOUT': '86400', 21:55:00 INFO - 'USER': 'cltbld', 21:55:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:00 INFO - '_': '/tools/buildbot/bin/python'} 21:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:55:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:55:02 INFO - Installing collected packages: mozsystemmonitor 21:55:02 INFO - Running setup.py install for mozsystemmonitor 21:55:02 INFO - Successfully installed mozsystemmonitor 21:55:02 INFO - Cleaning up... 21:55:02 INFO - Return code: 0 21:55:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:55:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:55:02 INFO - Using env: {'DISPLAY': ':0', 21:55:02 INFO - 'HOME': '/home/cltbld', 21:55:02 INFO - 'LANG': 'en_US.UTF-8', 21:55:02 INFO - 'LANGUAGE': 'en_US:en', 21:55:02 INFO - 'LOGNAME': 'cltbld', 21:55:02 INFO - 'MAIL': '/var/mail/cltbld', 21:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:02 INFO - 'MOZ_NO_REMOTE': '1', 21:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:02 INFO - 'NO_EM_RESTART': '1', 21:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:02 INFO - 'SHELL': '/bin/bash', 21:55:02 INFO - 'SHLVL': '1', 21:55:02 INFO - 'TERM': 'linux', 21:55:02 INFO - 'TMOUT': '86400', 21:55:02 INFO - 'USER': 'cltbld', 21:55:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:02 INFO - '_': '/tools/buildbot/bin/python'} 21:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:02 INFO - Downloading/unpacking blobuploader==1.2.4 21:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:55:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:55:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:55:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:05 INFO - Downloading docopt-0.6.1.tar.gz 21:55:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:55:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:55:05 INFO - Running setup.py install for blobuploader 21:55:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:55:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:55:05 INFO - Running setup.py install for requests 21:55:05 INFO - Running setup.py install for docopt 21:55:06 INFO - Successfully installed blobuploader requests docopt 21:55:06 INFO - Cleaning up... 21:55:06 INFO - Return code: 0 21:55:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:06 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:06 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 21:55:06 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 21:55:06 INFO - Using env: {'DISPLAY': ':0', 21:55:06 INFO - 'HOME': '/home/cltbld', 21:55:06 INFO - 'LANG': 'en_US.UTF-8', 21:55:06 INFO - 'LANGUAGE': 'en_US:en', 21:55:06 INFO - 'LOGNAME': 'cltbld', 21:55:06 INFO - 'MAIL': '/var/mail/cltbld', 21:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:06 INFO - 'MOZ_NO_REMOTE': '1', 21:55:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:06 INFO - 'NO_EM_RESTART': '1', 21:55:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:06 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:06 INFO - 'SHELL': '/bin/bash', 21:55:06 INFO - 'SHLVL': '1', 21:55:06 INFO - 'TERM': 'linux', 21:55:06 INFO - 'TMOUT': '86400', 21:55:06 INFO - 'USER': 'cltbld', 21:55:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:06 INFO - '_': '/tools/buildbot/bin/python'} 21:55:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:55:06 INFO - Running setup.py (path:/tmp/pip-6KLxYJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:55:06 INFO - Running setup.py (path:/tmp/pip-_TVVo5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:55:06 INFO - Running setup.py (path:/tmp/pip-zZ2XZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:55:06 INFO - Running setup.py (path:/tmp/pip-gsy4Hv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:55:06 INFO - Running setup.py (path:/tmp/pip-4LVZHg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:55:06 INFO - Running setup.py (path:/tmp/pip-RBWLku-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:55:06 INFO - Running setup.py (path:/tmp/pip-YTeSck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:06 INFO - Running setup.py (path:/tmp/pip-p9kQlb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:06 INFO - Running setup.py (path:/tmp/pip-qQ02Fe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:06 INFO - Running setup.py (path:/tmp/pip-N1CkSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:07 INFO - Running setup.py (path:/tmp/pip-y2jXbs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:07 INFO - Running setup.py (path:/tmp/pip-Vrdpt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:07 INFO - Running setup.py (path:/tmp/pip-izc2zF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:07 INFO - Running setup.py (path:/tmp/pip-XOhyYe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:07 INFO - Running setup.py (path:/tmp/pip-hvNoty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:07 INFO - Running setup.py (path:/tmp/pip-OmhAZd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:07 INFO - Running setup.py (path:/tmp/pip-XkK9xJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:55:07 INFO - Running setup.py install for manifestparser 21:55:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:55:07 INFO - Running setup.py install for mozcrash 21:55:07 INFO - Running setup.py install for mozdebug 21:55:07 INFO - Running setup.py install for mozdevice 21:55:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:55:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:55:07 INFO - Running setup.py install for mozfile 21:55:08 INFO - Running setup.py install for mozhttpd 21:55:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for mozinfo 21:55:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for mozInstall 21:55:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for mozleak 21:55:08 INFO - Running setup.py install for mozlog 21:55:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for moznetwork 21:55:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for mozprocess 21:55:08 INFO - Running setup.py install for mozprofile 21:55:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:55:08 INFO - Running setup.py install for mozrunner 21:55:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:55:09 INFO - Running setup.py install for mozscreenshot 21:55:09 INFO - Running setup.py install for moztest 21:55:09 INFO - Running setup.py install for mozversion 21:55:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:55:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:55:09 INFO - Cleaning up... 21:55:09 INFO - Return code: 0 21:55:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:55:09 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')]} 21:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:09 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')]} 21:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:09 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:09 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 21:55:09 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 21:55:09 INFO - Using env: {'DISPLAY': ':0', 21:55:09 INFO - 'HOME': '/home/cltbld', 21:55:09 INFO - 'LANG': 'en_US.UTF-8', 21:55:09 INFO - 'LANGUAGE': 'en_US:en', 21:55:09 INFO - 'LOGNAME': 'cltbld', 21:55:09 INFO - 'MAIL': '/var/mail/cltbld', 21:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:09 INFO - 'MOZ_NO_REMOTE': '1', 21:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:09 INFO - 'NO_EM_RESTART': '1', 21:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:09 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:09 INFO - 'SHELL': '/bin/bash', 21:55:09 INFO - 'SHLVL': '1', 21:55:09 INFO - 'TERM': 'linux', 21:55:09 INFO - 'TMOUT': '86400', 21:55:09 INFO - 'USER': 'cltbld', 21:55:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:09 INFO - '_': '/tools/buildbot/bin/python'} 21:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:55:09 INFO - Running setup.py (path:/tmp/pip-G6NOHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:55:09 INFO - Running setup.py (path:/tmp/pip-Wo4EV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:55:09 INFO - Running setup.py (path:/tmp/pip-8WibU9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:55:09 INFO - Running setup.py (path:/tmp/pip-9pBzXE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:55:09 INFO - Running setup.py (path:/tmp/pip-RFsG9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:55:09 INFO - Running setup.py (path:/tmp/pip-AmQzi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:55:09 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)) 21:55:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:55:09 INFO - Running setup.py (path:/tmp/pip-WkImNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:10 INFO - Running setup.py (path:/tmp/pip-XxwGLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:10 INFO - Running setup.py (path:/tmp/pip-bOTFQ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:10 INFO - Running setup.py (path:/tmp/pip-aiADKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:10 INFO - Running setup.py (path:/tmp/pip-K9roGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:10 INFO - Running setup.py (path:/tmp/pip-UwPEYs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:10 INFO - Running setup.py (path:/tmp/pip-8aQkkz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:10 INFO - Running setup.py (path:/tmp/pip-VfQuJe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:10 INFO - Running setup.py (path:/tmp/pip-aBA7eR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:10 INFO - Running setup.py (path:/tmp/pip-va0u7c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:55:10 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)) 21:55:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:10 INFO - Running setup.py (path:/tmp/pip-iEd5NE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:55:10 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)) 21:55:10 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)) 21:55:10 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)) 21:55:10 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)) 21:55:10 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)) 21:55:10 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)) 21:55:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:55:10 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 21:55:10 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 21:55:10 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 21:55:10 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 21:55:10 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 21:55:10 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 21:55:12 INFO - Downloading blessings-1.6.tar.gz 21:55:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:55:12 INFO - Installing collected packages: blessings 21:55:12 INFO - Running setup.py install for blessings 21:55:12 INFO - Successfully installed blessings 21:55:12 INFO - Cleaning up... 21:55:12 INFO - Return code: 0 21:55:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:55:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:55:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:55:13 INFO - Reading from file tmpfile_stdout 21:55:13 INFO - Current package versions: 21:55:13 INFO - argparse == 1.2.1 21:55:13 INFO - blessings == 1.6 21:55:13 INFO - blobuploader == 1.2.4 21:55:13 INFO - docopt == 0.6.1 21:55:13 INFO - manifestparser == 1.1 21:55:13 INFO - mozInstall == 1.12 21:55:13 INFO - mozcrash == 0.16 21:55:13 INFO - mozdebug == 0.1 21:55:13 INFO - mozdevice == 0.48 21:55:13 INFO - mozfile == 1.2 21:55:13 INFO - mozhttpd == 0.7 21:55:13 INFO - mozinfo == 0.9 21:55:13 INFO - mozleak == 0.1 21:55:13 INFO - mozlog == 3.1 21:55:13 INFO - moznetwork == 0.27 21:55:13 INFO - mozprocess == 0.22 21:55:13 INFO - mozprofile == 0.28 21:55:13 INFO - mozrunner == 6.11 21:55:13 INFO - mozscreenshot == 0.1 21:55:13 INFO - mozsystemmonitor == 0.0 21:55:13 INFO - moztest == 0.7 21:55:13 INFO - mozversion == 1.4 21:55:13 INFO - psutil == 3.1.1 21:55:13 INFO - requests == 1.2.3 21:55:13 INFO - wsgiref == 0.1.2 21:55:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:13 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:13 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 21:55:13 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 21:55:13 INFO - Using env: {'DISPLAY': ':0', 21:55:13 INFO - 'HOME': '/home/cltbld', 21:55:13 INFO - 'LANG': 'en_US.UTF-8', 21:55:13 INFO - 'LANGUAGE': 'en_US:en', 21:55:13 INFO - 'LOGNAME': 'cltbld', 21:55:13 INFO - 'MAIL': '/var/mail/cltbld', 21:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:13 INFO - 'MOZ_NO_REMOTE': '1', 21:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:13 INFO - 'NO_EM_RESTART': '1', 21:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:13 INFO - 'SHELL': '/bin/bash', 21:55:13 INFO - 'SHLVL': '1', 21:55:13 INFO - 'TERM': 'linux', 21:55:13 INFO - 'TMOUT': '86400', 21:55:13 INFO - 'USER': 'cltbld', 21:55:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:13 INFO - '_': '/tools/buildbot/bin/python'} 21:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 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)) 21:55:13 INFO - Cleaning up... 21:55:13 INFO - Return code: 0 21:55:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:55:13 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 21:55:13 INFO - Using env: {'DISPLAY': ':0', 21:55:13 INFO - 'HOME': '/home/cltbld', 21:55:13 INFO - 'LANG': 'en_US.UTF-8', 21:55:13 INFO - 'LANGUAGE': 'en_US:en', 21:55:13 INFO - 'LOGNAME': 'cltbld', 21:55:13 INFO - 'MAIL': '/var/mail/cltbld', 21:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:13 INFO - 'MOZ_NO_REMOTE': '1', 21:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:13 INFO - 'NO_EM_RESTART': '1', 21:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:13 INFO - 'SHELL': '/bin/bash', 21:55:13 INFO - 'SHLVL': '1', 21:55:13 INFO - 'TERM': 'linux', 21:55:13 INFO - 'TMOUT': '86400', 21:55:13 INFO - 'USER': 'cltbld', 21:55:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:13 INFO - '_': '/tools/buildbot/bin/python'} 21:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:13 INFO - Downloading/unpacking jsonschema 21:55:13 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 21:55:13 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 21:55:13 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 21:55:13 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 21:55:13 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 21:55:13 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 21:55:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:55:15 INFO - Downloading/unpacking functools32 (from jsonschema) 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 INFO - Downloading functools32-3.2.3-2.tar.gz 21:55:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:55:15 INFO - warning: no files found matching '*.txt' 21:55:15 INFO - no previously-included directories found matching 'build' 21:55:15 INFO - no previously-included directories found matching 'dist' 21:55:15 INFO - no previously-included directories found matching '.git*' 21:55:15 INFO - Installing collected packages: jsonschema, functools32 21:55:15 INFO - Running setup.py install for functools32 21:55:15 INFO - warning: no files found matching '*.txt' 21:55:15 INFO - no previously-included directories found matching 'build' 21:55:15 INFO - no previously-included directories found matching 'dist' 21:55:15 INFO - no previously-included directories found matching '.git*' 21:55:15 INFO - Successfully installed jsonschema functools32 21:55:15 INFO - Cleaning up... 21:55:15 INFO - Return code: 0 21:55:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:55:15 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')]} 21:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:15 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')]} 21:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:15 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 0x7f6362710f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe288a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef5670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', '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 21:55:15 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 21:55:15 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 21:55:15 INFO - Using env: {'DISPLAY': ':0', 21:55:15 INFO - 'HOME': '/home/cltbld', 21:55:15 INFO - 'LANG': 'en_US.UTF-8', 21:55:15 INFO - 'LANGUAGE': 'en_US:en', 21:55:15 INFO - 'LOGNAME': 'cltbld', 21:55:15 INFO - 'MAIL': '/var/mail/cltbld', 21:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:15 INFO - 'MOZ_NO_REMOTE': '1', 21:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:15 INFO - 'NO_EM_RESTART': '1', 21:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:15 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:15 INFO - 'SHELL': '/bin/bash', 21:55:15 INFO - 'SHLVL': '1', 21:55:15 INFO - 'TERM': 'linux', 21:55:15 INFO - 'TMOUT': '86400', 21:55:15 INFO - 'USER': 'cltbld', 21:55:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:15 INFO - '_': '/tools/buildbot/bin/python'} 21:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:15 INFO - Downloading/unpacking flake8 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:15 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 21:55:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:55:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:55:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 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 21:55:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:18 INFO - no previously-included directories found matching 'docs/_build' 21:55:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:55:18 INFO - Running setup.py install for pep8 21:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:55:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:55:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:55:18 INFO - no previously-included directories found matching 'docs/_build' 21:55:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:55:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:55:18 INFO - Cleaning up... 21:55:18 INFO - Return code: 0 21:55:18 INFO - Running post-action listener: _resource_record_post_action 21:55:18 INFO - Running post-action listener: _start_resource_monitoring 21:55:18 INFO - Starting resource monitoring. 21:55:18 INFO - ##### 21:55:18 INFO - ##### Running install step. 21:55:18 INFO - ##### 21:55:18 INFO - Running pre-action listener: _resource_record_pre_action 21:55:18 INFO - Running main action method: install 21:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:55:18 INFO - Reading from file tmpfile_stdout 21:55:18 INFO - Detecting whether we're running mozinstall >=1.0... 21:55:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:55:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:55:19 INFO - Reading from file tmpfile_stdout 21:55:19 INFO - Output received: 21:55:19 INFO - Usage: mozinstall [options] installer 21:55:19 INFO - Options: 21:55:19 INFO - -h, --help show this help message and exit 21:55:19 INFO - -d DEST, --destination=DEST 21:55:19 INFO - Directory to install application into. [default: 21:55:19 INFO - "/builds/slave/test-pgo"] 21:55:19 INFO - --app=APP Application being installed. [default: firefox] 21:55:19 INFO - mkdir: /builds/slave/test-pgo/build/application 21:55:19 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'] 21:55:19 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 21:55:35 INFO - Reading from file tmpfile_stdout 21:55:35 INFO - Output received: 21:55:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:55:35 INFO - Running post-action listener: _resource_record_post_action 21:55:35 INFO - ##### 21:55:35 INFO - ##### Running run-tests step. 21:55:35 INFO - ##### 21:55:35 INFO - Running pre-action listener: _resource_record_pre_action 21:55:35 INFO - Running main action method: run_tests 21:55:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:55:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:55:35 INFO - Python 2.7.3 21:55:35 INFO - Return code: 0 21:55:35 INFO - grabbing minidump binary from tooltool 21:55: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')]} 21:55:35 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 0xf848c0>, '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 0xf857c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf85c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:55:35 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 21:55:35 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 21:55:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:35 INFO - Return code: 0 21:55:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:55:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:55:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:55:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:55:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:55:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:55:36 INFO - Return code: 0 21:55:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:55:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 21:55:36 INFO - Using env: {'DISPLAY': ':0', 21:55:36 INFO - 'HOME': '/home/cltbld', 21:55:36 INFO - 'LANG': 'en_US.UTF-8', 21:55:36 INFO - 'LANGUAGE': 'en_US:en', 21:55:36 INFO - 'LOGNAME': 'cltbld', 21:55:36 INFO - 'MAIL': '/var/mail/cltbld', 21:55:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:36 INFO - 'MOZ_NO_REMOTE': '1', 21:55:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:55:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:36 INFO - 'NO_EM_RESTART': '1', 21:55:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:36 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:55:36 INFO - 'SHELL': '/bin/bash', 21:55:36 INFO - 'SHLVL': '1', 21:55:36 INFO - 'TERM': 'linux', 21:55:36 INFO - 'TMOUT': '86400', 21:55:36 INFO - 'USER': 'cltbld', 21:55:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052', 21:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:36 INFO - '_': '/tools/buildbot/bin/python'} 21:55:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:55:36 INFO - mozversion application_buildid: 20160226193212 21:55:36 INFO - mozversion application_changeset: 8e93182402a9742f890c722ae8057e724105a21b 21:55:36 INFO - mozversion application_display_name: Nightly 21:55:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:36 INFO - mozversion application_name: Firefox 21:55:36 INFO - mozversion application_remotingname: firefox 21:55:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:36 INFO - mozversion application_vendor: Mozilla 21:55:36 INFO - mozversion application_version: 47.0a1 21:55:36 INFO - mozversion platform_buildid: 20160226193212 21:55:36 INFO - mozversion platform_changeset: 8e93182402a9742f890c722ae8057e724105a21b 21:55:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:55:36 INFO - mozversion platform_version: 47.0a1 21:55:36 INFO - using testdate: 1456552536 21:55:36 INFO - actual date: 1456552536 21:55:36 INFO - starting webserver on 'localhost:59620' 21:55:36 INFO - SUITE-START | Running 2 tests 21:55:36 INFO - TEST-START | dromaeo_css 21:55:36 INFO - operating with platform_type : linux_ 21:55:36 INFO - Initialising browser for dromaeo_css test... 21:55:36 INFO - TEST-INFO | started process 3442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzm9bzw/profile http://localhost:59620/getInfo.html) 21:55:41 INFO - PROCESS | 3442 | __metrics Screen width/height:1600/1200 21:55:41 INFO - PROCESS | 3442 | colorDepth:24 21:55:41 INFO - PROCESS | 3442 | Browser inner width/height: 1024/697 21:55:41 INFO - PROCESS | 3442 | __metrics 21:55:42 INFO - PROCESS | 3442 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 21:55:42 INFO - PROCESS | 3442 | 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. 21:55:43 INFO - TEST-INFO | 3442: exit 0 21:55:43 INFO - Browser initialized. 21:55:43 INFO - Running cycle 1/1 for dromaeo_css test... 21:55:43 INFO - TEST-INFO | started process 3539 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzm9bzw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:55 INFO - PROCESS | 3539 | RSS: Main: 149987328 21:55:55 INFO - PROCESS | 3539 | 21:56:46 INFO - PROCESS | 3539 | 1456552606803 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] 21:58:54 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59620/tests/dromaeo/cssquery-ext.html) 21:58:55 INFO - PROCESS | 3539 | RSS: Main: 241946624 21:58:55 INFO - PROCESS | 3539 | 22:01:57 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-ext.html (next: http://localhost:59620/tests/dromaeo/cssquery-jquery.html) 22:01:58 INFO - PROCESS | 3539 | RSS: Main: 230121472 22:01:58 INFO - PROCESS | 3539 | 22:05:00 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59620/tests/dromaeo/cssquery-mootools.html) 22:05:01 INFO - PROCESS | 3539 | RSS: Main: 235110400 22:05:01 INFO - PROCESS | 3539 | 22:08:02 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59620/tests/dromaeo/cssquery-prototype.html) 22:08:03 INFO - PROCESS | 3539 | RSS: Main: 215011328 22:08:03 INFO - PROCESS | 3539 | 22:11:05 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59620/tests/dromaeo/cssquery-yui.html) 22:11:06 INFO - PROCESS | 3539 | RSS: Main: 212598784 22:11:06 INFO - PROCESS | 3539 | 22:14:08 INFO - PROCESS | 3539 | Cycle 1(1): loaded http://localhost:59620/tests/dromaeo/cssquery-yui.html (next: http://localhost:59620/tests/dromaeo/cssquery-dojo.html) 22:14:09 INFO - PROCESS | 3539 | RSS: Main: 311504896 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | __start_tp_report 22:14:09 INFO - PROCESS | 3539 | _x_x_mozilla_page_load 22:14:09 INFO - PROCESS | 3539 | _x_x_mozilla_page_load_details 22:14:09 INFO - PROCESS | 3539 | |i|pagename|runs| 22:14:09 INFO - PROCESS | 3539 | |0;dojo.html;3036.590060341854;3093.3194697166646;3117.127204382772;3133.4203172413104;3172.349668317994;4903.779329930153;4912.754362281885;4914.115459217344;4916.631252656047;4950.55445009949;4947.752612369385;4969.925451118236;4983.17777566702;4988.850334489962;5019.422766381867;4593;4620.237660785966;4638.930416043762;4687.765611719417;4776.952230477686;4714.858554243361;4733.337332773414;4750.928736068961;4754.477007529169;4803.687760295569;4562.885927851797;4603.953960460386;4687.273472611751;4709.9764501177615;4712;4604.424446944132;4614.5385461453925;4618.35343051973;4624.606908412756;4646.4888862225125;4477.238869392211;4591.380163677894;4599.494055653875;4617.2612382018715;4636.53634636537;4849.369581954324;4895.363602731622;4914.04176185644;4934.111859865223;4938.62960277977;5334.119870221409;5336.759845806909;5344.706041167734;5361.329833770778;5368.597355198376;5321.494458026481;5347.224652425415;5355.0896347621;5355.250264962909;5372.597055220835;5064.620153488503;5073.1122053640465;5078.111330517145;5084.46613105626;5139.280500729901;5460.071787796084;5463.617546771688;5465.945340546623;5470.261514695545;5499.615026948075;5263.736813159327;5278.683279003272;5285.577153827685;5288.2596436498925;5308.442613525602;5337.973310133424;5339.839804805862;5361.812336568201;5367.624266301322;5404.108322126805;5318.25544423781;5322.54758345545;5326.627136100513;5335.199720041947;5382.973085134549;5269.973650131725;5324.148136298174;5330.413654498002;5407.756650950717;5474.39781624021;4151.522574903925;4168.958310416918;4170.520390155171;4191.832326706958;4205.831766729358;3741.9064523386587;3761.4921985531605;3772.358699021173;3787.299349620329;3809.0286976820735;5078.542931136216;5108.361454818148;5170.508801663836;5242.449542797951;5252.65857719247;5380.784768609212;5390.757415916293;5399.055165346049;5399.676019438846;5405.216243644728;5118.820841270538;5122.078025955364;5132.28148059272;5139.743012849342;5142.382914050338;4470.530594287618;4511.390962220124;4543.068670922453;4573.49691533931;4582.518835522289;5595.552355811526;5655.349634791969;5663.801766938137;5668.263125793538;5672.064109421982;5267.3152490176035;5343.5457986071615;5367.329083864517;5368.731563421891;5420.214068960057;5708.172315014383;5718.170865224436;5744.339400968942;5775.133729940542;5785.739641716049;5292.470752924677;5302.337207849019;5312.203169524602;5315.521603055744;5316.255724198538;5274.182501712241;5343.431783281051;5347.117725575236;5393.541548968225;5445.074337362737;5296.364436267672;5299.655522391032;5305.151175812006;5338.733063346895;5342.358916929993;5260.210968354778;5290.285811415563;5290.788368465218;5297.54970827484;5353.384360798403;5052.1663925451885;5091.109055915274;5167.638265321391;5168.689878607295;5168.767405466839;5270.446603106772;5283.313169287968;5296.020236256305;5303.992241474108;5344.198370244494;5100.515451032146;5187.636865419385;5189.299444574934;5193.558547523503;5194.220866869849 22:14:09 INFO - PROCESS | 3539 | |1;ext.html;507.9054637256711;522.46969326134;547.8630342414397;586.8268860686097;602.0908428273308;27857.442851142965;36169.819150904244;36614.45078323827;36757;36778.8161059195;39601.207975840465;40217.195656086864;40308;40372.59627403725;40488.19023619526;7447.366973807233;7589.848203035936;8486.44838085524;8735.082816304292;10102.19182465401;10079.848802267936;10228.641997530089;10236;10238.180945524377;10241;10259.846102308435;10394.376337419779;10394.792104157912;10395.32430392022;10400.687979360631;10480.109190718798;10597.311174773615;10607.84088238677;10617.309874858109;10630.255882088257;10370.22223333253;10582.15342772584;10583.470826458723;10617.628383006559;10630.362178269252;39598;39935.800320998496;39964.60035399638;39975.60024399777;40001;3152;3212.61448626164;3278.9016329510155;3407.1993081625797;3539.292141571696;29988.55017174744;30240.54639180392;30440.391192176256;30816.69183308183;31334.37331253385;3606.6573675500786;3680.7423480356388;3688.748769256788;3698.981505092457;3801.1067399161175;266788;268159;268495;268686;269350;40576;56407.43592564104;56489.15266271009;57053.71473142608;57114.714426428436;39904.600953990666;40007.59992400097;40041.39937900934;40045.39931901024;40065.59934400619;12559.497620095277;13646.317684115755;13818;13823.930880345735;13843.238621875893;10950.123990080774;11119.777604447865;11128.221024528368;11142.220044596801;11145.609903653332;13313.134646247963;13376.866231337757;13387.397567109503;13403.061785674909;13455.25996070206;5645.943540564624;5779.913301300484;5827.504662103684;5876.7355469004;5901.527877769769;939.9671011514564;940.4545363689044;950.1638558068855;987.9357841740264;1074.8177005294115;28348.85825570859;28403.57394639082;28595.71404285972;28769.85615071953;28789.424211515652;987.980240395188;994.1301361308855;1044.3472829481575;1062.9819283109857;1164.1210885781181;14301.570952871223;14753.40986360555;14797.186154761592;15085.47200847965;15122.773158402633;300807;303621;303896;304592;305108;50764;52324.21513677298;52438.73780631149;52503.47496525062;52612.210816837774;1230.7415442757122;1336.111485861891;1349.0961056092638;1400.1878910232042;1497.169071165492;25375.746242538076;25721.842517086403;25920.351991199615;25977.870110649324;26496.337591560365;35937.64062359343;35951.640483595875;36319.818400907825;36800.44799328066;37076;178023;178058;178173;178195;178196;26989;30642.846785765927;30787.230319242197;31043.534346985263;31190.37619247557;39282;40579;40719.1856162881;40840.795796022016;41415;35027.47458788069;35284.82357588196;35394.29211415809;35461.82269088741;35667.64332356643;35324.82337588296;35345;35367;35555.466667999484;36026.27947441089;33703;34314.82842585871;34328.48507272443;34492.482612761334;34724.82637586796;30629.846850766495;31223.531647024858;31445.68554314519;31537.526937095503;31664.366712665156;24130.39674008164;24153.396165096012;24214.394640133432;24566.26301210895;24826 22:14:09 INFO - PROCESS | 3539 | |2;jquery.html;331.79262960649595;339.13689659815765;340.6253121566277;343.21746418166583;343.57739979824817;16717.41489047882;17052.658946821055;17351.652966940652;17888.82111178888;17895.373661921803;16189.919050404731;16301.510954671348;16436.506904792845;16456.259468323926;16471.423500177498;4812.975935120337;5252.395974462938;5389.8113566025195;5484.533814625762;5488.835334939939;5329.893402131955;5350.785968561253;5377.489138531852;5381.838544843661;5421.322334708161;5079.74601269935;5292.5765938725;5335.759890804904;5341.145416733323;5344.251804747339;5290.127129023706;5292.761825717852;5315.0432922074015;5326.121190003664;5329.626926115193;4656.953430465685;4703.741294228816;4707.38803955487;4709.081729062834;4712.5051869553545;20191;20731.792682073286;21009.369718908456;21009.68485472719;21219.68170477444;2069.4205622425743;2257.221258665758;2393.401649587603;2544.2875994721508;2827.7313655202724;9033.23217526511;9368.812623747555;11264.549418023269;11385.9183377579;13051.934740326238;1742.4946765438008;1847.8706490545667;1865.0674662668666;1896.8577356698304;1905.0569967865856;50790.74604626953;52233;57005.14492282661;63216.866869361416;64586;10090.596376145018;10164.136048435967;10347.63783267582;10410.115140213014;10553.63062292816;11944.880551194377;12915.612531624067;13205.405756740969;13205.867941320656;13224;7256.363242049552;7257.52826066304;7311.488195826348;7327.890081648779;7561.659725312375;7147.928520714726;7163.212046674862;7305.086864141982;7315.561066336037;7458.2541745826065;4470.776461176928;4561.2245918193985;4562.771861406916;4563.292689633112;4620.052889157714;1638.4101723379574;1753.6229710612024;1796.3533128073882;1818.6544556534216;1840.162725959685;889.3374436045187;911.9042500537481;915.9450432974043;937.6296362936602;1001.5843424978698;16088.597785055466;16346.673066538602;16704.74942875858;16906;16962.15189240533;886.5744442667427;902.0168016861652;912.7763697893926;948.1656142594472;984.3995162950595;9282.329180747396;9416.717498475056;9650.324477286664;9685.564149613143;9751.756206094762;417520;419646;425003;442558;443055;70119;73179.26820731831;74362;74526.62736686281;75452.24547754561;1009.545704433008;1020.2042406922612;1044.6657069737762;1054.5518154784186;1056.7463808686014;14590.489332873298;14756.188409637572;14872.553823385315;14890.85109148938;15238.3904643813;25791.226263212135;30761.8461907689;31280.530792038593;33058.33883322368;34444.48333275053;39629;44826;48920.5107948916;51076.48923510866;51613.741931290104;7347.5224110432655;7389.667464963982;7530.096388433423;7570.735024274344;7636.045494313211;10032;11772.17594768358;11829.408529573659;12164;12199.695007624525;10237.129843963347;10366.06705396518;10424.374537527772;10593.947030264799;10596.629117980834;10662.8400573993;10875.401852898167;11006;11059.61291354831;11155.44222788841;10540.84188737185;10680.57277708883;10793.56825726962;10797;11170.609028684283;7728.690852365842;7729.304362607392;7895.131535531202;7937.801554961172;8183.839140751842;10302.793944121226;10604.681859544226;10629.627963021258;10690.732731681459;10774.515146818256 22:14:09 INFO - PROCESS | 3539 | |3;mootools.html;1364.7065880835619;1496.8353481117078;1526.6793973265617;1683.2509533257705;1822.2528763207088;7736.613169341532;7909.6836126554945;7944.086430060552;7944.563049032301;7944.602769861513;7755.302022817945;7800.180980996999;7856.8035799105055;7857.92142078579;7861.68553257869;1999.3102379678987;2169.511859831541;2200.5488874780713;2224.6663000549884;2226.9888650556722;2264.230161745006;2268.7731226877345;2269.4099534121083;2271.931842044733;2272.4318920269934;2203.724534433196;2212.6127927612683;2282.463621049052;2283.2465286455513;2285.714285714286;2228.1644383356324;2230.2194232018746;2234.7988681018705;2258.175765845471;2315.3169814904477;2177.945551361229;2182.639864422368;2194.659827726689;2198.0548364203387;2198.65920782279;7916.6833326666865;7960.522368657841;7967.322777563914;7968.482048666876;7989.840203195961;4669.556392142741;4728.172569800271;4734;4737.170995075882;4776.785044672998;2939.103573410109;3031.7271445570004;3066.7699922505903;3074.431230222416;3078.0611913366415;978.848278516831;990.2622546203053;1004.909558139771;1010.6715317521835;1032.5250384822916;10754.892451075468;10762.192835537287;10795.028447439769;10826.24216304859;10831.07935825448;3946.861859834892;4086.366613174963;4130.752154870717;4172.144710334374;4185.309423945076;8568.271696905833;8792.560371981375;8821.117888211127;8825;8862.113788621085;4753.453352864396;4771.976140119277;4789.209780386267;4791.233402655558;4792.185328494164;3979.5622481527007;4317.978410107929;4396.956030439655;4441.20058389493;4445.5776701213335;3373.983130084383;3427.4002049641713;3432.262063656326;3455.740819438552;3467.1852114753015;1006.8741407324085;1010.0858722855827;1014.3204053284318;1016.9440680762481;1017.4861694844204;1287.909846310768;1306.7713150198676;1310.4823594680238;1331.1214598365227;1345.8115863779078;7483;7612.80967975805;7618.085829700472;7620.3522700571075;7633.5419874807685;448.21338550843063;455.85640523235736;458.1478450082843;462.3919545797266;474.49466318371515;5808.6224395414165;5835.124731290341;5881.764729410861;5887.381824908409;5904.350521442638;9521.256261697969;9930.602775888883;9988.550515226832;10006.799864002825;10130.138938190188;9897.65358212459;9956.701298961043;9974.551145198484;10047.09576138151;10048;7453.552786832807;7648.502847314907;7667.233276672288;7711.884321735179;7766.378689704923;7110.146782386147;7150.070490836158;7226.494145409771;7235.927640723526;7254.45591580623;8415.4109212357;8739.43193692408;8856.07011263808;8861.424007439497;8883.200511953955;8698.695545655872;8820.691275805317;8826.64693412282;8842.336824738042;8970.506622135845;6279.372062793684;7016.473764467583;7137.321954414322;7397.371223445852;7614.847703045797;7649.273319034683;7682.923170768221;7683.193264707125;7718.6140692964;7733.265339792711;6871.9656401717675;6913.3777959983845;6945.166580010431;7057.2237053923;7177.605231712306;6720.1263835703;6772.559783614246;6784.185897692111;6809.93190068093;6960.23437421873;6936.687849046906;7041.788746337618;7075.82310442243;7079.079719636415;7120.537165084253;6622.039804228456;6623.867522649423;6646.03632473279;6676.031975363642;6678.532502724763;6503.349665033459;6586.37429444202;6613.768518102036;6622.933770662232;6630 22:14:09 INFO - PROCESS | 3539 | |4;prototype.html;308.1018830110229;310.1610144558968;310.93936682346936;310.9766767492437;311.50004243189693;5774.6535207887555;5782.566307526931;5821.214136091627;5835.766569337221;5853.912191317134;5723.341815691197;5723.9141412878735;5742.167385729077;5746.310442746876;5746.798862039829;4223.36649502574;4316.352547117926;4429.15845989261;4454.710443821157;4461.219286624828;4425.203463376591;4447.4218351614245;4456.955430445702;4458.2866741321395;4461.263891457906;4197.895052623679;4411.80146893389;4414.823407063714;4423.955760442403;4426.97786511067;4278.957210427918;4302.591253830897;4310.4611923509565;4395.582419670126;4403.405540252057;3826.330392181357;3842.212346468967;3844.4430005847676;3846.499955005859;3851.73037887348;5501.284832971688;5502.367227768817;5512.476314750093;5513.062779327524;5518.558515318805;5119.897602047976;5123.820666276662;5129.717865517395;5130.1791713326065;5131.743412829381;6072.332043475214;6097.756089756404;6100.115483254947;6106.419890110433;6127.662978536178;4042.0905296308097;4167.708260421772;4176;4259.97870010648;4271.273883439822;6341.8414539636415;6394.264659564164;6425.293217746044;6434.292227854979;6452.161219041542;4263.040815816416;4263.829446822155;4264.317709166518;4264.530901600821;4267.551907049778;4316.589923957219;4318.050028993616;4318.503372112247;4319.352097185448;4325.589069038437;5059.392872855281;5067.442581316126;5070.087384270867;5072.163093089599;5082.618803589746;6042.942485065096;6190.2571691397325;6194.659293738888;6199.721012554446;6201.10084037812;1489.3893503663446;1504.3907217576898;1507.4422463688506;1508.4644951042442;1512.6520900193018;927.0497739816742;967.6613185385199;971.8639390485338;987.3730181334761;998.8152191844532;5883.441073098049;5913.704314784243;5919.260092488439;5929.37741537141;5941.762329506858;6288.937110628835;6324.557280990379;6340.968295158495;6389.393007664265;6394.136791533177;5913.733881975236;5923.466887980103;5923.674197919069;5928.229330187048;5929.881402371929;3366.057503898863;3398.677125673057;3398.9830050849587;3401.795892246473;3403.1322012886553;6543.214814222324;6680.665966701646;6694.665266736741;6760.357766012221;6831.69257383419;6522;6550.2794692583775;6558.639274839929;6563.343665633399;6570.967145164339;6786.321367863273;6794.320567943265;6795.52431329812;6806.18325800907;6806.387425131762;6409;6410.262819775786;6415.582987105823;6416.422521973045;6418.711157997995;6210.192674952227;6355.110284560258;6364.840878978062;6374.58565193261;6382.393672601095;6750.45996320303;6779.118714567075;6792.626405547742;6799.422049125879;6804.217514985642;4244.957550424456;4305.397244385851;4306.569343065668;4306.935395969125;4309.612134907873;6343.9682801585695;6404.199475065617;6414.839629009312;6424.550281480439;6428.646424446701;6215.844603884939;6218.06728990655;6222.688865556614;6233.532485063548;6234.096056071935;6064.605800622945;6224.439800417984;6233.407826256498;6238.220222472191;6239.500839932885;6015.849603759941;6062.090686397076;6063.090536419396;6064.090386441892;6070.939290607037;6190.7214175363115;6250.749970001149;6255.280642726145;6257;6258.186435763321;5888.205092312483;5966.850828729316;6104.4200800923845;6115.602485838406;6125.571210015256 22:14:09 INFO - PROCESS | 3539 | |5;yui.html;738.3613174603967;820.5568992743919;823.5758584329068;838.5136620759956;861.4917198852678;13844.861551384496;14098;14171.574852754407;14175.503857364982;14198.71602567948;13366;13390.732185356286;13466.12470189437;14127.788083178735;14201;843.9409241353108;850.4472093139478;857.297016446511;859;862.3316929379719;853.1681610429844;853.9444936079135;854.2567965869671;855.1405837133703;855.4012191465968;896.256107430834;897.9102089791002;897.9551022448884;898.034612791252;899.6986009686763;886.8669699545087;887.5384799904078;888;888.9111088891124;890.3366991591241;655.8655475627485;656.1863289521008;656.2387630348773;658.5159907468008;661.2759028863387;13256.602301930958;13261.668458288523;13310.068295219338;13312.400941957538;13318.334083295797;10670.466476676134;10759;11065.668029959113;11983;12183.634490965196;9683.983181765954;9792.559334829879;9857.260705447121;9905;9969.55137018836;3467.7572569920117;3481.1123163593375;3532.982335088334;3545.308664810363;3657.65252301031;49017.99999999964;49217;49621.751891240674;49664.50335496635;49789;9118.498482583522;9232.584533696;9308.301877359225;9654.22766178704;9717;17015.489535313962;17033.14834258307;17083.91458042702;17094.05982670965;17101;7430.962845185848;7504.099508059068;7665.61671916402;7741.264579864904;7831.177726338652;4151.294279972412;4257.723247988933;4343.1530851484285;4398.670099742532;4497.347884556786;3123.141136187521;3147.496400575897;3148.968510314913;3153.3377990621766;3157.4000939821362;542;550.8815604645021;552.6021264689417;556.1629747230393;560.3751816724323;661.8543920337518;676.4182802789597;699.5313140195979;704.1374316462395;713.2261496276494;8211.371197541383;8409.747707568782;8720.825583488422;8785.692500762443;8856.438460079693;699.3076853914689;699.6746512871539;709.5104377979178;711.2212127720138;724.7318492157935;3906.7851268179957;3923.8822835314986;4011.13760541485;4028.5971402860064;4075.7554546727292;48555.75722121437;49480.25779613309;49492.25761613579;49560.256596151085;49562.25656615154;38997.905010960865;46422.30366544505;48119.278210826866;48682.26976595354;53491;44194.77902610466;44470;44901.55098449039;45028.77485612616;45334;8303.211194936472;8510.74467765968;8532.829343413221;8560.48637081777;8685.826283474169;32424;32459.513107302937;32984.67015329816;33344;33796.32407351888;39026.219475610895;41574;43166.78416607897;43228.78385608052;43466;10731.248812583357;10766.784664306826;10843.186760993114;10995.505202265756;11053.115750740082;12152.513899443924;12294.139410241198;12356.876431235572;12769.489220431078;12770.87229127734;11270.492827822603;11558.07535397183;11613.76772464563;11751.118666100248;12051.397430128634;9362.765930851783;9588.520573971413;9699.757506062122;9730.805383892424;9913.30606857513;10901.454927253764;10934.179936504954;10939.28894621847;11282.323060616389;11386.601468948547;9119.635214591342;9237.445753254826;9263.953680231556;9291.76770580741;9332.813343733224;8922.73231803047;8926.509042002752;9000.5134686784;9117.179453849185;9620.13418792312 22:14:09 INFO - PROCESS | 3539 | __end_tp_report 22:14:09 INFO - PROCESS | 3539 | __start_cc_report 22:14:09 INFO - PROCESS | 3539 | _x_x_mozilla_cycle_collect,727 22:14:09 INFO - PROCESS | 3539 | __end_cc_report 22:14:09 INFO - PROCESS | 3539 | __startTimestamp1456553649246__endTimestamp 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | ------- Summary: start ------- 22:14:09 INFO - PROCESS | 3539 | Number of tests: 6 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#0] dojo.html Cycles:165 Average:5018.81 Median:5194.22 stddev:535.67 (10.3%) stddev-sans-first:514.25 22:14:09 INFO - PROCESS | 3539 | Values: 3036.6 3093.3 3117.1 3133.4 3172.3 4903.8 4912.8 4914.1 4916.6 4950.6 4947.8 4969.9 4983.2 4988.9 5019.4 4593.0 4620.2 4638.9 4687.8 4777.0 4714.9 4733.3 4750.9 4754.5 4803.7 4562.9 4604.0 4687.3 4710.0 4712.0 4604.4 4614.5 4618.4 4624.6 4646.5 4477.2 4591.4 4599.5 4617.3 4636.5 4849.4 4895.4 4914.0 4934.1 4938.6 5334.1 5336.8 5344.7 5361.3 5368.6 5321.5 5347.2 5355.1 5355.3 5372.6 5064.6 5073.1 5078.1 5084.5 5139.3 5460.1 5463.6 5465.9 5470.3 5499.6 5263.7 5278.7 5285.6 5288.3 5308.4 5338.0 5339.8 5361.8 5367.6 5404.1 5318.3 5322.5 5326.6 5335.2 5383.0 5270.0 5324.1 5330.4 5407.8 5474.4 4151.5 4169.0 4170.5 4191.8 4205.8 3741.9 3761.5 3772.4 3787.3 3809.0 5078.5 5108.4 5170.5 5242.4 5252.7 5380.8 5390.8 5399.1 5399.7 5405.2 5118.8 5122.1 5132.3 5139.7 5142.4 4470.5 4511.4 4543.1 4573.5 4582.5 5595.6 5655.3 5663.8 5668.3 5672.1 5267.3 5343.5 5367.3 5368.7 5420.2 5708.2 5718.2 5744.3 5775.1 5785.7 5292.5 5302.3 5312.2 5315.5 5316.3 5274.2 5343.4 5347.1 5393.5 5445.1 5296.4 5299.7 5305.2 5338.7 5342.4 5260.2 5290.3 5290.8 5297.5 5353.4 5052.2 5091.1 5167.6 5168.7 5168.8 5270.4 5283.3 5296.0 5304.0 5344.2 5100.5 5187.6 5189.3 5193.6 5194.2 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#1] ext.html Cycles:180 Average:41207.13 Median:31206.95 stddev:66699.40 (213.7%) stddev-sans-first:66816.51 22:14:09 INFO - PROCESS | 3539 | Values: 507.9 522.5 547.9 586.8 602.1 27857.4 36169.8 36614.5 36757.0 36778.8 39601.2 40217.2 40308.0 40372.6 40488.2 7447.4 7589.8 8486.4 8735.1 10102.2 10079.8 10228.6 10236.0 10238.2 10241.0 10259.8 10394.4 10394.8 10395.3 10400.7 10480.1 10597.3 10607.8 10617.3 10630.3 10370.2 10582.2 10583.5 10617.6 10630.4 39598.0 39935.8 39964.6 39975.6 40001.0 3152.0 3212.6 3278.9 3407.2 3539.3 29988.6 30240.5 30440.4 30816.7 31334.4 3606.7 3680.7 3688.7 3699.0 3801.1 266788.0 268159.0 268495.0 268686.0 269350.0 40576.0 56407.4 56489.2 57053.7 57114.7 39904.6 40007.6 40041.4 40045.4 40065.6 12559.5 13646.3 13818.0 13823.9 13843.2 10950.1 11119.8 11128.2 11142.2 11145.6 13313.1 13376.9 13387.4 13403.1 13455.3 5645.9 5779.9 5827.5 5876.7 5901.5 940.0 940.5 950.2 987.9 1074.8 28348.9 28403.6 28595.7 28769.9 28789.4 988.0 994.1 1044.3 1063.0 1164.1 14301.6 14753.4 14797.2 15085.5 15122.8 300807.0 303621.0 303896.0 304592.0 305108.0 50764.0 52324.2 52438.7 52503.5 52612.2 1230.7 1336.1 1349.1 1400.2 1497.2 25375.7 25721.8 25920.4 25977.9 26496.3 35937.6 35951.6 36319.8 36800.4 37076.0 178023.0 178058.0 178173.0 178195.0 178196.0 26989.0 30642.8 30787.2 31043.5 31190.4 39282.0 40579.0 40719.2 40840.8 41415.0 35027.5 35284.8 35394.3 35461.8 35667.6 35324.8 35345.0 35367.0 35555.5 36026.3 33703.0 34314.8 34328.5 34492.5 34724.8 30629.8 31223.5 31445.7 31537.5 31664.4 24130.4 24153.4 24214.4 24566.3 24826.0 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#2] jquery.html Cycles:180 Average:24798.76 Median:341.92 stddev:70404.89 (20591.0%) stddev-sans-first:70578.43 22:14:09 INFO - PROCESS | 3539 | Values: 331.8 339.1 340.6 343.2 343.6 16717.4 17052.7 17351.7 17888.8 17895.4 16189.9 16301.5 16436.5 16456.3 16471.4 4813.0 5252.4 5389.8 5484.5 5488.8 5329.9 5350.8 5377.5 5381.8 5421.3 5079.7 5292.6 5335.8 5341.1 5344.3 5290.1 5292.8 5315.0 5326.1 5329.6 4657.0 4703.7 4707.4 4709.1 4712.5 20191.0 20731.8 21009.4 21009.7 21219.7 2069.4 2257.2 2393.4 2544.3 2827.7 9033.2 9368.8 11264.5 11385.9 13051.9 1742.5 1847.9 1865.1 1896.9 1905.1 50790.7 52233.0 57005.1 63216.9 64586.0 10090.6 10164.1 10347.6 10410.1 10553.6 11944.9 12915.6 13205.4 13205.9 13224.0 7256.4 7257.5 7311.5 7327.9 7561.7 7147.9 7163.2 7305.1 7315.6 7458.3 4470.8 4561.2 4562.8 4563.3 4620.1 1638.4 1753.6 1796.4 1818.7 1840.2 889.3 911.9 915.9 937.6 1001.6 16088.6 16346.7 16704.7 16906.0 16962.2 886.6 902.0 912.8 948.2 984.4 9282.3 9416.7 9650.3 9685.6 9751.8 417520.0 419646.0 425003.0 442558.0 443055.0 70119.0 73179.3 74362.0 74526.6 75452.2 1009.5 1020.2 1044.7 1054.6 1056.7 14590.5 14756.2 14872.6 14890.9 15238.4 25791.2 30761.8 31280.5 33058.3 34444.5 39629.0 44826.0 48920.5 51076.5 51613.7 7347.5 7389.7 7530.1 7570.7 7636.0 10032.0 11772.2 11829.4 12164.0 12199.7 10237.1 10366.1 10424.4 10593.9 10596.6 10662.8 10875.4 11006.0 11059.6 11155.4 10540.8 10680.6 10793.6 10797.0 11170.6 7728.7 7729.3 7895.1 7937.8 8183.8 10302.8 10604.7 10629.6 10690.7 10774.5 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#3] mootools.html Cycles:180 Average:5522.58 Median:5895.87 stddev:2956.34 (50.1%) stddev-sans-first:2948.11 22:14:09 INFO - PROCESS | 3539 | Values: 1364.7 1496.8 1526.7 1683.3 1822.3 7736.6 7909.7 7944.1 7944.6 7944.6 7755.3 7800.2 7856.8 7857.9 7861.7 1999.3 2169.5 2200.5 2224.7 2227.0 2264.2 2268.8 2269.4 2271.9 2272.4 2203.7 2212.6 2282.5 2283.2 2285.7 2228.2 2230.2 2234.8 2258.2 2315.3 2177.9 2182.6 2194.7 2198.1 2198.7 7916.7 7960.5 7967.3 7968.5 7989.8 4669.6 4728.2 4734.0 4737.2 4776.8 2939.1 3031.7 3066.8 3074.4 3078.1 978.8 990.3 1004.9 1010.7 1032.5 10754.9 10762.2 10795.0 10826.2 10831.1 3946.9 4086.4 4130.8 4172.1 4185.3 8568.3 8792.6 8821.1 8825.0 8862.1 4753.5 4772.0 4789.2 4791.2 4792.2 3979.6 4318.0 4397.0 4441.2 4445.6 3374.0 3427.4 3432.3 3455.7 3467.2 1006.9 1010.1 1014.3 1016.9 1017.5 1287.9 1306.8 1310.5 1331.1 1345.8 7483.0 7612.8 7618.1 7620.4 7633.5 448.2 455.9 458.1 462.4 474.5 5808.6 5835.1 5881.8 5887.4 5904.4 9521.3 9930.6 9988.6 10006.8 10130.1 9897.7 9956.7 9974.6 10047.1 10048.0 7453.6 7648.5 7667.2 7711.9 7766.4 7110.1 7150.1 7226.5 7235.9 7254.5 8415.4 8739.4 8856.1 8861.4 8883.2 8698.7 8820.7 8826.6 8842.3 8970.5 6279.4 7016.5 7137.3 7397.4 7614.8 7649.3 7682.9 7683.2 7718.6 7733.3 6872.0 6913.4 6945.2 7057.2 7177.6 6720.1 6772.6 6784.2 6809.9 6960.2 6936.7 7041.8 7075.8 7079.1 7120.5 6622.0 6623.9 6646.0 6676.0 6678.5 6503.3 6586.4 6613.8 6622.9 6630.0 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#4] prototype.html Cycles:180 Average:5152.81 Median:5923.57 stddev:1594.33 (26.9%) stddev-sans-first:1556.78 22:14:09 INFO - PROCESS | 3539 | Values: 308.1 310.2 310.9 311.0 311.5 5774.7 5782.6 5821.2 5835.8 5853.9 5723.3 5723.9 5742.2 5746.3 5746.8 4223.4 4316.4 4429.2 4454.7 4461.2 4425.2 4447.4 4457.0 4458.3 4461.3 4197.9 4411.8 4414.8 4424.0 4427.0 4279.0 4302.6 4310.5 4395.6 4403.4 3826.3 3842.2 3844.4 3846.5 3851.7 5501.3 5502.4 5512.5 5513.1 5518.6 5119.9 5123.8 5129.7 5130.2 5131.7 6072.3 6097.8 6100.1 6106.4 6127.7 4042.1 4167.7 4176.0 4260.0 4271.3 6341.8 6394.3 6425.3 6434.3 6452.2 4263.0 4263.8 4264.3 4264.5 4267.6 4316.6 4318.1 4318.5 4319.4 4325.6 5059.4 5067.4 5070.1 5072.2 5082.6 6042.9 6190.3 6194.7 6199.7 6201.1 1489.4 1504.4 1507.4 1508.5 1512.7 927.0 967.7 971.9 987.4 998.8 5883.4 5913.7 5919.3 5929.4 5941.8 6288.9 6324.6 6341.0 6389.4 6394.1 5913.7 5923.5 5923.7 5928.2 5929.9 3366.1 3398.7 3399.0 3401.8 3403.1 6543.2 6680.7 6694.7 6760.4 6831.7 6522.0 6550.3 6558.6 6563.3 6571.0 6786.3 6794.3 6795.5 6806.2 6806.4 6409.0 6410.3 6415.6 6416.4 6418.7 6210.2 6355.1 6364.8 6374.6 6382.4 6750.5 6779.1 6792.6 6799.4 6804.2 4245.0 4305.4 4306.6 4306.9 4309.6 6344.0 6404.2 6414.8 6424.6 6428.6 6215.8 6218.1 6222.7 6233.5 6234.1 6064.6 6224.4 6233.4 6238.2 6239.5 6015.8 6062.1 6063.1 6064.1 6070.9 6190.7 6250.7 6255.3 6257.0 6258.2 5888.2 5966.9 6104.4 6115.6 6125.6 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | [#5] yui.html Cycles:180 Average:13204.00 Median:49592.00 stddev:14901.23 (30.0%) stddev-sans-first:14913.63 22:14:09 INFO - PROCESS | 3539 | Values: 738.4 820.6 823.6 838.5 861.5 13844.9 14098.0 14171.6 14175.5 14198.7 13366.0 13390.7 13466.1 14127.8 14201.0 843.9 850.4 857.3 859.0 862.3 853.2 853.9 854.3 855.1 855.4 896.3 897.9 898.0 898.0 899.7 886.9 887.5 888.0 888.9 890.3 655.9 656.2 656.2 658.5 661.3 13256.6 13261.7 13310.1 13312.4 13318.3 10670.5 10759.0 11065.7 11983.0 12183.6 9684.0 9792.6 9857.3 9905.0 9969.6 3467.8 3481.1 3533.0 3545.3 3657.7 49018.0 49217.0 49621.8 49664.5 49789.0 9118.5 9232.6 9308.3 9654.2 9717.0 17015.5 17033.1 17083.9 17094.1 17101.0 7431.0 7504.1 7665.6 7741.3 7831.2 4151.3 4257.7 4343.2 4398.7 4497.3 3123.1 3147.5 3149.0 3153.3 3157.4 542.0 550.9 552.6 556.2 560.4 661.9 676.4 699.5 704.1 713.2 8211.4 8409.7 8720.8 8785.7 8856.4 699.3 699.7 709.5 711.2 724.7 3906.8 3923.9 4011.1 4028.6 4075.8 48555.8 49480.3 49492.3 49560.3 49562.3 38997.9 46422.3 48119.3 48682.3 53491.0 44194.8 44470.0 44901.6 45028.8 45334.0 8303.2 8510.7 8532.8 8560.5 8685.8 32424.0 32459.5 32984.7 33344.0 33796.3 39026.2 41574.0 43166.8 43228.8 43466.0 10731.2 10766.8 10843.2 10995.5 11053.1 12152.5 12294.1 12356.9 12769.5 12770.9 11270.5 11558.1 11613.8 11751.1 12051.4 9362.8 9588.5 9699.8 9730.8 9913.3 10901.5 10934.2 10939.3 11282.3 11386.6 9119.6 9237.4 9264.0 9291.8 9332.8 8922.7 8926.5 9000.5 9117.2 9620.1 22:14:09 INFO - PROCESS | 3539 | -------- Summary: end -------- 22:14:09 INFO - PROCESS | 3539 | 22:14:09 INFO - PROCESS | 3539 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:09 INFO - PROCESS | 3539 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:09 INFO - PROCESS | 3539 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:09 INFO - PROCESS | 3539 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:09 INFO - PROCESS | 3539 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:09 INFO - TEST-INFO | 3539: exit 0 22:14:09 INFO - TEST-OK | dromaeo_css | took 1113318ms 22:14:09 INFO - TEST-START | kraken 22:14:09 INFO - operating with platform_type : linux_ 22:14:09 INFO - Initialising browser for kraken test... 22:14:09 INFO - TEST-INFO | started process 3726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ5XyW/profile http://localhost:59620/getInfo.html) 22:14:14 INFO - PROCESS | 3726 | __metrics Screen width/height:1600/1200 22:14:14 INFO - PROCESS | 3726 | colorDepth:24 22:14:14 INFO - PROCESS | 3726 | Browser inner width/height: 1024/697 22:14:14 INFO - PROCESS | 3726 | __metrics 22:14:15 INFO - PROCESS | 3726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:14:15 INFO - PROCESS | 3726 | 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. 22:14:16 INFO - TEST-INFO | 3726: exit 0 22:14:16 INFO - Browser initialized. 22:14:16 INFO - Running cycle 1/1 for kraken test... 22:14:16 INFO - TEST-INFO | started process 3808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvJ5XyW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:28 INFO - PROCESS | 3808 | RSS: Main: 150753280 22:14:28 INFO - PROCESS | 3808 | 22:14:30 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59620/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:31 INFO - PROCESS | 3808 | RSS: Main: 195497984 22:14:31 INFO - PROCESS | 3808 | 22:14:33 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59620/tests/kraken/driver.html?testName=audio-dft) 22:14:34 INFO - PROCESS | 3808 | RSS: Main: 184504320 22:14:34 INFO - PROCESS | 3808 | 22:14:37 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59620/tests/kraken/driver.html?testName=audio-fft) 22:14:37 INFO - PROCESS | 3808 | RSS: Main: 167559168 22:14:37 INFO - PROCESS | 3808 | 22:14:39 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59620/tests/kraken/driver.html?testName=audio-oscillator) 22:14:40 INFO - PROCESS | 3808 | RSS: Main: 171003904 22:14:40 INFO - PROCESS | 3808 | 22:14:42 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:14:43 INFO - PROCESS | 3808 | RSS: Main: 172957696 22:14:43 INFO - PROCESS | 3808 | 22:14:46 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59620/tests/kraken/driver.html?testName=imaging-darkroom) 22:14:46 INFO - PROCESS | 3808 | RSS: Main: 173277184 22:14:46 INFO - PROCESS | 3808 | 22:14:50 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59620/tests/kraken/driver.html?testName=imaging-desaturate) 22:14:50 INFO - PROCESS | 3808 | RSS: Main: 173838336 22:14:50 INFO - PROCESS | 3808 | 22:14:53 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59620/tests/kraken/driver.html?testName=json-parse-financial) 22:14:54 INFO - PROCESS | 3808 | RSS: Main: 172535808 22:14:54 INFO - PROCESS | 3808 | 22:14:55 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:14:56 INFO - PROCESS | 3808 | RSS: Main: 183934976 22:14:56 INFO - PROCESS | 3808 | 22:14:58 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:14:58 INFO - PROCESS | 3808 | RSS: Main: 180400128 22:14:58 INFO - PROCESS | 3808 | 22:15:00 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:15:01 INFO - PROCESS | 3808 | RSS: Main: 192008192 22:15:01 INFO - PROCESS | 3808 | 22:15:03 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:15:04 INFO - PROCESS | 3808 | RSS: Main: 195325952 22:15:04 INFO - PROCESS | 3808 | 22:15:06 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:15:07 INFO - PROCESS | 3808 | RSS: Main: 197488640 22:15:07 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:59620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59620/tests/kraken/driver.html?testName=ai-astar) 22:15:09 INFO - PROCESS | 3808 | RSS: Main: 256675840 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | __start_tp_report 22:15:09 INFO - PROCESS | 3808 | _x_x_mozilla_page_load 22:15:09 INFO - PROCESS | 3808 | _x_x_mozilla_page_load_details 22:15:09 INFO - PROCESS | 3808 | |i|pagename|runs| 22:15:09 INFO - PROCESS | 3808 | |0;ai-astar;113;112;107;111;111;112;100;111;111;112 22:15:09 INFO - PROCESS | 3808 | |1;audio-beat-detection;154;124;151;165;129;148;157;128;174;128 22:15:09 INFO - PROCESS | 3808 | |2;audio-dft;161;162;169;161;159;161;161;164;163;164 22:15:09 INFO - PROCESS | 3808 | |3;audio-fft;75;73;107;93;73;73;74;128;100;73 22:15:09 INFO - PROCESS | 3808 | |4;audio-oscillator;96;96;142;96;96;95;151;95;96;139 22:15:09 INFO - PROCESS | 3808 | |5;imaging-gaussian-blur;119;115;114;115;115;115;116;115;115;114 22:15:09 INFO - PROCESS | 3808 | |6;imaging-darkroom;145;145;145;145;147;145;145;146;145;146 22:15:09 INFO - PROCESS | 3808 | |7;imaging-desaturate;96;96;95;95;96;96;96;96;96;96 22:15:09 INFO - PROCESS | 3808 | |8;json-parse-financial;58;58;58;57;56;56;56;64;55;54 22:15:09 INFO - PROCESS | 3808 | |9;json-stringify-tinderbox;68;68;69;67;67;68;67;68;67;67 22:15:09 INFO - PROCESS | 3808 | |10;stanford-crypto-aes;82;83;83;83;83;81;88;83;81;82 22:15:09 INFO - PROCESS | 3808 | |11;stanford-crypto-ccm;118;121;115;120;115;123;114;116;138;114 22:15:09 INFO - PROCESS | 3808 | |12;stanford-crypto-pbkdf2;157;138;152;148;150;139;154;149;148;141 22:15:09 INFO - PROCESS | 3808 | |13;stanford-crypto-sha256-iterative;70;70;75;68;70;69;71;71;69;69 22:15:09 INFO - PROCESS | 3808 | __end_tp_report 22:15:09 INFO - PROCESS | 3808 | __start_cc_report 22:15:09 INFO - PROCESS | 3808 | _x_x_mozilla_cycle_collect,1088 22:15:09 INFO - PROCESS | 3808 | __end_cc_report 22:15:09 INFO - PROCESS | 3808 | __startTimestamp1456553709467__endTimestamp 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | ------- Summary: start ------- 22:15:09 INFO - PROCESS | 3808 | Number of tests: 14 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.86 (3.5%) stddev-sans-first:3.94 22:15:09 INFO - PROCESS | 3808 | Values: 113.0 112.0 107.0 111.0 111.0 112.0 100.0 111.0 111.0 112.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:152.50 stddev:17.57 (11.5%) stddev-sans-first:18.39 22:15:09 INFO - PROCESS | 3808 | Values: 154.0 124.0 151.0 165.0 129.0 148.0 157.0 128.0 174.0 128.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.76 (1.7%) stddev-sans-first:2.87 22:15:09 INFO - PROCESS | 3808 | Values: 161.0 162.0 169.0 161.0 159.0 161.0 161.0 164.0 163.0 164.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#3] audio-fft Cycles:10 Average:86.90 Median:73.00 stddev:19.39 (26.6%) stddev-sans-first:20.08 22:15:09 INFO - PROCESS | 3808 | Values: 75.0 73.0 107.0 93.0 73.0 73.0 74.0 128.0 100.0 73.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:23.51 (24.5%) stddev-sans-first:24.37 22:15:09 INFO - PROCESS | 3808 | Values: 96.0 96.0 142.0 96.0 96.0 95.0 151.0 95.0 96.0 139.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 22:15:09 INFO - PROCESS | 3808 | Values: 119.0 115.0 114.0 115.0 115.0 115.0 116.0 115.0 115.0 114.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:15:09 INFO - PROCESS | 3808 | Values: 145.0 145.0 145.0 145.0 147.0 145.0 145.0 146.0 145.0 146.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:15:09 INFO - PROCESS | 3808 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:2.74 (4.8%) stddev-sans-first:2.89 22:15:09 INFO - PROCESS | 3808 | Values: 58.0 58.0 58.0 57.0 56.0 56.0 56.0 64.0 55.0 54.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 22:15:09 INFO - PROCESS | 3808 | Values: 68.0 68.0 69.0 67.0 67.0 68.0 67.0 68.0 67.0 67.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.97 (2.4%) stddev-sans-first:2.06 22:15:09 INFO - PROCESS | 3808 | Values: 82.0 83.0 83.0 83.0 83.0 81.0 88.0 83.0 81.0 82.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.00 stddev:7.24 (6.1%) stddev-sans-first:7.67 22:15:09 INFO - PROCESS | 3808 | Values: 118.0 121.0 115.0 120.0 115.0 123.0 114.0 116.0 138.0 114.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:149.50 stddev:6.38 (4.3%) stddev-sans-first:5.79 22:15:09 INFO - PROCESS | 3808 | Values: 157.0 138.0 152.0 148.0 150.0 139.0 154.0 149.0 148.0 141.0 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.93 (2.8%) stddev-sans-first:2.05 22:15:09 INFO - PROCESS | 3808 | Values: 70.0 70.0 75.0 68.0 70.0 69.0 71.0 71.0 69.0 69.0 22:15:09 INFO - PROCESS | 3808 | -------- Summary: end -------- 22:15:09 INFO - PROCESS | 3808 | 22:15:09 INFO - PROCESS | 3808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:15:09 INFO - PROCESS | 3808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:15:09 INFO - PROCESS | 3808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:15:09 INFO - PROCESS | 3808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:15:09 INFO - PROCESS | 3808 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 22:15:10 INFO - TEST-INFO | 3808: exit 0 22:15:10 INFO - TEST-OK | kraken | took 60429ms 22:15:10 INFO - SUITE-END | took 1173s 22:15:10 INFO - Completed test suite (00:19:33) 22:15:10 INFO - Working with test: dromaeo_css 22:15:10 INFO - Generating results file: dromaeo_css 22:15:10 INFO - Working with test: kraken 22:15:10 INFO - Generating results file: kraken 22:15:10 INFO - javascript benchmark 22:15:10 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:15:10 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:15:10 INFO - process_Request line: dromaeo_css 6712.45 graph.html#tests=[[72,63,35]] 22:15:10 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:15:10 INFO - process_Request line: kraken 1516.80 graph.html#tests=[[232,63,35]] 22:15:10 INFO - RETURN: dromaeo_css: 6712.45 22:15:10 INFO - RETURN: kraken: 1516.80 22:15:10 INFO - javascript benchmark 22:15:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3036.590060341854, 3093.3194697166646, 3117.127204382772, 3133.4203172413104, 3172.349668317994, 4903.779329930153, 4912.754362281885, 4914.115459217344, 4916.631252656047, 4950.55445009949, 4947.752612369385, 4969.925451118236, 4983.17777566702, 4988.850334489962, 5019.422766381867, 4593.0, 4620.237660785966, 4638.930416043762, 4687.765611719417, 4776.952230477686, 4714.858554243361, 4733.337332773414, 4750.928736068961, 4754.477007529169, 4803.687760295569, 4562.885927851797, 4603.953960460386, 4687.273472611751, 4709.9764501177615, 4712.0, 4604.424446944132, 4614.5385461453925, 4618.35343051973, 4624.606908412756, 4646.4888862225125, 4477.238869392211, 4591.380163677894, 4599.494055653875, 4617.2612382018715, 4636.53634636537, 4849.369581954324, 4895.363602731622, 4914.04176185644, 4934.111859865223, 4938.62960277977, 5334.119870221409, 5336.759845806909, 5344.706041167734, 5361.329833770778, 5368.597355198376, 5321.494458026481, 5347.224652425415, 5355.0896347621, 5355.250264962909, 5372.597055220835, 5064.620153488503, 5073.1122053640465, 5078.111330517145, 5084.46613105626, 5139.280500729901, 5460.071787796084, 5463.617546771688, 5465.945340546623, 5470.261514695545, 5499.615026948075, 5263.736813159327, 5278.683279003272, 5285.577153827685, 5288.2596436498925, 5308.442613525602, 5337.973310133424, 5339.839804805862, 5361.812336568201, 5367.624266301322, 5404.108322126805, 5318.25544423781, 5322.54758345545, 5326.627136100513, 5335.199720041947, 5382.973085134549, 5269.973650131725, 5324.148136298174, 5330.413654498002, 5407.756650950717, 5474.39781624021, 4151.522574903925, 4168.958310416918, 4170.520390155171, 4191.832326706958, 4205.831766729358, 3741.9064523386587, 3761.4921985531605, 3772.358699021173, 3787.299349620329, 3809.0286976820735, 5078.542931136216, 5108.361454818148, 5170.508801663836, 5242.449542797951, 5252.65857719247, 5380.784768609212, 5390.757415916293, 5399.055165346049, 5399.676019438846, 5405.216243644728, 5118.820841270538, 5122.078025955364, 5132.28148059272, 5139.743012849342, 5142.382914050338, 4470.530594287618, 4511.390962220124, 4543.068670922453, 4573.49691533931, 4582.518835522289, 5595.552355811526, 5655.349634791969, 5663.801766938137, 5668.263125793538, 5672.064109421982, 5267.3152490176035, 5343.5457986071615, 5367.329083864517, 5368.731563421891, 5420.214068960057, 5708.172315014383, 5718.170865224436, 5744.339400968942, 5775.133729940542, 5785.739641716049, 5292.470752924677, 5302.337207849019, 5312.203169524602, 5315.521603055744, 5316.255724198538, 5274.182501712241, 5343.431783281051, 5347.117725575236, 5393.541548968225, 5445.074337362737, 5296.364436267672, 5299.655522391032, 5305.151175812006, 5338.733063346895, 5342.358916929993, 5260.210968354778, 5290.285811415563, 5290.788368465218, 5297.54970827484, 5353.384360798403, 5052.1663925451885, 5091.109055915274, 5167.638265321391, 5168.689878607295, 5168.767405466839, 5270.446603106772, 5283.313169287968, 5296.020236256305, 5303.992241474108, 5344.198370244494, 5100.515451032146, 5187.636865419385, 5189.299444574934, 5193.558547523503, 5194.220866869849], "unit": "score", "name": "dojo.html", "value": 4985.760650562243}, {"lowerIsBetter": false, "replicates": [507.9054637256711, 522.46969326134, 547.8630342414397, 586.8268860686097, 602.0908428273308, 27857.442851142965, 36169.819150904244, 36614.45078323827, 36757.0, 36778.8161059195, 39601.207975840465, 40217.195656086864, 40308.0, 40372.59627403725, 40488.19023619526, 7447.366973807233, 7589.848203035936, 8486.44838085524, 8735.082816304292, 10102.19182465401, 10079.848802267936, 10228.641997530089, 10236.0, 10238.180945524377, 10241.0, 10259.846102308435, 10394.376337419779, 10394.792104157912, 10395.32430392022, 10400.687979360631, 10480.109190718798, 10597.311174773615, 10607.84088238677, 10617.309874858109, 10630.255882088257, 10370.22223333253, 10582.15342772584, 10583.470826458723, 10617.628383006559, 10630.362178269252, 39598.0, 39935.800320998496, 39964.60035399638, 39975.60024399777, 40001.0, 3152.0, 3212.61448626164, 3278.9016329510155, 3407.1993081625797, 3539.292141571696, 29988.55017174744, 30240.54639180392, 30440.391192176256, 30816.69183308183, 31334.37331253385, 3606.6573675500786, 3680.7423480356388, 3688.748769256788, 3698.981505092457, 3801.1067399161175, 266788.0, 268159.0, 268495.0, 268686.0, 269350.0, 40576.0, 56407.43592564104, 56489.15266271009, 57053.71473142608, 57114.714426428436, 39904.600953990666, 40007.59992400097, 40041.39937900934, 40045.39931901024, 40065.59934400619, 12559.497620095277, 13646.317684115755, 13818.0, 13823.930880345735, 13843.238621875893, 10950.123990080774, 11119.777604447865, 11128.221024528368, 11142.220044596801, 11145.609903653332, 13313.134646247963, 13376.866231337757, 13387.397567109503, 13403.061785674909, 13455.25996070206, 5645.943540564624, 5779.913301300484, 5827.504662103684, 5876.7355469004, 5901.527877769769, 939.9671011514564, 940.4545363689044, 950.1638558068855, 987.9357841740264, 1074.8177005294115, 28348.85825570859, 28403.57394639082, 28595.71404285972, 28769.85615071953, 28789.424211515652, 987.980240395188, 994.1301361308855, 1044.3472829481575, 1062.9819283109857, 1164.1210885781181, 14301.570952871223, 14753.40986360555, 14797.186154761592, 15085.47200847965, 15122.773158402633, 300807.0, 303621.0, 303896.0, 304592.0, 305108.0, 50764.0, 52324.21513677298, 52438.73780631149, 52503.47496525062, 52612.210816837774, 1230.7415442757122, 1336.111485861891, 1349.0961056092638, 1400.1878910232042, 1497.169071165492, 25375.746242538076, 25721.842517086403, 25920.351991199615, 25977.870110649324, 26496.337591560365, 35937.64062359343, 35951.640483595875, 36319.818400907825, 36800.44799328066, 37076.0, 178023.0, 178058.0, 178173.0, 178195.0, 178196.0, 26989.0, 30642.846785765927, 30787.230319242197, 31043.534346985263, 31190.37619247557, 39282.0, 40579.0, 40719.1856162881, 40840.795796022016, 41415.0, 35027.47458788069, 35284.82357588196, 35394.29211415809, 35461.82269088741, 35667.64332356643, 35324.82337588296, 35345.0, 35367.0, 35555.466667999484, 36026.27947441089, 33703.0, 34314.82842585871, 34328.48507272443, 34492.482612761334, 34724.82637586796, 30629.846850766495, 31223.531647024858, 31445.68554314519, 31537.526937095503, 31664.366712665156, 24130.39674008164, 24153.396165096012, 24214.394640133432, 24566.26301210895, 24826.0], "unit": "score", "name": "ext.html", "value": 17440.007008198787}, {"lowerIsBetter": false, "replicates": [331.79262960649595, 339.13689659815765, 340.6253121566277, 343.21746418166583, 343.57739979824817, 16717.41489047882, 17052.658946821055, 17351.652966940652, 17888.82111178888, 17895.373661921803, 16189.919050404731, 16301.510954671348, 16436.506904792845, 16456.259468323926, 16471.423500177498, 4812.975935120337, 5252.395974462938, 5389.8113566025195, 5484.533814625762, 5488.835334939939, 5329.893402131955, 5350.785968561253, 5377.489138531852, 5381.838544843661, 5421.322334708161, 5079.74601269935, 5292.5765938725, 5335.759890804904, 5341.145416733323, 5344.251804747339, 5290.127129023706, 5292.761825717852, 5315.0432922074015, 5326.121190003664, 5329.626926115193, 4656.953430465685, 4703.741294228816, 4707.38803955487, 4709.081729062834, 4712.5051869553545, 20191.0, 20731.792682073286, 21009.369718908456, 21009.68485472719, 21219.68170477444, 2069.4205622425743, 2257.221258665758, 2393.401649587603, 2544.2875994721508, 2827.7313655202724, 9033.23217526511, 9368.812623747555, 11264.549418023269, 11385.9183377579, 13051.934740326238, 1742.4946765438008, 1847.8706490545667, 1865.0674662668666, 1896.8577356698304, 1905.0569967865856, 50790.74604626953, 52233.0, 57005.14492282661, 63216.866869361416, 64586.0, 10090.596376145018, 10164.136048435967, 10347.63783267582, 10410.115140213014, 10553.63062292816, 11944.880551194377, 12915.612531624067, 13205.405756740969, 13205.867941320656, 13224.0, 7256.363242049552, 7257.52826066304, 7311.488195826348, 7327.890081648779, 7561.659725312375, 7147.928520714726, 7163.212046674862, 7305.086864141982, 7315.561066336037, 7458.2541745826065, 4470.776461176928, 4561.2245918193985, 4562.771861406916, 4563.292689633112, 4620.052889157714, 1638.4101723379574, 1753.6229710612024, 1796.3533128073882, 1818.6544556534216, 1840.162725959685, 889.3374436045187, 911.9042500537481, 915.9450432974043, 937.6296362936602, 1001.5843424978698, 16088.597785055466, 16346.673066538602, 16704.74942875858, 16906.0, 16962.15189240533, 886.5744442667427, 902.0168016861652, 912.7763697893926, 948.1656142594472, 984.3995162950595, 9282.329180747396, 9416.717498475056, 9650.324477286664, 9685.564149613143, 9751.756206094762, 417520.0, 419646.0, 425003.0, 442558.0, 443055.0, 70119.0, 73179.26820731831, 74362.0, 74526.62736686281, 75452.24547754561, 1009.545704433008, 1020.2042406922612, 1044.6657069737762, 1054.5518154784186, 1056.7463808686014, 14590.489332873298, 14756.188409637572, 14872.553823385315, 14890.85109148938, 15238.3904643813, 25791.226263212135, 30761.8461907689, 31280.530792038593, 33058.33883322368, 34444.48333275053, 39629.0, 44826.0, 48920.5107948916, 51076.48923510866, 51613.741931290104, 7347.5224110432655, 7389.667464963982, 7530.096388433423, 7570.735024274344, 7636.045494313211, 10032.0, 11772.17594768358, 11829.408529573659, 12164.0, 12199.695007624525, 10237.129843963347, 10366.06705396518, 10424.374537527772, 10593.947030264799, 10596.629117980834, 10662.8400573993, 10875.401852898167, 11006.0, 11059.61291354831, 11155.44222788841, 10540.84188737185, 10680.57277708883, 10793.56825726962, 10797.0, 11170.609028684283, 7728.690852365842, 7729.304362607392, 7895.131535531202, 7937.801554961172, 8183.839140751842, 10302.793944121226, 10604.681859544226, 10629.627963021258, 10690.732731681459, 10774.515146818256], "unit": "score", "name": "jquery.html", "value": 8268.413689852501}, {"lowerIsBetter": false, "replicates": [1364.7065880835619, 1496.8353481117078, 1526.6793973265617, 1683.2509533257705, 1822.2528763207088, 7736.613169341532, 7909.6836126554945, 7944.086430060552, 7944.563049032301, 7944.602769861513, 7755.302022817945, 7800.180980996999, 7856.8035799105055, 7857.92142078579, 7861.68553257869, 1999.3102379678987, 2169.511859831541, 2200.5488874780713, 2224.6663000549884, 2226.9888650556722, 2264.230161745006, 2268.7731226877345, 2269.4099534121083, 2271.931842044733, 2272.4318920269934, 2203.724534433196, 2212.6127927612683, 2282.463621049052, 2283.2465286455513, 2285.714285714286, 2228.1644383356324, 2230.2194232018746, 2234.7988681018705, 2258.175765845471, 2315.3169814904477, 2177.945551361229, 2182.639864422368, 2194.659827726689, 2198.0548364203387, 2198.65920782279, 7916.6833326666865, 7960.522368657841, 7967.322777563914, 7968.482048666876, 7989.840203195961, 4669.556392142741, 4728.172569800271, 4734.0, 4737.170995075882, 4776.785044672998, 2939.103573410109, 3031.7271445570004, 3066.7699922505903, 3074.431230222416, 3078.0611913366415, 978.848278516831, 990.2622546203053, 1004.909558139771, 1010.6715317521835, 1032.5250384822916, 10754.892451075468, 10762.192835537287, 10795.028447439769, 10826.24216304859, 10831.07935825448, 3946.861859834892, 4086.366613174963, 4130.752154870717, 4172.144710334374, 4185.309423945076, 8568.271696905833, 8792.560371981375, 8821.117888211127, 8825.0, 8862.113788621085, 4753.453352864396, 4771.976140119277, 4789.209780386267, 4791.233402655558, 4792.185328494164, 3979.5622481527007, 4317.978410107929, 4396.956030439655, 4441.20058389493, 4445.5776701213335, 3373.983130084383, 3427.4002049641713, 3432.262063656326, 3455.740819438552, 3467.1852114753015, 1006.8741407324085, 1010.0858722855827, 1014.3204053284318, 1016.9440680762481, 1017.4861694844204, 1287.909846310768, 1306.7713150198676, 1310.4823594680238, 1331.1214598365227, 1345.8115863779078, 7483.0, 7612.80967975805, 7618.085829700472, 7620.3522700571075, 7633.5419874807685, 448.21338550843063, 455.85640523235736, 458.1478450082843, 462.3919545797266, 474.49466318371515, 5808.6224395414165, 5835.124731290341, 5881.764729410861, 5887.381824908409, 5904.350521442638, 9521.256261697969, 9930.602775888883, 9988.550515226832, 10006.799864002825, 10130.138938190188, 9897.65358212459, 9956.701298961043, 9974.551145198484, 10047.09576138151, 10048.0, 7453.552786832807, 7648.502847314907, 7667.233276672288, 7711.884321735179, 7766.378689704923, 7110.146782386147, 7150.070490836158, 7226.494145409771, 7235.927640723526, 7254.45591580623, 8415.4109212357, 8739.43193692408, 8856.07011263808, 8861.424007439497, 8883.200511953955, 8698.695545655872, 8820.691275805317, 8826.64693412282, 8842.336824738042, 8970.506622135845, 6279.372062793684, 7016.473764467583, 7137.321954414322, 7397.371223445852, 7614.847703045797, 7649.273319034683, 7682.923170768221, 7683.193264707125, 7718.6140692964, 7733.265339792711, 6871.9656401717675, 6913.3777959983845, 6945.166580010431, 7057.2237053923, 7177.605231712306, 6720.1263835703, 6772.559783614246, 6784.185897692111, 6809.93190068093, 6960.23437421873, 6936.687849046906, 7041.788746337618, 7075.82310442243, 7079.079719636415, 7120.537165084253, 6622.039804228456, 6623.867522649423, 6646.03632473279, 6676.031975363642, 6678.532502724763, 6503.349665033459, 6586.37429444202, 6613.768518102036, 6622.933770662232, 6630.0], "unit": "score", "name": "mootools.html", "value": 4408.047092032988}, {"lowerIsBetter": false, "replicates": [308.1018830110229, 310.1610144558968, 310.93936682346936, 310.9766767492437, 311.50004243189693, 5774.6535207887555, 5782.566307526931, 5821.214136091627, 5835.766569337221, 5853.912191317134, 5723.341815691197, 5723.9141412878735, 5742.167385729077, 5746.310442746876, 5746.798862039829, 4223.36649502574, 4316.352547117926, 4429.15845989261, 4454.710443821157, 4461.219286624828, 4425.203463376591, 4447.4218351614245, 4456.955430445702, 4458.2866741321395, 4461.263891457906, 4197.895052623679, 4411.80146893389, 4414.823407063714, 4423.955760442403, 4426.97786511067, 4278.957210427918, 4302.591253830897, 4310.4611923509565, 4395.582419670126, 4403.405540252057, 3826.330392181357, 3842.212346468967, 3844.4430005847676, 3846.499955005859, 3851.73037887348, 5501.284832971688, 5502.367227768817, 5512.476314750093, 5513.062779327524, 5518.558515318805, 5119.897602047976, 5123.820666276662, 5129.717865517395, 5130.1791713326065, 5131.743412829381, 6072.332043475214, 6097.756089756404, 6100.115483254947, 6106.419890110433, 6127.662978536178, 4042.0905296308097, 4167.708260421772, 4176.0, 4259.97870010648, 4271.273883439822, 6341.8414539636415, 6394.264659564164, 6425.293217746044, 6434.292227854979, 6452.161219041542, 4263.040815816416, 4263.829446822155, 4264.317709166518, 4264.530901600821, 4267.551907049778, 4316.589923957219, 4318.050028993616, 4318.503372112247, 4319.352097185448, 4325.589069038437, 5059.392872855281, 5067.442581316126, 5070.087384270867, 5072.163093089599, 5082.618803589746, 6042.942485065096, 6190.2571691397325, 6194.659293738888, 6199.721012554446, 6201.10084037812, 1489.3893503663446, 1504.3907217576898, 1507.4422463688506, 1508.4644951042442, 1512.6520900193018, 927.0497739816742, 967.6613185385199, 971.8639390485338, 987.3730181334761, 998.8152191844532, 5883.441073098049, 5913.704314784243, 5919.260092488439, 5929.37741537141, 5941.762329506858, 6288.937110628835, 6324.557280990379, 6340.968295158495, 6389.393007664265, 6394.136791533177, 5913.733881975236, 5923.466887980103, 5923.674197919069, 5928.229330187048, 5929.881402371929, 3366.057503898863, 3398.677125673057, 3398.9830050849587, 3401.795892246473, 3403.1322012886553, 6543.214814222324, 6680.665966701646, 6694.665266736741, 6760.357766012221, 6831.69257383419, 6522.0, 6550.2794692583775, 6558.639274839929, 6563.343665633399, 6570.967145164339, 6786.321367863273, 6794.320567943265, 6795.52431329812, 6806.18325800907, 6806.387425131762, 6409.0, 6410.262819775786, 6415.582987105823, 6416.422521973045, 6418.711157997995, 6210.192674952227, 6355.110284560258, 6364.840878978062, 6374.58565193261, 6382.393672601095, 6750.45996320303, 6779.118714567075, 6792.626405547742, 6799.422049125879, 6804.217514985642, 4244.957550424456, 4305.397244385851, 4306.569343065668, 4306.935395969125, 4309.612134907873, 6343.9682801585695, 6404.199475065617, 6414.839629009312, 6424.550281480439, 6428.646424446701, 6215.844603884939, 6218.06728990655, 6222.688865556614, 6233.532485063548, 6234.096056071935, 6064.605800622945, 6224.439800417984, 6233.407826256498, 6238.220222472191, 6239.500839932885, 6015.849603759941, 6062.090686397076, 6063.090536419396, 6064.090386441892, 6070.939290607037, 6190.7214175363115, 6250.749970001149, 6255.280642726145, 6257.0, 6258.186435763321, 5888.205092312483, 5966.850828729316, 6104.4200800923845, 6115.602485838406, 6125.571210015256], "unit": "score", "name": "prototype.html", "value": 4622.709424862483}, {"lowerIsBetter": false, "replicates": [738.3613174603967, 820.5568992743919, 823.5758584329068, 838.5136620759956, 861.4917198852678, 13844.861551384496, 14098.0, 14171.574852754407, 14175.503857364982, 14198.71602567948, 13366.0, 13390.732185356286, 13466.12470189437, 14127.788083178735, 14201.0, 843.9409241353108, 850.4472093139478, 857.297016446511, 859.0, 862.3316929379719, 853.1681610429844, 853.9444936079135, 854.2567965869671, 855.1405837133703, 855.4012191465968, 896.256107430834, 897.9102089791002, 897.9551022448884, 898.034612791252, 899.6986009686763, 886.8669699545087, 887.5384799904078, 888.0, 888.9111088891124, 890.3366991591241, 655.8655475627485, 656.1863289521008, 656.2387630348773, 658.5159907468008, 661.2759028863387, 13256.602301930958, 13261.668458288523, 13310.068295219338, 13312.400941957538, 13318.334083295797, 10670.466476676134, 10759.0, 11065.668029959113, 11983.0, 12183.634490965196, 9683.983181765954, 9792.559334829879, 9857.260705447121, 9905.0, 9969.55137018836, 3467.7572569920117, 3481.1123163593375, 3532.982335088334, 3545.308664810363, 3657.65252301031, 49017.99999999964, 49217.0, 49621.751891240674, 49664.50335496635, 49789.0, 9118.498482583522, 9232.584533696, 9308.301877359225, 9654.22766178704, 9717.0, 17015.489535313962, 17033.14834258307, 17083.91458042702, 17094.05982670965, 17101.0, 7430.962845185848, 7504.099508059068, 7665.61671916402, 7741.264579864904, 7831.177726338652, 4151.294279972412, 4257.723247988933, 4343.1530851484285, 4398.670099742532, 4497.347884556786, 3123.141136187521, 3147.496400575897, 3148.968510314913, 3153.3377990621766, 3157.4000939821362, 542.0, 550.8815604645021, 552.6021264689417, 556.1629747230393, 560.3751816724323, 661.8543920337518, 676.4182802789597, 699.5313140195979, 704.1374316462395, 713.2261496276494, 8211.371197541383, 8409.747707568782, 8720.825583488422, 8785.692500762443, 8856.438460079693, 699.3076853914689, 699.6746512871539, 709.5104377979178, 711.2212127720138, 724.7318492157935, 3906.7851268179957, 3923.8822835314986, 4011.13760541485, 4028.5971402860064, 4075.7554546727292, 48555.75722121437, 49480.25779613309, 49492.25761613579, 49560.256596151085, 49562.25656615154, 38997.905010960865, 46422.30366544505, 48119.278210826866, 48682.26976595354, 53491.0, 44194.77902610466, 44470.0, 44901.55098449039, 45028.77485612616, 45334.0, 8303.211194936472, 8510.74467765968, 8532.829343413221, 8560.48637081777, 8685.826283474169, 32424.0, 32459.513107302937, 32984.67015329816, 33344.0, 33796.32407351888, 39026.219475610895, 41574.0, 43166.78416607897, 43228.78385608052, 43466.0, 10731.248812583357, 10766.784664306826, 10843.186760993114, 10995.505202265756, 11053.115750740082, 12152.513899443924, 12294.139410241198, 12356.876431235572, 12769.489220431078, 12770.87229127734, 11270.492827822603, 11558.07535397183, 11613.76772464563, 11751.118666100248, 12051.397430128634, 9362.765930851783, 9588.520573971413, 9699.757506062122, 9730.805383892424, 9913.30606857513, 10901.454927253764, 10934.179936504954, 10939.28894621847, 11282.323060616389, 11386.601468948547, 9119.635214591342, 9237.445753254826, 9263.953680231556, 9291.76770580741, 9332.813343733224, 8922.73231803047, 8926.509042002752, 9000.5134686784, 9117.179453849185, 9620.13418792312], "unit": "score", "name": "yui.html", "value": 6243.138575495248}], "name": "dromaeo_css", "value": 6712.4449762775785}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 107.0, 111.0, 111.0, 112.0, 100.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 151.0, 165.0, 129.0, 148.0, 157.0, 128.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 169.0, 161.0, 159.0, 161.0, 161.0, 164.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 107.0, 93.0, 73.0, 73.0, 74.0, 128.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 142.0, 96.0, 96.0, 95.0, 151.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 115.0, 115.0, 115.0, 116.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 57.0, 56.0, 56.0, 56.0, 64.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 83.0, 83.0, 81.0, 88.0, 83.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 115.0, 120.0, 115.0, 123.0, 114.0, 116.0, 138.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [157.0, 138.0, 152.0, 148.0, 150.0, 139.0, 154.0, 149.0, 148.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 75.0, 68.0, 70.0, 69.0, 71.0, 71.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1516.8}]} 22:15:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1516.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6712.45"}}} 22:15:10 INFO - Return code: 0 22:15:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:15:10 INFO - # TBPL SUCCESS # 22:15:10 INFO - Running post-action listener: _resource_record_post_action 22:15:10 INFO - Running post-run listener: _resource_record_post_run 22:15:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 536776704; Read time: 384; Write time: 1135880 22:15:12 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 4096; Write bytes: 240992256; Read time: 356; Write time: 707240 22:15:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295784448; Read time: 28; Write time: 428640 22:15:12 INFO - Running post-run listener: _upload_blobber_files 22:15:12 INFO - Blob upload gear active. 22:15:12 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:15:12 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:15:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:15:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:15:12 INFO - (blobuploader) - INFO - Open directory for files ... 22:15:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:15:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:15:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:13 INFO - (blobuploader) - INFO - Done attempting. 22:15:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:15:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:14 INFO - (blobuploader) - INFO - Done attempting. 22:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 22:15:14 INFO - Return code: 0 22:15:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:15:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d9865b936f248023cf68daa2644f9e8b21d3e29ab45d6cc8c895935fbb40b938f420c8336bd78423e8131b44bbcfbcee6d5f92de0911bb1d88599769d1d20db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4911a0b0be5099c03832ecadb16652b5f401e78df2479c2bbd2bfcec9778a804c6264a5f964855489bfe9183042ed9f19f4165ce8dedef9063a5865d634741f9"} 22:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:15:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:15:14 INFO - Contents: 22:15:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d9865b936f248023cf68daa2644f9e8b21d3e29ab45d6cc8c895935fbb40b938f420c8336bd78423e8131b44bbcfbcee6d5f92de0911bb1d88599769d1d20db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4911a0b0be5099c03832ecadb16652b5f401e78df2479c2bbd2bfcec9778a804c6264a5f964855489bfe9183042ed9f19f4165ce8dedef9063a5865d634741f9"} 22:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 22:15:14 INFO - Copying logs to upload dir... 22:15:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.768625 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-26 22:15:13.748317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 22:15:13.751992) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d9865b936f248023cf68daa2644f9e8b21d3e29ab45d6cc8c895935fbb40b938f420c8336bd78423e8131b44bbcfbcee6d5f92de0911bb1d88599769d1d20db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4911a0b0be5099c03832ecadb16652b5f401e78df2479c2bbd2bfcec9778a804c6264a5f964855489bfe9183042ed9f19f4165ce8dedef9063a5865d634741f9"} build_url:https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/Mu2ZSgEpRFeOsU6rTncO2g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d9865b936f248023cf68daa2644f9e8b21d3e29ab45d6cc8c895935fbb40b938f420c8336bd78423e8131b44bbcfbcee6d5f92de0911bb1d88599769d1d20db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4911a0b0be5099c03832ecadb16652b5f401e78df2479c2bbd2bfcec9778a804c6264a5f964855489bfe9183042ed9f19f4165ce8dedef9063a5865d634741f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 22:15:13.775932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 22:15:13.776216) ========= 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=af724c981e2a0f424dbabf99000001e7-1456550901.174464-2128796052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 22:15:13.860317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 22:15:13.860671) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 22:15:13.860952) ========= ========= Total master_lag: 0.32 =========