builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1454855894.67 results: success (0) buildid: 20160207030402 builduid: 41df0b2c3603470d819869e81b07bf97 revision: 76733110704b975154ac0fa779445e6eae5da559 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.667306) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.667732) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.668043) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006366 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.696405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.696701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.713370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.713663) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.762813) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.763109) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.763495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.763827) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-07 06:38:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-02-07 06:38:15 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.952919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:14.953268) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015510 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.003189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.003587) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 76733110704b975154ac0fa779445e6eae5da559 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 76733110704b975154ac0fa779445e6eae5da559 --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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-07 06:38:15,862 truncating revision to first 12 chars 2016-02-07 06:38:15,862 Setting DEBUG logging. 2016-02-07 06:38:15,863 attempt 1/10 2016-02-07 06:38:15,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/76733110704b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-07 06:38:16,126 unpacking tar archive at: mozilla-central-76733110704b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541064 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.558001) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.558368) ========= echo 76733110704b975154ac0fa779445e6eae5da559 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'76733110704b975154ac0fa779445e6eae5da559'] 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76733110704b975154ac0fa779445e6eae5da559 program finished with exit code 0 elapsedTime=0.003533 script_repo_revision: '76733110704b975154ac0fa779445e6eae5da559' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.607563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.607942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-07 06:38:15.618278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-07 06:38:15.618795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:38:16 INFO - MultiFileLogger online at 20160207 06:38:16 in /builds/slave/test-pgo 06:38:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:38:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:38:16 INFO - {'append_to_log': False, 06:38:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:38:16 INFO - 'blob_upload_branch': 'Firefox', 06:38:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:38:16 INFO - 'branch': 'Firefox', 06:38:16 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:16 INFO - 'config_files': ('talos/linux_config.py',), 06:38:16 INFO - 'default_actions': ('clobber', 06:38:16 INFO - 'read-buildbot-config', 06:38:16 INFO - 'download-and-extract', 06:38:16 INFO - 'populate-webroot', 06:38:16 INFO - 'create-virtualenv', 06:38:16 INFO - 'install', 06:38:16 INFO - 'run-tests'), 06:38:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:16 INFO - 'download_minidump_stackwalk': True, 06:38:16 INFO - 'download_symbols': 'ondemand', 06:38:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:16 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:16 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:16 INFO - 'installer_path': 'installer.exe', 06:38:16 INFO - 'log_level': 'info', 06:38:16 INFO - 'log_name': 'talos', 06:38:16 INFO - 'log_to_console': True, 06:38:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:38:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:38:16 INFO - 'opt_config_files': (), 06:38:16 INFO - 'pip_index': False, 06:38:16 INFO - 'sps_profile': False, 06:38:16 INFO - 'sps_profile_interval': 0, 06:38:16 INFO - 'suite': 'dromaeojs', 06:38:16 INFO - 'system_bits': '32', 06:38:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:16 INFO - 'title': 'talos-linux64-ix-020', 06:38:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:16 INFO - 'use_talos_json': True, 06:38:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:38:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:16 INFO - 'work_dir': 'build'} 06:38:16 INFO - ##### 06:38:16 INFO - ##### Running clobber step. 06:38:16 INFO - ##### 06:38:16 INFO - Running pre-action listener: _resource_record_pre_action 06:38:16 INFO - Running main action method: clobber 06:38:16 INFO - rmtree: /builds/slave/test-pgo/build 06:38:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:38:17 INFO - Running post-action listener: _resource_record_post_action 06:38:17 INFO - ##### 06:38:17 INFO - ##### Running read-buildbot-config step. 06:38:17 INFO - ##### 06:38:17 INFO - Running pre-action listener: _resource_record_pre_action 06:38:17 INFO - Running main action method: read_buildbot_config 06:38:17 INFO - Using buildbot properties: 06:38:17 INFO - { 06:38:17 INFO - "project": "", 06:38:17 INFO - "product": "firefox", 06:38:17 INFO - "script_repo_revision": "production", 06:38:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:38:17 INFO - "repository": "", 06:38:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:38:17 INFO - "buildid": "20160207030402", 06:38:17 INFO - "stage_platform": "linux64-pgo", 06:38:17 INFO - "basedir": "/builds/slave/test-pgo", 06:38:17 INFO - "nightly_build": "True", 06:38:17 INFO - "buildnumber": 186, 06:38:17 INFO - "slavename": "talos-linux64-ix-020", 06:38:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:38:17 INFO - "platform": "ubuntu64_hw", 06:38:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:38:17 INFO - "branch": "mozilla-central", 06:38:17 INFO - "repo_path": "mozilla-central", 06:38:17 INFO - "revision": "76733110704b975154ac0fa779445e6eae5da559", 06:38:17 INFO - "pgo_build": "True", 06:38:17 INFO - "builduid": "41df0b2c3603470d819869e81b07bf97", 06:38:17 INFO - "slavebuilddir": "test" 06:38:17 INFO - } 06:38:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:38:17 INFO - Running post-action listener: _resource_record_post_action 06:38:17 INFO - ##### 06:38:17 INFO - ##### Running download-and-extract step. 06:38:17 INFO - ##### 06:38:17 INFO - Running pre-action listener: _resource_record_pre_action 06:38:17 INFO - Running main action method: download_and_extract 06:38:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:17 INFO - https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/test_packages.json 06:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/test_packages.json 06:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:38:23 INFO - Downloaded 1448 bytes. 06:38:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:38:23 INFO - Using the following test package requirements: 06:38:23 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:23 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:38:23 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:38:23 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'jsshell-linux-x86_64.zip'], 06:38:23 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:38:23 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:23 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:38:23 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:38:23 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:38:23 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:38:23 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:38:23 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:38:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:23 INFO - https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:38:27 INFO - Downloaded 23574839 bytes. 06:38:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:38:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:38:28 INFO - Return code: 0 06:38:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:28 INFO - https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:38:30 INFO - Downloaded 23574839 bytes. 06:38:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:38:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:38:31 INFO - Return code: 0 06:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:31 INFO - https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:38:32 INFO - Downloaded 10706547 bytes. 06:38:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:38:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:38:32 INFO - Return code: 0 06:38:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:32 INFO - https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:38:34 INFO - Downloaded 56550288 bytes. 06:38:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:38:34 INFO - mkdir: /builds/slave/test-pgo/properties 06:38:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:38:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:38:34 INFO - Contents: 06:38:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:38:34 INFO - Running post-action listener: _resource_record_post_action 06:38:34 INFO - Running post-action listener: set_extra_try_arguments 06:38:34 INFO - ##### 06:38:34 INFO - ##### Running populate-webroot step. 06:38:35 INFO - ##### 06:38:35 INFO - Running pre-action listener: _resource_record_pre_action 06:38:35 INFO - Running main action method: populate_webroot 06:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:35 INFO - '--tppagecycles', 06:38:35 INFO - '7'], 06:38:35 INFO - 'tests': ['tsvgm']}}, 06:38:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:38:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:38:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'tests': ['damp', 'tps']}, 06:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['damp', 'tps']}, 06:38:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:38:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:35 INFO - 'other': {'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'other_l64': {'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'other_nol64': {'tests': ['a11yr', 06:38:35 INFO - 'ts_paint', 06:38:35 INFO - 'tpaint', 06:38:35 INFO - 'sessionrestore', 06:38:35 INFO - 'sessionrestore_no_auto_restore']}, 06:38:35 INFO - 'svgr': {'tests': ['tsvgx', 06:38:35 INFO - 'tsvgr_opacity', 06:38:35 INFO - 'tart', 06:38:35 INFO - 'tscrollx', 06:38:35 INFO - 'cart']}, 06:38:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['tsvgx', 06:38:35 INFO - 'tsvgr_opacity', 06:38:35 INFO - 'tart', 06:38:35 INFO - 'tscrollx', 06:38:35 INFO - 'cart']}, 06:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'tests': ['tp5o']}, 06:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'talos_options': ['--e10s'], 06:38:35 INFO - 'tests': ['tp5o']}, 06:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'talos_options': ['--xperf_path', 06:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:35 INFO - 'tests': ['tp5n']}, 06:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:35 INFO - 'talos_options': ['--e10s', 06:38:35 INFO - '--xperf_path', 06:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:35 INFO - 'tests': ['tp5n']}}, 06:38:35 INFO - 'talos.zip': {'path': '', 06:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:35 INFO - Running post-action listener: _resource_record_post_action 06:38:35 INFO - ##### 06:38:35 INFO - ##### Running create-virtualenv step. 06:38:35 INFO - ##### 06:38:35 INFO - Running pre-action listener: _resource_record_pre_action 06:38:35 INFO - Running main action method: create_virtualenv 06:38:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:38:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 06:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:35 INFO - Using real prefix '/usr' 06:38:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:38:35 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:37 INFO - Installing pip.................done. 06:38:37 INFO - Return code: 0 06:38:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:38:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:38:37 INFO - Using env: {'DISPLAY': ':0', 06:38:37 INFO - 'HOME': '/home/cltbld', 06:38:37 INFO - 'LANG': 'en_US.UTF-8', 06:38:37 INFO - 'LANGUAGE': 'en_US:en', 06:38:37 INFO - 'LOGNAME': 'cltbld', 06:38:37 INFO - 'MAIL': '/var/mail/cltbld', 06:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:37 INFO - 'MOZ_NO_REMOTE': '1', 06:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:37 INFO - 'NO_EM_RESTART': '1', 06:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:37 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:37 INFO - 'SHELL': '/bin/bash', 06:38:37 INFO - 'SHLVL': '1', 06:38:37 INFO - 'TERM': 'linux', 06:38:37 INFO - 'TMOUT': '86400', 06:38:37 INFO - 'USER': 'cltbld', 06:38:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:37 INFO - '_': '/tools/buildbot/bin/python'} 06:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:38:37 INFO - Cleaning up... 06:38:37 INFO - Return code: 0 06:38:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:38:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:38:37 INFO - Using env: {'DISPLAY': ':0', 06:38:37 INFO - 'HOME': '/home/cltbld', 06:38:37 INFO - 'LANG': 'en_US.UTF-8', 06:38:37 INFO - 'LANGUAGE': 'en_US:en', 06:38:37 INFO - 'LOGNAME': 'cltbld', 06:38:37 INFO - 'MAIL': '/var/mail/cltbld', 06:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:37 INFO - 'MOZ_NO_REMOTE': '1', 06:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:37 INFO - 'NO_EM_RESTART': '1', 06:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:37 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:37 INFO - 'SHELL': '/bin/bash', 06:38:37 INFO - 'SHLVL': '1', 06:38:37 INFO - 'TERM': 'linux', 06:38:37 INFO - 'TMOUT': '86400', 06:38:37 INFO - 'USER': 'cltbld', 06:38:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:37 INFO - '_': '/tools/buildbot/bin/python'} 06:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:38 INFO - Downloading/unpacking psutil>=0.7.1 06:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:39 INFO - Installing collected packages: psutil 06:38:39 INFO - Running setup.py install for psutil 06:38:39 INFO - building 'psutil._psutil_linux' extension 06:38:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:38:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:38:40 INFO - building 'psutil._psutil_posix' extension 06:38:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:38:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:40 INFO - Successfully installed psutil 06:38:40 INFO - Cleaning up... 06:38:40 INFO - Return code: 0 06:38:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:38: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')]} 06:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:40 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:38:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:38:40 INFO - Using env: {'DISPLAY': ':0', 06:38:40 INFO - 'HOME': '/home/cltbld', 06:38:40 INFO - 'LANG': 'en_US.UTF-8', 06:38:40 INFO - 'LANGUAGE': 'en_US:en', 06:38:40 INFO - 'LOGNAME': 'cltbld', 06:38:40 INFO - 'MAIL': '/var/mail/cltbld', 06:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:40 INFO - 'MOZ_NO_REMOTE': '1', 06:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:40 INFO - 'NO_EM_RESTART': '1', 06:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:40 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:40 INFO - 'SHELL': '/bin/bash', 06:38:40 INFO - 'SHLVL': '1', 06:38:40 INFO - 'TERM': 'linux', 06:38:40 INFO - 'TMOUT': '86400', 06:38:40 INFO - 'USER': 'cltbld', 06:38:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:40 INFO - '_': '/tools/buildbot/bin/python'} 06:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:38:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:38:42 INFO - Installing collected packages: mozsystemmonitor 06:38:42 INFO - Running setup.py install for mozsystemmonitor 06:38:42 INFO - Successfully installed mozsystemmonitor 06:38:42 INFO - Cleaning up... 06:38:42 INFO - Return code: 0 06:38:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:42 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:38:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:38:42 INFO - Using env: {'DISPLAY': ':0', 06:38:42 INFO - 'HOME': '/home/cltbld', 06:38:42 INFO - 'LANG': 'en_US.UTF-8', 06:38:42 INFO - 'LANGUAGE': 'en_US:en', 06:38:42 INFO - 'LOGNAME': 'cltbld', 06:38:42 INFO - 'MAIL': '/var/mail/cltbld', 06:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:42 INFO - 'MOZ_NO_REMOTE': '1', 06:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:42 INFO - 'NO_EM_RESTART': '1', 06:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:42 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:42 INFO - 'SHELL': '/bin/bash', 06:38:42 INFO - 'SHLVL': '1', 06:38:42 INFO - 'TERM': 'linux', 06:38:42 INFO - 'TMOUT': '86400', 06:38:42 INFO - 'USER': 'cltbld', 06:38:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:42 INFO - '_': '/tools/buildbot/bin/python'} 06:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:42 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:44 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:38:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:45 INFO - Downloading docopt-0.6.1.tar.gz 06:38:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:45 INFO - Running setup.py install for blobuploader 06:38:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:38:45 INFO - Running setup.py install for requests 06:38:45 INFO - Running setup.py install for docopt 06:38:45 INFO - Successfully installed blobuploader requests docopt 06:38:45 INFO - Cleaning up... 06:38:45 INFO - Return code: 0 06:38:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:38:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:45 INFO - Using env: {'DISPLAY': ':0', 06:38:45 INFO - 'HOME': '/home/cltbld', 06:38:45 INFO - 'LANG': 'en_US.UTF-8', 06:38:45 INFO - 'LANGUAGE': 'en_US:en', 06:38:45 INFO - 'LOGNAME': 'cltbld', 06:38:45 INFO - 'MAIL': '/var/mail/cltbld', 06:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:45 INFO - 'MOZ_NO_REMOTE': '1', 06:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:45 INFO - 'NO_EM_RESTART': '1', 06:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:45 INFO - 'SHELL': '/bin/bash', 06:38:45 INFO - 'SHLVL': '1', 06:38:45 INFO - 'TERM': 'linux', 06:38:45 INFO - 'TMOUT': '86400', 06:38:45 INFO - 'USER': 'cltbld', 06:38:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:45 INFO - '_': '/tools/buildbot/bin/python'} 06:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:38:46 INFO - Running setup.py (path:/tmp/pip-AVIZLt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:38:46 INFO - Running setup.py (path:/tmp/pip-FLHGUi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:38:46 INFO - Running setup.py (path:/tmp/pip-AKiLV2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:38:46 INFO - Running setup.py (path:/tmp/pip-O8JspP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:38:46 INFO - Running setup.py (path:/tmp/pip-2U6ess-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:38:46 INFO - Running setup.py (path:/tmp/pip-c6uK2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:38:46 INFO - Running setup.py (path:/tmp/pip-SLXQuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:38:46 INFO - Running setup.py (path:/tmp/pip-GSk08l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:38:46 INFO - Running setup.py (path:/tmp/pip-Ns999C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:38:46 INFO - Running setup.py (path:/tmp/pip-0RYaI2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:38:46 INFO - Running setup.py (path:/tmp/pip-GtGt2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:38:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:38:46 INFO - Running setup.py (path:/tmp/pip-esAR0B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:38:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:38:47 INFO - Running setup.py (path:/tmp/pip-pdQV0M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:38:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:38:47 INFO - Running setup.py (path:/tmp/pip-298Ucb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:38:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:38:47 INFO - Running setup.py (path:/tmp/pip-xH440m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:38:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:38:47 INFO - Running setup.py (path:/tmp/pip-r2NP2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:38:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:38:47 INFO - Running setup.py (path:/tmp/pip-vd66xG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:38:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:47 INFO - Running setup.py install for manifestparser 06:38:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:38:47 INFO - Running setup.py install for mozcrash 06:38:47 INFO - Running setup.py install for mozdebug 06:38:47 INFO - Running setup.py install for mozdevice 06:38:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:38:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:38:47 INFO - Running setup.py install for mozfile 06:38:47 INFO - Running setup.py install for mozhttpd 06:38:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:38:47 INFO - Running setup.py install for mozinfo 06:38:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for mozInstall 06:38:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for mozleak 06:38:48 INFO - Running setup.py install for mozlog 06:38:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for moznetwork 06:38:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for mozprocess 06:38:48 INFO - Running setup.py install for mozprofile 06:38:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for mozrunner 06:38:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:38:48 INFO - Running setup.py install for mozscreenshot 06:38:48 INFO - Running setup.py install for moztest 06:38:49 INFO - Running setup.py install for mozversion 06:38:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:38:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:49 INFO - Cleaning up... 06:38:49 INFO - Return code: 0 06:38:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:49 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:38:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:38:49 INFO - Using env: {'DISPLAY': ':0', 06:38:49 INFO - 'HOME': '/home/cltbld', 06:38:49 INFO - 'LANG': 'en_US.UTF-8', 06:38:49 INFO - 'LANGUAGE': 'en_US:en', 06:38:49 INFO - 'LOGNAME': 'cltbld', 06:38:49 INFO - 'MAIL': '/var/mail/cltbld', 06:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:49 INFO - 'MOZ_NO_REMOTE': '1', 06:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:49 INFO - 'NO_EM_RESTART': '1', 06:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:49 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:49 INFO - 'SHELL': '/bin/bash', 06:38:49 INFO - 'SHLVL': '1', 06:38:49 INFO - 'TERM': 'linux', 06:38:49 INFO - 'TMOUT': '86400', 06:38:49 INFO - 'USER': 'cltbld', 06:38:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:49 INFO - '_': '/tools/buildbot/bin/python'} 06:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:38:49 INFO - Running setup.py (path:/tmp/pip-pm_ABX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:38:49 INFO - Running setup.py (path:/tmp/pip-jwvR5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:38:49 INFO - Running setup.py (path:/tmp/pip-i5AxmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:38:49 INFO - Running setup.py (path:/tmp/pip-FM3r5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:38:49 INFO - Running setup.py (path:/tmp/pip-gcWmZ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:38:49 INFO - Running setup.py (path:/tmp/pip-niuHGu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:38:49 INFO - Running setup.py (path:/tmp/pip-0Hlf42-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:38:49 INFO - Running setup.py (path:/tmp/pip-NFIP2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:38:49 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)) 06:38:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:38:49 INFO - Running setup.py (path:/tmp/pip-QnXX2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:38:50 INFO - Running setup.py (path:/tmp/pip-BSXvqV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:38:50 INFO - Running setup.py (path:/tmp/pip-Jt66AA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:38:50 INFO - Running setup.py (path:/tmp/pip-ec1Xce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:38:50 INFO - Running setup.py (path:/tmp/pip-i329vX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:38:50 INFO - Running setup.py (path:/tmp/pip-7lVPLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:38:50 INFO - Running setup.py (path:/tmp/pip-_fXFXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:38:50 INFO - Running setup.py (path:/tmp/pip-C8TJsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:38:50 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)) 06:38:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:38:50 INFO - Running setup.py (path:/tmp/pip-P3vbos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:38:50 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)) 06:38:50 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)) 06:38:50 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)) 06:38:50 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)) 06:38:50 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)) 06:38:50 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)) 06:38:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:52 INFO - Downloading blessings-1.6.tar.gz 06:38:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:38:52 INFO - Installing collected packages: blessings 06:38:52 INFO - Running setup.py install for blessings 06:38:52 INFO - Successfully installed blessings 06:38:52 INFO - Cleaning up... 06:38:52 INFO - Return code: 0 06:38:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:38:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:38:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:38:52 INFO - Reading from file tmpfile_stdout 06:38:52 INFO - Current package versions: 06:38:52 INFO - argparse == 1.2.1 06:38:52 INFO - blessings == 1.6 06:38:52 INFO - blobuploader == 1.2.4 06:38:52 INFO - docopt == 0.6.1 06:38:52 INFO - manifestparser == 1.1 06:38:52 INFO - mozInstall == 1.12 06:38:52 INFO - mozcrash == 0.16 06:38:52 INFO - mozdebug == 0.1 06:38:52 INFO - mozdevice == 0.48 06:38:52 INFO - mozfile == 1.2 06:38:52 INFO - mozhttpd == 0.7 06:38:52 INFO - mozinfo == 0.9 06:38:52 INFO - mozleak == 0.1 06:38:52 INFO - mozlog == 3.1 06:38:52 INFO - moznetwork == 0.27 06:38:52 INFO - mozprocess == 0.22 06:38:52 INFO - mozprofile == 0.28 06:38:52 INFO - mozrunner == 6.11 06:38:52 INFO - mozscreenshot == 0.1 06:38:52 INFO - mozsystemmonitor == 0.0 06:38:52 INFO - moztest == 0.7 06:38:52 INFO - mozversion == 1.4 06:38:52 INFO - psutil == 3.1.1 06:38:52 INFO - requests == 1.2.3 06:38:52 INFO - wsgiref == 0.1.2 06:38:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:38: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')]} 06:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38: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')]} 06:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:52 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 06:38:52 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 06:38:52 INFO - Using env: {'DISPLAY': ':0', 06:38:52 INFO - 'HOME': '/home/cltbld', 06:38:52 INFO - 'LANG': 'en_US.UTF-8', 06:38:52 INFO - 'LANGUAGE': 'en_US:en', 06:38:52 INFO - 'LOGNAME': 'cltbld', 06:38:52 INFO - 'MAIL': '/var/mail/cltbld', 06:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:52 INFO - 'MOZ_NO_REMOTE': '1', 06:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:52 INFO - 'NO_EM_RESTART': '1', 06:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:52 INFO - 'SHELL': '/bin/bash', 06:38:52 INFO - 'SHLVL': '1', 06:38:52 INFO - 'TERM': 'linux', 06:38:52 INFO - 'TMOUT': '86400', 06:38:52 INFO - 'USER': 'cltbld', 06:38:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:52 INFO - '_': '/tools/buildbot/bin/python'} 06:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 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)) 06:38:53 INFO - Cleaning up... 06:38:53 INFO - Return code: 0 06:38:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:38:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:38:53 INFO - Using env: {'DISPLAY': ':0', 06:38:53 INFO - 'HOME': '/home/cltbld', 06:38:53 INFO - 'LANG': 'en_US.UTF-8', 06:38:53 INFO - 'LANGUAGE': 'en_US:en', 06:38:53 INFO - 'LOGNAME': 'cltbld', 06:38:53 INFO - 'MAIL': '/var/mail/cltbld', 06:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:53 INFO - 'MOZ_NO_REMOTE': '1', 06:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:53 INFO - 'NO_EM_RESTART': '1', 06:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:53 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:53 INFO - 'SHELL': '/bin/bash', 06:38:53 INFO - 'SHLVL': '1', 06:38:53 INFO - 'TERM': 'linux', 06:38:53 INFO - 'TMOUT': '86400', 06:38:53 INFO - 'USER': 'cltbld', 06:38:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:53 INFO - '_': '/tools/buildbot/bin/python'} 06:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:53 INFO - Downloading/unpacking jsonschema 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:55 INFO - Downloading/unpacking functools32 (from jsonschema) 06:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:55 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:55 INFO - warning: no files found matching '*.txt' 06:38:55 INFO - no previously-included directories found matching 'build' 06:38:55 INFO - no previously-included directories found matching 'dist' 06:38:55 INFO - no previously-included directories found matching '.git*' 06:38:55 INFO - Installing collected packages: jsonschema, functools32 06:38:55 INFO - Running setup.py install for functools32 06:38:55 INFO - warning: no files found matching '*.txt' 06:38:55 INFO - no previously-included directories found matching 'build' 06:38:55 INFO - no previously-included directories found matching 'dist' 06:38:55 INFO - no previously-included directories found matching '.git*' 06:38:55 INFO - Successfully installed jsonschema functools32 06:38:55 INFO - Cleaning up... 06:38:55 INFO - Return code: 0 06:38:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:55 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 0x7ff692284f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2898360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, '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-1454847372.61331-627555222', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:38:55 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 06:38:55 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 06:38:55 INFO - Using env: {'DISPLAY': ':0', 06:38:55 INFO - 'HOME': '/home/cltbld', 06:38:55 INFO - 'LANG': 'en_US.UTF-8', 06:38:55 INFO - 'LANGUAGE': 'en_US:en', 06:38:55 INFO - 'LOGNAME': 'cltbld', 06:38:55 INFO - 'MAIL': '/var/mail/cltbld', 06:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:55 INFO - 'MOZ_NO_REMOTE': '1', 06:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:38:55 INFO - 'NO_EM_RESTART': '1', 06:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:38:55 INFO - 'PWD': '/builds/slave/test-pgo', 06:38:55 INFO - 'SHELL': '/bin/bash', 06:38:55 INFO - 'SHLVL': '1', 06:38:55 INFO - 'TERM': 'linux', 06:38:55 INFO - 'TMOUT': '86400', 06:38:55 INFO - 'USER': 'cltbld', 06:38:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:55 INFO - '_': '/tools/buildbot/bin/python'} 06:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:55 INFO - Downloading/unpacking flake8 06:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:38:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:38:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:58 INFO - no previously-included directories found matching 'docs/_build' 06:38:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:38:58 INFO - Running setup.py install for pep8 06:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:38:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:38:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:38:58 INFO - no previously-included directories found matching 'docs/_build' 06:38:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:38:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:38:58 INFO - Cleaning up... 06:38:58 INFO - Return code: 0 06:38:58 INFO - Running post-action listener: _resource_record_post_action 06:38:58 INFO - Running post-action listener: _start_resource_monitoring 06:38:58 INFO - Starting resource monitoring. 06:38:58 INFO - ##### 06:38:58 INFO - ##### Running install step. 06:38:58 INFO - ##### 06:38:58 INFO - Running pre-action listener: _resource_record_pre_action 06:38:58 INFO - Running main action method: install 06:38:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:38:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:38:58 INFO - Reading from file tmpfile_stdout 06:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:38:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:38:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:38:58 INFO - Reading from file tmpfile_stdout 06:38:58 INFO - Output received: 06:38:58 INFO - Usage: mozinstall [options] installer 06:38:58 INFO - Options: 06:38:58 INFO - -h, --help show this help message and exit 06:38:58 INFO - -d DEST, --destination=DEST 06:38:58 INFO - Directory to install application into. [default: 06:38:58 INFO - "/builds/slave/test-pgo"] 06:38:58 INFO - --app=APP Application being installed. [default: firefox] 06:38:58 INFO - mkdir: /builds/slave/test-pgo/build/application 06:38:58 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'] 06:38:58 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 06:39:16 INFO - Reading from file tmpfile_stdout 06:39:16 INFO - Output received: 06:39:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:39:16 INFO - Running post-action listener: _resource_record_post_action 06:39:16 INFO - ##### 06:39:16 INFO - ##### Running run-tests step. 06:39:16 INFO - ##### 06:39:16 INFO - Running pre-action listener: _resource_record_pre_action 06:39:16 INFO - Running main action method: run_tests 06:39:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:39:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:39:16 INFO - Python 2.7.3 06:39:16 INFO - Return code: 0 06:39:16 INFO - grabbing minidump binary from tooltool 06:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:39:16 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 0x2927540>, '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 0x2928440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29288f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:39:16 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 06:39:16 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 06:39:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:16 INFO - Return code: 0 06:39:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:39:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:39:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:39:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:39:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:39:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:39:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:39:17 INFO - Return code: 0 06:39:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/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 06:39:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/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 06:39:17 INFO - Using env: {'DISPLAY': ':0', 06:39:17 INFO - 'HOME': '/home/cltbld', 06:39:17 INFO - 'LANG': 'en_US.UTF-8', 06:39:17 INFO - 'LANGUAGE': 'en_US:en', 06:39:17 INFO - 'LOGNAME': 'cltbld', 06:39:17 INFO - 'MAIL': '/var/mail/cltbld', 06:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:17 INFO - 'MOZ_NO_REMOTE': '1', 06:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:17 INFO - 'NO_EM_RESTART': '1', 06:39:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:39:17 INFO - 'PWD': '/builds/slave/test-pgo', 06:39:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:39:17 INFO - 'SHELL': '/bin/bash', 06:39:17 INFO - 'SHLVL': '1', 06:39:17 INFO - 'TERM': 'linux', 06:39:17 INFO - 'TMOUT': '86400', 06:39:17 INFO - 'USER': 'cltbld', 06:39:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1454847372.61331-627555222', 06:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:17 INFO - '_': '/tools/buildbot/bin/python'} 06:39:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/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 06:39:18 INFO - mozversion application_buildid: 20160207030402 06:39:18 INFO - mozversion application_changeset: 76733110704b975154ac0fa779445e6eae5da559 06:39:18 INFO - mozversion application_display_name: Nightly 06:39:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:18 INFO - mozversion application_name: Firefox 06:39:18 INFO - mozversion application_remotingname: firefox 06:39:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:39:18 INFO - mozversion application_vendor: Mozilla 06:39:18 INFO - mozversion application_version: 47.0a1 06:39:18 INFO - mozversion platform_buildid: 20160207030402 06:39:18 INFO - mozversion platform_changeset: 76733110704b975154ac0fa779445e6eae5da559 06:39:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:39:18 INFO - mozversion platform_version: 47.0a1 06:39:18 INFO - using testdate: 1454855958 06:39:18 INFO - actual date: 1454855958 06:39:18 INFO - starting webserver on 'localhost:33940' 06:39:18 INFO - SUITE-START | Running 2 tests 06:39:18 INFO - TEST-START | dromaeo_css 06:39:18 INFO - operating with platform_type : linux_ 06:39:18 INFO - Initialising browser for dromaeo_css test... 06:39:18 INFO - TEST-INFO | started process 9224 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgwIwyH/profile http://localhost:33940/getInfo.html) 06:39:23 INFO - PROCESS | 9224 | __metrics Screen width/height:1600/1200 06:39:23 INFO - PROCESS | 9224 | colorDepth:24 06:39:23 INFO - PROCESS | 9224 | Browser inner width/height: 1024/697 06:39:23 INFO - PROCESS | 9224 | __metrics 06:39:23 INFO - PROCESS | 9224 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:24 INFO - TEST-INFO | 9224: exit 0 06:39:24 INFO - Browser initialized. 06:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:24 INFO - TEST-INFO | started process 9319 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgwIwyH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:36 INFO - PROCESS | 9319 | RSS: Main: 151646208 06:39:36 INFO - PROCESS | 9319 | 06:40:28 INFO - PROCESS | 9319 | 1454856028219 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] 06:42:36 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33940/tests/dromaeo/cssquery-ext.html) 06:42:38 INFO - PROCESS | 9319 | RSS: Main: 262664192 06:42:38 INFO - PROCESS | 9319 | 06:45:40 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-ext.html (next: http://localhost:33940/tests/dromaeo/cssquery-jquery.html) 06:45:41 INFO - PROCESS | 9319 | RSS: Main: 236638208 06:45:41 INFO - PROCESS | 9319 | 06:48:43 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33940/tests/dromaeo/cssquery-mootools.html) 06:48:43 INFO - PROCESS | 9319 | RSS: Main: 233320448 06:48:43 INFO - PROCESS | 9319 | 06:51:45 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33940/tests/dromaeo/cssquery-prototype.html) 06:51:46 INFO - PROCESS | 9319 | RSS: Main: 215445504 06:51:46 INFO - PROCESS | 9319 | 06:54:48 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33940/tests/dromaeo/cssquery-yui.html) 06:54:49 INFO - PROCESS | 9319 | RSS: Main: 217837568 06:54:49 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | Cycle 1(1): loaded http://localhost:33940/tests/dromaeo/cssquery-yui.html (next: http://localhost:33940/tests/dromaeo/cssquery-dojo.html) 06:57:52 INFO - PROCESS | 9319 | RSS: Main: 305233920 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | __start_tp_report 06:57:52 INFO - PROCESS | 9319 | _x_x_mozilla_page_load 06:57:52 INFO - PROCESS | 9319 | _x_x_mozilla_page_load_details 06:57:52 INFO - PROCESS | 9319 | |i|pagename|runs| 06:57:52 INFO - PROCESS | 9319 | |0;dojo.html;3159.8736050557973;3176.428242916274;3210.3418799146193;3214.871405143794;3243.6107667079955;5053.115704751672;5137.434882162968;5192.688438693681;5203.271541984125;5245.055889939814;5137.101007323713;5162.6128040397025;5165.664231824929;5197;5250.737463126848;4643.907121857561;4769.594584460317;4804.231322988323;4817.735024573647;4834.395700537433;4660.953390466103;4761.976190119062;4767.713937163781;4774.28385742138;4879.512048795127;4770.356001939728;4829.058333624945;4829.782659780319;4835.661503694708;4849.175640141167;4816.903661926742;4818.542238487373;4827.565519103297;4848.22428411456;4854.732989685566;4543.204939135638;4735.621150307967;4787.425508938914;4823.421189457253;4844.37023186987;5034.295198672189;5040.924386134211;5056.241563765428;5073.239014147871;5102.6428150029515;5549.556035517149;5556.388797232301;5559.972200138974;5561.749721262553;5606;5489.149181876815;5530.336359636869;5585.636933599344;5586.190002449663;5589.832305030855;5212.322398088262;5247.47525247476;5249.4488078751565;5253.894922101575;5276.208568714724;5590.993621148233;5730.36965933747;5736.741846616912;5739.598228124075;5754.0505816540635;5409.377921538995;5450.8909821803345;5475.917861232085;5483.396826349099;5509.035918714209;5547.195656629766;5547.5007249347755;5547.833564993057;5549.861253468695;5550.361708403505;5367.731613419313;5437;5536.944630553643;5541.030319694038;5582.413846546055;5559.63862348946;5590.944090559124;5593.105103183471;5598.356189038313;5639.943600564024;4313.892152696208;4345.956540434619;4351.19502891966;4355.912881742347;4391.5827996340295;3848.8845334640005;3867.8259478323544;3900.278448487039;3907.9218415631526;3939.625735555118;5157.406898206679;5178.119719647669;5179.61152913533;5180.766865491062;5194.792208311701;5584.301962254718;5604.915926261109;5609.887802244014;5611.523020543218;5659.547236221092;5074.2895994560795;5142.537171654569;5159.716215608102;5170.1727723564045;5253.868653283622;4686.742229177428;4697.976510117427;4707.7881495332795;4711.8350857719815;4750.026244619845;5679.119736440858;5684.118961560965;5688.601797874192;5692.857678557986;5697.857553561194;5409.594280429063;5514.5864060196445;5606.775728970795;5617.691026993554;5694.373618902;5707.971460142673;5715.085586306171;5715.913976344481;5717.371089180104;5725.742341594555;5382.219578161223;5410.48600382963;5435;5470.72646367688;5471.753771080232;5495.368032676293;5551.500364967173;5578.163275508544;5588.38527761954;5623.718814059363;5378.515933565998;5378.892422151457;5405.297311349656;5425.891482170414;5435.592330575144;5380.192971054373;5409.1345384739825;5435.130379139477;5479.643823151482;5501.889962200654;5328.8401347959625;5332.706701131475;5367.865803354791;5378.112611419228;5415.350157981067;5453.863653408696;5480.095784195563;5508.586855985897;5510.8071217507195;5516.310461192351;5244.265802787689;5330.920036199383;5342;5373.247745315737;5387.111126664213 06:57:52 INFO - PROCESS | 9319 | |1;ext.html;542.4927692607409;557.66818742848;568.0059895183429;587.7619564076549;588.6085752974269;27538.724612753867;35898;36228.637713622855;36239.2752144957;36299.274014519695;38988.80505597475;39168.60831391692;39238.21523569527;39243.80378098113;39432.80283598585;8324.33405327574;8580.957095214546;8585.141485851427;8596.656133754643;8602.48385096893;8434.662613495453;8547.145285471433;8571.699990500334;8577.356698247626;8733;8718.258947989429;8808.075152109033;8821.823563528758;8826.426282291663;8834.293256539493;8700.30397568193;8776.517291548962;8783.165599268059;8785.6046477908;8788.824223515527;8622.094680058566;8734.86897696535;8749.47503149813;8751.299896008304;8760.167784060504;37420.25159496795;37651.24697506062;37755;37818.621813781785;38066;3258.885938992124;3382.8477718502727;3490.738194635387;3497.3529896969144;3615.5842078161086;29190.41619167626;29610.70389296101;29684.257893552618;30105.397892042256;30491.847540762377;3833.923321533554;3987.1029018470904;4012.3981402789523;4041.97979010106;4148.792560372;253591;254359;254481;254719.72640136865;255055;50175.74912125416;50883.745581271854;56523;57447.42552574504;57541;50647.49352506428;50787.492125079014;50832.49167508352;50900.745496272284;50922.49077509178;13881.722365552632;14526.128432294096;14662.266886655625;14711.632209194855;14816;10910.672679819618;10916.34501929871;10967.232293739362;10969.780604388026;10975.780484390427;17780.822191778174;17900.373486927896;17902.641947160984;18226.179821908045;18620.906895465436;7325.6337183141695;7535.246475352421;7570.848583028309;7669.194734552903;7741.419393545507;985.6156099121205;1040.0483557544912;1121.2935850414349;1127.5997021057572;1132.105636547135;29166.562501562494;29717.257068573457;29752.2561935949;30094.09717708472;30327.241818954702;1092.2845536173818;1108.2408550143177;1109.4341885638382;1248.3259040118417;1260.7478504299177;15471.845281547041;15556.922215388851;15646.921765391327;15676.843231567538;15907.443239486794;304960;308920;309389;309471;310325;43486;47311;49287.50712492901;51709.7414512925;52167.73916130395;1318.2420108437686;1318.6176008957486;1332.8333958255218;1335.0587835576089;1338.8661133886533;26268.21195364142;26927.730722693304;28983.7101628981;29537;30385.69614303917;41683.37474937939;46984;48214.27678584754;48452.5154748448;48644.27033594428;191906;192251.07748922892;192963;193056.0347198255;193658;30087.097387078422;30326.696733032386;30371.69628303777;30405;30422.847885760428;42492.362614561425;43101;43230.783846080565;44236.336454953846;44314.77842610766;35967.82016089903;36322.455163172046;36609.816950915076;37388.439173411876;37627.81186094052;35587.418138519955;36776.63223367732;36901.8799127294;37367.43948840715;37468;35913;36919.26161476702;37786.24427511379;38056.242969628795;38077.238455231294;28660;31285.530717038808;31679.84160079185;31827.36345273128;31848.36303273968;24072.518549629258;24129;24346.02615895415;24447.38881527976;24962.875185623954 06:57:52 INFO - PROCESS | 9319 | |2;jquery.html;344.4677972532437;354.78358201497065;355.4082452716228;364.14426098668133;370.8831718008827;13505.527306544273;13788.655283617914;16187.919060404696;17249.13754312284;18209.362672306455;15027.924860375682;15722;15871.682566348665;15897.52307430779;16772.41296554621;5426.864328391792;5596.300462442195;5597.63615365;5597.916031259534;5600.439956004388;4096.5903409659095;5483.8080667176655;5531.917021244684;5870.11948207768;6136.447719705226;5982.6410415375;6040.667763273018;6087.2086628738425;6091.543134264925;6091.908621370683;5978.521718262528;6067.9696601516935;6108.633481991051;6110.480609148228;6134.631922084667;5266.131088370415;5353.759080841332;5369.5972802040005;5381.408045115034;5389.029974604569;19967.50081247966;19997.50006249841;20203.39389818293;20276.188952442033;20333.779973201654;1994.700794880765;2080.2719048333115;2096.979030209709;2401.0515846240637;2483.466054798227;9175.44947303164;9268.814623707556;9336.3464557481;9706.320557560974;12445.25328480294;1887.1885089411549;1893.1575448925234;1894.8484121270264;1896.1277812206401;1975.812297831718;51074.74462627663;57244.42755572432;58916.41083589195;59967;60859;9754.512274386252;10075.697729068139;10180.185585153169;10185;10249.74375640615;13185.14296570739;13192;13211.40548675312;13213.339333033502;13218.140820846615;7185.3533182012825;7349;7359.8160045999275;7383.335499805044;7518.173000969889;7085.964570177116;7106.040684507629;7123.572585644878;7166.175889772743;7166.78499645001;4147.751134931914;4385.649148068147;4404.537523560044;4441.133978874089;4466.57567531084;1771.8936863788215;1772.8758986871053;1787.25828781057;1789.454216463965;1816.7456556082159;445.14309953339693;454.42742144897005;899.2760827533898;955.9330846840794;1029.145808978546;10557.894421055844;10650.201234907257;10733.248672592843;10743.14054875608;11219.214654974074;473.54303097510376;476.07403599997673;483.6880212263141;928.2342067794096;1070.7804899995638;8788.95605521981;9279.443233406017;9285.442873427615;9377.827771528559;9477.28920330978;493860;498360;512009;513180;516371;45840;56594.15108773372;63860;63903.680481597294;70873;1128.3568366031448;1135.812590922505;1179.2688533109526;1186.661801386618;1189.7323102301914;14379.352929118424;14487;14744;15146.848531514544;15577.844221558093;30375;30497.54253686152;30640.693593064676;31163;31397.8430107848;41613;42524;43207.567924321615;43385.44452832407;43522.56477435185;7430.628468576658;7650.31147196755;7676.232376762279;7707.845843083219;7720;8000;9327.414339562156;10479.895201047892;11503.712407189887;11567.421628918351;7377.446691498052;7560.395168386626;8987.595558199766;9684.273679474209;10185.287029908131;9588.256676077759;9655.951720241354;9751.317407781387;9904.405735655884;10028.147607453157;9331.813363732823;10141.645042423479;10181.389116652728;10307.226957978331;11037.172212083966;7590.848183036419;7654.617269136632;7734.6132693366235;7773.650185741542;7870.212978702084;9331.580078896603;9795.804083918425;10136.695899123039;10318.331503841871;10790.946045269724 06:57:52 INFO - PROCESS | 9319 | |3;mootools.html;1343.8253027106487;1470.8014418053563;1470.8529147085292;1611.8468745469183;1763.8765286429955;7010.754623588169;7627;7789.493682910607;7798.5320880747195;7803.492772969753;7628.626847167508;7775.727849525254;7827.804304892381;7829.647665855036;7842.451028427998;2049.5183631846503;2261.231181398324;2325.43026958395;2333.614953532665;2350.471143992605;2322.280093171122;2326.26722582386;2327.860328380294;2328.382978510696;2330.0796185506715;2286.5084006938505;2359.044586942291;2359.4337359033793;2361.9645705314433;2362.5038741864228;2290.0839664134396;2315.6873822033976;2342.7891489765916;2343.425860664131;2345.8592484450987;2292.3810571145696;2299.9655005174936;2314.849534780234;2321.1991862807304;2324.732655744594;7931.206879312081;7935.08746494149;7979.760607181794;7990.920090799075;8010.399220058519;4806.375171227718;4928;4930.408350997904;4933.679310844784;4938.9753051234875;3096.6748491408302;3109;3151.038933125396;3268.9182770430693;3279.6884295991845;1055.4352922398568;1071.6999240212754;1077.2136340471422;1091.6791775619156;1099.3019432660237;10162.085412312854;10386.169106471463;10406.999999999924;10430;10432.791344173074;4260.147970405931;4283.935740963888;4354.150940566559;4362.1493808707;4367.235733746582;8082.959585202154;8113;8114.269715725613;8127.146649601825;8127.674893004214;4679.415073115861;4691.108689349013;4703.106409782131;4712.552307530779;4744.3595114659765;4426.22541055314;4429.335599660012;4442.977785111054;4446.73319600825;4451.154280686724;3213.1645772099423;3260.054584170611;3436.1924947637285;3480.7563470557325;3503.649635036476;1009.6466236817055;1015.223354134088;1015.8882522922472;1018.1549314069305;1036.486938965202;1316.7432350691715;1325.9933700331437;1328.448693792085;1347.3936728472227;1380.2270728392132;7340.44946629005;7533.322001019935;7742.070951485858;7742.341900938371;7767.106782719947;1127.2053202492223;1137.9601713939971;1140.994295028536;1142.360278244186;1169.1997665590861;5480.232767412565;5521.3926468088475;5526.226328314039;5527.944720552823;5535.750891209906;9145.405548639317;9162.267018638493;9420.481873497023;9532.571034303335;9554.90445095554;9556.617735290649;9688.564014619358;9697.709068727949;9701.417914924987;9711.417314961125;7491.6254187290415;7522.134954480195;7686.269804368688;7701.4608977371045;7705.730299439605;7315.743948961761;7324.63376831167;7353.632318383952;7364.189939106587;7370.742024029133;8071.031476222891;8115.594220288844;8331.16688331162;8497.235248827636;8511.91488085136;8398.370122240734;8404.53775042354;8411.411201215857;8570.74287771368;8574.442661227;6345.302016778243;6815.591064536144;6952.617606031717;6954.443644508326;6954.443644508528;6833.111695479556;7331.816704582215;7484.663190156347;7504.774856754306;7506.361959233308;6899;7067.787966361017;7074;7151.177614574391;7187.712491500281;6896.448284137357;6899;6968.477364197807;7014.368706816411;7138.571685698875;7030.121234845645;7043.401310888426;7076.964615176891;7092.468064895257;7253.673584688807;6678.966605166943;6729.932700672931;6731.158605174353;6739.460843132636;6746.730130794714;6635.834104147242;6685.364890335605;6731.057651928832;6737.191537015589;6742.089817874524 06:57:52 INFO - PROCESS | 9319 | |4;prototype.html;336.98315084245786;343.1524135385598;346.70876463770435;347.48398628037376;352.3393636930755;5707.6290041147295;5846.918320110783;5878.676672782995;5914.083317085848;5931.673757943317;5724.055530837417;5800.390958949313;5850.5612079094135;5870.530357571395;5881.735321910513;4576.222042252808;4586.724796512203;4595.678302518825;4603.355530225755;4604.930926036112;4357.520672725997;4451.443569553806;4499.932501012488;4579.473360563527;4588.678792484528;4530.093981203756;4543.636509079266;4548.295014272793;4549.61328287096;4569.840055598055;4546.477155127153;4557.248054071091;4562.498125206224;4569.177548041352;4572.885677858047;4010.7393019453643;4013.337799263147;4023.3160362738404;4033.3949907514107;4039.0508230565792;5400.189971504266;5548.140038294071;5572.60991730579;5596.2165296858475;5612.35457922336;5173.249878767595;5184.611154163453;5190.299309593194;5205.869853253699;5213;5922.58541902067;6230.7819226326865;6232.532560057968;6240.188775459162;6250.312465628777;4218.810153543067;4346.413234213404;4352.064306174156;4354.673399495019;4388.034632380871;6417.711202995876;6515.7067931943175;6524.93475065248;6532.248791388956;6538.967305163491;4376.343548467756;4386.824527018884;4390.100029493946;4391.012022294958;4395.428594282723;4363.2364336241035;4415.381846541487;4440.222960981815;4452.0873220989615;4454.510003899569;5163.845084647466;5168.9741551292755;5178.171492561248;5179.19722443022;5192.506711862367;6299.590526615755;6310.7791227306825;6314.242290925118;6320.304766475684;6340.144080549159;1555.4478160252947;1578.8105427348562;1581.0671703694645;1584.3187429405466;1585.2866210205455;1052.6263176572359;1059.502034043998;1061.851340812287;1079.1312993040679;1086.6359769477315;5906.350301466835;5914.201582786355;5915.881682366328;5917.644941303535;5918.053111502139;6465;6465.321141280192;6467.062275970052;6471.5146364022885;6473.06140609609;5906.7637294508595;5908.05471124618;5910.970445147746;5913.083472061838;5917.349091599921;3401.4557670772556;3507.2985402919517;3508.210652603195;3510.4558793387064;3510.684038436553;6755.763548275885;6758.05387245786;6761.797146085625;6766.18805743314;6775.220849602359;6652.966735166293;6657.1345725055435;6664.8000559983275;6666.100076489612;6667.6666166691475;6551.475881929434;6781.796546103625;6827.726890924308;6828.248892621708;6831.555948863308;6222.191115155001;6370.235571731422;6531;6533.346665333429;6546.934530654633;6264.906026409516;6317.273513545817;6370.968145159244;6392.616443013434;6398.968005159944;6707.765228217184;6732.394084532416;6742.393184613408;6744.898826517704;6749.156355455568;4341;4413.7351758894565;4465.5087940327185;4468.195724769573;4475.731456112644;6493.805185844432;6493.902591461037;6496.350364963466;6497.967510162419;6507;6274.403931626488;6284.366064823087;6309.305976342507;6310.4320611143385;6311.116443697978;6194.225721784777;6281.497480201481;6294.685265736786;6308.905366419415;6316.431521162934;6193.194884664965;6195.349488303663;6196.969015155076;6197.318294987638;6202;6320.5575609706875;6322.272938612118;6337.968310158604;6338.207724034496;6344.143540622142;6065.6663883486835;6174.660393678211;6180.783672571439;6189.84525386869;6195.597286176384 06:57:52 INFO - PROCESS | 9319 | |5;yui.html;725.6335550546974;732.0812380462519;770.6647608290394;791.5053091817614;792.659156562678;13575.52485663002;13838.169709817417;13896.096753711014;13919.860801391984;13952.441902323908;11940.402979851016;12988.350582470863;13016;13033.869661303384;13047.21716696999;683.4532374100725;687.8417963868313;819.5041999590252;832.0057531250159;832.3632421197789;813.7599408174602;829.5437509369852;835.6114406800837;837.3636036612188;837.5728378526965;878.6046279174365;887.3034667785789;887.414306557672;888.0409158109227;888.1074520107284;706.6537396675618;712.2165617820382;826.7478419082178;880.2605811118627;880.3793325705362;643.9001954697029;644.1947565543071;644.9290578036412;645.6771614192903;645.8675971425846;13423.932880335537;13457.86542134576;13494.392752326168;13500.392482338319;13531.255780932044;12651.785937461;12978.675533111653;13111.344432778324;13241.602751917362;13245.271510066943;10363.170946324275;10364.844527332096;10454.477276136238;10599.947000265027;10695.679129626124;3544.432890737495;3612.8193590320643;3652.3243200008083;3658.2683463307444;3689.4281386384887;47403.525964740256;47718.52281477176;47739;49232.753836231306;49440;9794.118529332252;9832.508374581243;10450.268481206243;10459.84310235347;10740.248182627141;17719.911400442914;17756.644867102586;17855.28578856857;17860.9106954467;17899.821001789816;7591.696332146763;7781.221877812287;7954.840903181904;8045.436819422701;8059.879101813477;4450.287953927356;4451.11974258103;4518.796654150571;4534.161180181677;4543;3195.7123858852815;3232.4181647303712;3236.417444859948;3240.4329242382487;3248.59392575928;588.114887094928;590.1678633127356;601.1133577972543;603.3333166850655;607.875385545962;597.2802772658936;601.2454369765916;615.4829942848029;643.0900276109346;659.2451642868888;9043.32175086871;9172.54137293146;9432.575534100983;9534.189593884597;9585.520723963775;563.8364874186522;566.7053132371144;580.4340767751493;636.1507387637463;698.8916717908733;3763.322601931624;3932.292187406237;4089.6221468768476;4113.547509773923;4196.391523229115;56481.15278270829;58473.70763146242;59366.10950835741;59702.40297597055;59771.70114149401;48979;49005.26492102621;49569;49579.25631115536;50454.49545504571;44772.32841507315;44957.55042449599;45248.773756131006;46140.53859461429;46415.535844641796;8638.78403039929;8801.427907186013;8806.383553151218;8868.201861832466;8869.911300886908;33234.16914577155;34242.48636270508;34615;35212.647873521964;35468.645313546534;39223.62717304995;39276.41085383664;40774;42926.14147717091;43132.56867431411;10607.257491975797;11084.390358530036;11100.000999910048;11134.3876086816;11389.829152562885;12273.631791046282;12392;12403.75192496127;12604.936975315064;12788.232706037668;10886.782264354826;11013.724656883642;11021.338719676525;11198.160137989846;11298.322100673986;11040.116790656888;11041.227114101936;11146.996770290389;11359.261647992855;11646.24299420535;11317.151213658844;11725.34966596867;11797.056235500968;11846.585369512026;11893.76212475763;9090.772910435453;9233.492157931378;9249.953750231205;9251.583678734338;9769.413835169913;9118.680846170351;9295.581698823704;9745.707628771148;10097.848532272168;10238.12975897057 06:57:52 INFO - PROCESS | 9319 | __end_tp_report 06:57:52 INFO - PROCESS | 9319 | __start_cc_report 06:57:52 INFO - PROCESS | 9319 | _x_x_mozilla_cycle_collect,802 06:57:52 INFO - PROCESS | 9319 | __end_cc_report 06:57:52 INFO - PROCESS | 9319 | __startTimestamp1454857072499__endTimestamp 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | ------- Summary: start ------- 06:57:52 INFO - PROCESS | 9319 | Number of tests: 6 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#0] dojo.html Cycles:165 Average:5171.66 Median:5373.25 stddev:545.82 (10.2%) stddev-sans-first:524.18 06:57:52 INFO - PROCESS | 9319 | Values: 3159.9 3176.4 3210.3 3214.9 3243.6 5053.1 5137.4 5192.7 5203.3 5245.1 5137.1 5162.6 5165.7 5197.0 5250.7 4643.9 4769.6 4804.2 4817.7 4834.4 4661.0 4762.0 4767.7 4774.3 4879.5 4770.4 4829.1 4829.8 4835.7 4849.2 4816.9 4818.5 4827.6 4848.2 4854.7 4543.2 4735.6 4787.4 4823.4 4844.4 5034.3 5040.9 5056.2 5073.2 5102.6 5549.6 5556.4 5560.0 5561.7 5606.0 5489.1 5530.3 5585.6 5586.2 5589.8 5212.3 5247.5 5249.4 5253.9 5276.2 5591.0 5730.4 5736.7 5739.6 5754.1 5409.4 5450.9 5475.9 5483.4 5509.0 5547.2 5547.5 5547.8 5549.9 5550.4 5367.7 5437.0 5536.9 5541.0 5582.4 5559.6 5590.9 5593.1 5598.4 5639.9 4313.9 4346.0 4351.2 4355.9 4391.6 3848.9 3867.8 3900.3 3907.9 3939.6 5157.4 5178.1 5179.6 5180.8 5194.8 5584.3 5604.9 5609.9 5611.5 5659.5 5074.3 5142.5 5159.7 5170.2 5253.9 4686.7 4698.0 4707.8 4711.8 4750.0 5679.1 5684.1 5688.6 5692.9 5697.9 5409.6 5514.6 5606.8 5617.7 5694.4 5708.0 5715.1 5715.9 5717.4 5725.7 5382.2 5410.5 5435.0 5470.7 5471.8 5495.4 5551.5 5578.2 5588.4 5623.7 5378.5 5378.9 5405.3 5425.9 5435.6 5380.2 5409.1 5435.1 5479.6 5501.9 5328.8 5332.7 5367.9 5378.1 5415.4 5453.9 5480.1 5508.6 5510.8 5516.3 5244.3 5330.9 5342.0 5373.2 5387.1 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#1] ext.html Cycles:180 Average:42171.24 Median:36269.27 stddev:66825.51 (184.2%) stddev-sans-first:66939.88 06:57:52 INFO - PROCESS | 9319 | Values: 542.5 557.7 568.0 587.8 588.6 27538.7 35898.0 36228.6 36239.3 36299.3 38988.8 39168.6 39238.2 39243.8 39432.8 8324.3 8581.0 8585.1 8596.7 8602.5 8434.7 8547.1 8571.7 8577.4 8733.0 8718.3 8808.1 8821.8 8826.4 8834.3 8700.3 8776.5 8783.2 8785.6 8788.8 8622.1 8734.9 8749.5 8751.3 8760.2 37420.3 37651.2 37755.0 37818.6 38066.0 3258.9 3382.8 3490.7 3497.4 3615.6 29190.4 29610.7 29684.3 30105.4 30491.8 3833.9 3987.1 4012.4 4042.0 4148.8 253591.0 254359.0 254481.0 254719.7 255055.0 50175.7 50883.7 56523.0 57447.4 57541.0 50647.5 50787.5 50832.5 50900.7 50922.5 13881.7 14526.1 14662.3 14711.6 14816.0 10910.7 10916.3 10967.2 10969.8 10975.8 17780.8 17900.4 17902.6 18226.2 18620.9 7325.6 7535.2 7570.8 7669.2 7741.4 985.6 1040.0 1121.3 1127.6 1132.1 29166.6 29717.3 29752.3 30094.1 30327.2 1092.3 1108.2 1109.4 1248.3 1260.7 15471.8 15556.9 15646.9 15676.8 15907.4 304960.0 308920.0 309389.0 309471.0 310325.0 43486.0 47311.0 49287.5 51709.7 52167.7 1318.2 1318.6 1332.8 1335.1 1338.9 26268.2 26927.7 28983.7 29537.0 30385.7 41683.4 46984.0 48214.3 48452.5 48644.3 191906.0 192251.1 192963.0 193056.0 193658.0 30087.1 30326.7 30371.7 30405.0 30422.8 42492.4 43101.0 43230.8 44236.3 44314.8 35967.8 36322.5 36609.8 37388.4 37627.8 35587.4 36776.6 36901.9 37367.4 37468.0 35913.0 36919.3 37786.2 38056.2 38077.2 28660.0 31285.5 31679.8 31827.4 31848.4 24072.5 24129.0 24346.0 24447.4 24962.9 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#2] jquery.html Cycles:180 Average:26077.37 Median:2460.50 stddev:82697.52 (3361.0%) stddev-sans-first:82906.93 06:57:52 INFO - PROCESS | 9319 | Values: 344.5 354.8 355.4 364.1 370.9 13505.5 13788.7 16187.9 17249.1 18209.4 15027.9 15722.0 15871.7 15897.5 16772.4 5426.9 5596.3 5597.6 5597.9 5600.4 4096.6 5483.8 5531.9 5870.1 6136.4 5982.6 6040.7 6087.2 6091.5 6091.9 5978.5 6068.0 6108.6 6110.5 6134.6 5266.1 5353.8 5369.6 5381.4 5389.0 19967.5 19997.5 20203.4 20276.2 20333.8 1994.7 2080.3 2097.0 2401.1 2483.5 9175.4 9268.8 9336.3 9706.3 12445.3 1887.2 1893.2 1894.8 1896.1 1975.8 51074.7 57244.4 58916.4 59967.0 60859.0 9754.5 10075.7 10180.2 10185.0 10249.7 13185.1 13192.0 13211.4 13213.3 13218.1 7185.4 7349.0 7359.8 7383.3 7518.2 7086.0 7106.0 7123.6 7166.2 7166.8 4147.8 4385.6 4404.5 4441.1 4466.6 1771.9 1772.9 1787.3 1789.5 1816.7 445.1 454.4 899.3 955.9 1029.1 10557.9 10650.2 10733.2 10743.1 11219.2 473.5 476.1 483.7 928.2 1070.8 8789.0 9279.4 9285.4 9377.8 9477.3 493860.0 498360.0 512009.0 513180.0 516371.0 45840.0 56594.2 63860.0 63903.7 70873.0 1128.4 1135.8 1179.3 1186.7 1189.7 14379.4 14487.0 14744.0 15146.8 15577.8 30375.0 30497.5 30640.7 31163.0 31397.8 41613.0 42524.0 43207.6 43385.4 43522.6 7430.6 7650.3 7676.2 7707.8 7720.0 8000.0 9327.4 10479.9 11503.7 11567.4 7377.4 7560.4 8987.6 9684.3 10185.3 9588.3 9656.0 9751.3 9904.4 10028.1 9331.8 10141.6 10181.4 10307.2 11037.2 7590.8 7654.6 7734.6 7773.7 7870.2 9331.6 9795.8 10136.7 10318.3 10790.9 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#3] mootools.html Cycles:180 Average:5475.24 Median:6490.57 stddev:2792.02 (43.0%) stddev-sans-first:2782.58 06:57:52 INFO - PROCESS | 9319 | Values: 1343.8 1470.8 1470.9 1611.8 1763.9 7010.8 7627.0 7789.5 7798.5 7803.5 7628.6 7775.7 7827.8 7829.6 7842.5 2049.5 2261.2 2325.4 2333.6 2350.5 2322.3 2326.3 2327.9 2328.4 2330.1 2286.5 2359.0 2359.4 2362.0 2362.5 2290.1 2315.7 2342.8 2343.4 2345.9 2292.4 2300.0 2314.8 2321.2 2324.7 7931.2 7935.1 7979.8 7990.9 8010.4 4806.4 4928.0 4930.4 4933.7 4939.0 3096.7 3109.0 3151.0 3268.9 3279.7 1055.4 1071.7 1077.2 1091.7 1099.3 10162.1 10386.2 10407.0 10430.0 10432.8 4260.1 4283.9 4354.2 4362.1 4367.2 8083.0 8113.0 8114.3 8127.1 8127.7 4679.4 4691.1 4703.1 4712.6 4744.4 4426.2 4429.3 4443.0 4446.7 4451.2 3213.2 3260.1 3436.2 3480.8 3503.6 1009.6 1015.2 1015.9 1018.2 1036.5 1316.7 1326.0 1328.4 1347.4 1380.2 7340.4 7533.3 7742.1 7742.3 7767.1 1127.2 1138.0 1141.0 1142.4 1169.2 5480.2 5521.4 5526.2 5527.9 5535.8 9145.4 9162.3 9420.5 9532.6 9554.9 9556.6 9688.6 9697.7 9701.4 9711.4 7491.6 7522.1 7686.3 7701.5 7705.7 7315.7 7324.6 7353.6 7364.2 7370.7 8071.0 8115.6 8331.2 8497.2 8511.9 8398.4 8404.5 8411.4 8570.7 8574.4 6345.3 6815.6 6952.6 6954.4 6954.4 6833.1 7331.8 7484.7 7504.8 7506.4 6899.0 7067.8 7074.0 7151.2 7187.7 6896.4 6899.0 6968.5 7014.4 7138.6 7030.1 7043.4 7077.0 7092.5 7253.7 6679.0 6729.9 6731.2 6739.5 6746.7 6635.8 6685.4 6731.1 6737.2 6742.1 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#4] prototype.html Cycles:180 Average:5240.22 Median:5909.51 stddev:1580.08 (26.7%) stddev-sans-first:1541.06 06:57:52 INFO - PROCESS | 9319 | Values: 337.0 343.2 346.7 347.5 352.3 5707.6 5846.9 5878.7 5914.1 5931.7 5724.1 5800.4 5850.6 5870.5 5881.7 4576.2 4586.7 4595.7 4603.4 4604.9 4357.5 4451.4 4499.9 4579.5 4588.7 4530.1 4543.6 4548.3 4549.6 4569.8 4546.5 4557.2 4562.5 4569.2 4572.9 4010.7 4013.3 4023.3 4033.4 4039.1 5400.2 5548.1 5572.6 5596.2 5612.4 5173.2 5184.6 5190.3 5205.9 5213.0 5922.6 6230.8 6232.5 6240.2 6250.3 4218.8 4346.4 4352.1 4354.7 4388.0 6417.7 6515.7 6524.9 6532.2 6539.0 4376.3 4386.8 4390.1 4391.0 4395.4 4363.2 4415.4 4440.2 4452.1 4454.5 5163.8 5169.0 5178.2 5179.2 5192.5 6299.6 6310.8 6314.2 6320.3 6340.1 1555.4 1578.8 1581.1 1584.3 1585.3 1052.6 1059.5 1061.9 1079.1 1086.6 5906.4 5914.2 5915.9 5917.6 5918.1 6465.0 6465.3 6467.1 6471.5 6473.1 5906.8 5908.1 5911.0 5913.1 5917.3 3401.5 3507.3 3508.2 3510.5 3510.7 6755.8 6758.1 6761.8 6766.2 6775.2 6653.0 6657.1 6664.8 6666.1 6667.7 6551.5 6781.8 6827.7 6828.2 6831.6 6222.2 6370.2 6531.0 6533.3 6546.9 6264.9 6317.3 6371.0 6392.6 6399.0 6707.8 6732.4 6742.4 6744.9 6749.2 4341.0 4413.7 4465.5 4468.2 4475.7 6493.8 6493.9 6496.4 6498.0 6507.0 6274.4 6284.4 6309.3 6310.4 6311.1 6194.2 6281.5 6294.7 6308.9 6316.4 6193.2 6195.3 6197.0 6197.3 6202.0 6320.6 6322.3 6338.0 6338.2 6344.1 6065.7 6174.7 6180.8 6189.8 6195.6 06:57:52 INFO - PROCESS | 9319 | 06:57:52 INFO - PROCESS | 9319 | [#5] yui.html Cycles:180 Average:13722.63 Median:24891.47 stddev:15674.65 (63.0%) stddev-sans-first:15688.24 06:57:52 INFO - PROCESS | 9319 | Values: 725.6 732.1 770.7 791.5 792.7 13575.5 13838.2 13896.1 13919.9 13952.4 11940.4 12988.4 13016.0 13033.9 13047.2 683.5 687.8 819.5 832.0 832.4 813.8 829.5 835.6 837.4 837.6 878.6 887.3 887.4 888.0 888.1 706.7 712.2 826.7 880.3 880.4 643.9 644.2 644.9 645.7 645.9 13423.9 13457.9 13494.4 13500.4 13531.3 12651.8 12978.7 13111.3 13241.6 13245.3 10363.2 10364.8 10454.5 10599.9 10695.7 3544.4 3612.8 3652.3 3658.3 3689.4 47403.5 47718.5 47739.0 49232.8 49440.0 9794.1 9832.5 10450.3 10459.8 10740.2 17719.9 17756.6 17855.3 17860.9 17899.8 7591.7 7781.2 7954.8 8045.4 8059.9 4450.3 4451.1 4518.8 4534.2 4543.0 3195.7 3232.4 3236.4 3240.4 3248.6 588.1 590.2 601.1 603.3 607.9 597.3 601.2 615.5 643.1 659.2 9043.3 9172.5 9432.6 9534.2 9585.5 563.8 566.7 580.4 636.2 698.9 3763.3 3932.3 4089.6 4113.5 4196.4 56481.2 58473.7 59366.1 59702.4 59771.7 48979.0 49005.3 49569.0 49579.3 50454.5 44772.3 44957.6 45248.8 46140.5 46415.5 8638.8 8801.4 8806.4 8868.2 8869.9 33234.2 34242.5 34615.0 35212.6 35468.6 39223.6 39276.4 40774.0 42926.1 43132.6 10607.3 11084.4 11100.0 11134.4 11389.8 12273.6 12392.0 12403.8 12604.9 12788.2 10886.8 11013.7 11021.3 11198.2 11298.3 11040.1 11041.2 11147.0 11359.3 11646.2 11317.2 11725.3 11797.1 11846.6 11893.8 9090.8 9233.5 9250.0 9251.6 9769.4 9118.7 9295.6 9745.7 10097.8 10238.1 06:57:52 INFO - PROCESS | 9319 | -------- Summary: end -------- 06:57:52 INFO - PROCESS | 9319 | 06:57:53 INFO - TEST-INFO | 9319: exit 0 06:57:53 INFO - TEST-OK | dromaeo_css | took 1115085ms 06:57:53 INFO - TEST-START | kraken 06:57:53 INFO - operating with platform_type : linux_ 06:57:53 INFO - Initialising browser for kraken test... 06:57:53 INFO - TEST-INFO | started process 9506 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaQba2Z/profile http://localhost:33940/getInfo.html) 06:57:57 INFO - PROCESS | 9506 | __metrics Screen width/height:1600/1200 06:57:57 INFO - PROCESS | 9506 | colorDepth:24 06:57:57 INFO - PROCESS | 9506 | Browser inner width/height: 1024/697 06:57:57 INFO - PROCESS | 9506 | __metrics 06:57:58 INFO - PROCESS | 9506 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:57:59 INFO - TEST-INFO | 9506: exit 0 06:57:59 INFO - Browser initialized. 06:57:59 INFO - Running cycle 1/1 for kraken test... 06:57:59 INFO - TEST-INFO | started process 9588 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaQba2Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:11 INFO - PROCESS | 9588 | RSS: Main: 151433216 06:58:11 INFO - PROCESS | 9588 | 06:58:13 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33940/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:14 INFO - PROCESS | 9588 | RSS: Main: 192200704 06:58:14 INFO - PROCESS | 9588 | 06:58:16 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33940/tests/kraken/driver.html?testName=audio-dft) 06:58:17 INFO - PROCESS | 9588 | RSS: Main: 182190080 06:58:17 INFO - PROCESS | 9588 | 06:58:20 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33940/tests/kraken/driver.html?testName=audio-fft) 06:58:20 INFO - PROCESS | 9588 | RSS: Main: 167038976 06:58:20 INFO - PROCESS | 9588 | 06:58:22 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33940/tests/kraken/driver.html?testName=audio-oscillator) 06:58:23 INFO - PROCESS | 9588 | RSS: Main: 168583168 06:58:23 INFO - PROCESS | 9588 | 06:58:25 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33940/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:26 INFO - PROCESS | 9588 | RSS: Main: 170758144 06:58:26 INFO - PROCESS | 9588 | 06:58:29 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33940/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:29 INFO - PROCESS | 9588 | RSS: Main: 171020288 06:58:29 INFO - PROCESS | 9588 | 06:58:33 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33940/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:33 INFO - PROCESS | 9588 | RSS: Main: 171151360 06:58:33 INFO - PROCESS | 9588 | 06:58:36 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33940/tests/kraken/driver.html?testName=json-parse-financial) 06:58:37 INFO - PROCESS | 9588 | RSS: Main: 170815488 06:58:37 INFO - PROCESS | 9588 | 06:58:38 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33940/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:58:39 INFO - PROCESS | 9588 | RSS: Main: 181493760 06:58:39 INFO - PROCESS | 9588 | 06:58:40 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:58:41 INFO - PROCESS | 9588 | RSS: Main: 180338688 06:58:41 INFO - PROCESS | 9588 | 06:58:43 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:58:44 INFO - PROCESS | 9588 | RSS: Main: 191340544 06:58:44 INFO - PROCESS | 9588 | 06:58:46 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:58:47 INFO - PROCESS | 9588 | RSS: Main: 198074368 06:58:47 INFO - PROCESS | 9588 | 06:58:49 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:58:50 INFO - PROCESS | 9588 | RSS: Main: 197062656 06:58:50 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | Cycle 1(1): loaded http://localhost:33940/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33940/tests/kraken/driver.html?testName=ai-astar) 06:58:52 INFO - PROCESS | 9588 | RSS: Main: 257519616 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | __start_tp_report 06:58:52 INFO - PROCESS | 9588 | _x_x_mozilla_page_load 06:58:52 INFO - PROCESS | 9588 | _x_x_mozilla_page_load_details 06:58:52 INFO - PROCESS | 9588 | |i|pagename|runs| 06:58:52 INFO - PROCESS | 9588 | |0;ai-astar;113;112;106;111;112;111;101;112;112;109 06:58:52 INFO - PROCESS | 9588 | |1;audio-beat-detection;146;122;155;162;128;144;151;131;163;124 06:58:52 INFO - PROCESS | 9588 | |2;audio-dft;160;161;161;162;162;163;161;165;162;162 06:58:52 INFO - PROCESS | 9588 | |3;audio-fft;73;73;93;98;73;75;73;104;93;73 06:58:52 INFO - PROCESS | 9588 | |4;audio-oscillator;95;96;141;94;95;96;139;95;96;139 06:58:52 INFO - PROCESS | 9588 | |5;imaging-gaussian-blur;119;115;115;115;118;115;115;115;115;115 06:58:52 INFO - PROCESS | 9588 | |6;imaging-darkroom;145;145;145;145;151;144;145;146;145;146 06:58:52 INFO - PROCESS | 9588 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 06:58:52 INFO - PROCESS | 9588 | |8;json-parse-financial;57;57;56;55;56;58;55;65;54;54 06:58:52 INFO - PROCESS | 9588 | |9;json-stringify-tinderbox;66;68;67;66;66;66;66;66;68;67 06:58:52 INFO - PROCESS | 9588 | |10;stanford-crypto-aes;83;85;86;93;86;86;85;85;85;85 06:58:52 INFO - PROCESS | 9588 | |11;stanford-crypto-ccm;117;118;115;113;127;119;114;121;115;119 06:58:52 INFO - PROCESS | 9588 | |12;stanford-crypto-pbkdf2;156;141;153;157;153;141;143;152;150;151 06:58:52 INFO - PROCESS | 9588 | |13;stanford-crypto-sha256-iterative;69;69;70;70;69;70;68;70;69;68 06:58:52 INFO - PROCESS | 9588 | __end_tp_report 06:58:52 INFO - PROCESS | 9588 | __start_cc_report 06:58:52 INFO - PROCESS | 9588 | _x_x_mozilla_cycle_collect,988 06:58:52 INFO - PROCESS | 9588 | __end_cc_report 06:58:52 INFO - PROCESS | 9588 | __startTimestamp1454857132400__endTimestamp 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | ------- Summary: start ------- 06:58:52 INFO - PROCESS | 9588 | Number of tests: 14 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#0] ai-astar Cycles:10 Average:109.90 Median:112.00 stddev:3.73 (3.3%) stddev-sans-first:3.78 06:58:52 INFO - PROCESS | 9588 | Values: 113.0 112.0 106.0 111.0 112.0 111.0 101.0 112.0 112.0 109.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.50 stddev:15.45 (10.4%) stddev-sans-first:16.34 06:58:52 INFO - PROCESS | 9588 | Values: 146.0 122.0 155.0 162.0 128.0 144.0 151.0 131.0 163.0 124.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.27 06:58:52 INFO - PROCESS | 9588 | Values: 160.0 161.0 161.0 162.0 162.0 163.0 161.0 165.0 162.0 162.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#3] audio-fft Cycles:10 Average:82.80 Median:74.00 stddev:12.60 (17.0%) stddev-sans-first:12.86 06:58:52 INFO - PROCESS | 9588 | Values: 73.0 73.0 93.0 98.0 73.0 75.0 73.0 104.0 93.0 73.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:95.00 stddev:21.45 (22.6%) stddev-sans-first:22.18 06:58:52 INFO - PROCESS | 9588 | Values: 95.0 96.0 141.0 94.0 95.0 96.0 139.0 95.0 96.0 139.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.00 06:58:52 INFO - PROCESS | 9588 | Values: 119.0 115.0 115.0 115.0 118.0 115.0 115.0 115.0 115.0 115.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.00 stddev:1.95 (1.3%) stddev-sans-first:2.05 06:58:52 INFO - PROCESS | 9588 | Values: 145.0 145.0 145.0 145.0 151.0 144.0 145.0 146.0 145.0 146.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:58:52 INFO - PROCESS | 9588 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:3.20 (5.7%) stddev-sans-first:3.39 06:58:52 INFO - PROCESS | 9588 | Values: 57.0 57.0 56.0 55.0 56.0 58.0 55.0 65.0 54.0 54.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 06:58:52 INFO - PROCESS | 9588 | Values: 66.0 68.0 67.0 66.0 66.0 66.0 66.0 66.0 68.0 67.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:2.64 (3.1%) stddev-sans-first:2.59 06:58:52 INFO - PROCESS | 9588 | Values: 83.0 85.0 86.0 93.0 86.0 86.0 85.0 85.0 85.0 85.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.50 stddev:4.10 (3.5%) stddev-sans-first:4.34 06:58:52 INFO - PROCESS | 9588 | Values: 117.0 118.0 115.0 113.0 127.0 119.0 114.0 121.0 115.0 119.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:152.50 stddev:5.95 (3.9%) stddev-sans-first:5.85 06:58:52 INFO - PROCESS | 9588 | Values: 156.0 141.0 153.0 157.0 153.0 141.0 143.0 152.0 150.0 151.0 06:58:52 INFO - PROCESS | 9588 | 06:58:52 INFO - PROCESS | 9588 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 06:58:52 INFO - PROCESS | 9588 | Values: 69.0 69.0 70.0 70.0 69.0 70.0 68.0 70.0 69.0 68.0 06:58:52 INFO - PROCESS | 9588 | -------- Summary: end -------- 06:58:52 INFO - PROCESS | 9588 | 06:58:53 INFO - TEST-INFO | 9588: exit 0 06:58:53 INFO - TEST-OK | kraken | took 60163ms 06:58:53 INFO - SUITE-END | took 1175s 06:58:53 INFO - Completed test suite (00:19:35) 06:58:53 INFO - Working with test: dromaeo_css 06:58:53 INFO - Generating results file: dromaeo_css 06:58:53 INFO - Working with test: kraken 06:58:53 INFO - Generating results file: kraken 06:58:53 INFO - javascript benchmark 06:58:53 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:58:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:58:53 INFO - process_Request line: dromaeo_css 6805.42 graph.html#tests=[[72,1,35]] 06:58:53 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:58:53 INFO - process_Request line: kraken 1509.10 graph.html#tests=[[232,1,35]] 06:58:53 INFO - RETURN: dromaeo_css: 6805.42 06:58:53 INFO - RETURN: kraken: 1509.10 06:58:53 INFO - javascript benchmark 06:58:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3159.8736050557973, 3176.428242916274, 3210.3418799146193, 3214.871405143794, 3243.6107667079955, 5053.115704751672, 5137.434882162968, 5192.688438693681, 5203.271541984125, 5245.055889939814, 5137.101007323713, 5162.6128040397025, 5165.664231824929, 5197.0, 5250.737463126848, 4643.907121857561, 4769.594584460317, 4804.231322988323, 4817.735024573647, 4834.395700537433, 4660.953390466103, 4761.976190119062, 4767.713937163781, 4774.28385742138, 4879.512048795127, 4770.356001939728, 4829.058333624945, 4829.782659780319, 4835.661503694708, 4849.175640141167, 4816.903661926742, 4818.542238487373, 4827.565519103297, 4848.22428411456, 4854.732989685566, 4543.204939135638, 4735.621150307967, 4787.425508938914, 4823.421189457253, 4844.37023186987, 5034.295198672189, 5040.924386134211, 5056.241563765428, 5073.239014147871, 5102.6428150029515, 5549.556035517149, 5556.388797232301, 5559.972200138974, 5561.749721262553, 5606.0, 5489.149181876815, 5530.336359636869, 5585.636933599344, 5586.190002449663, 5589.832305030855, 5212.322398088262, 5247.47525247476, 5249.4488078751565, 5253.894922101575, 5276.208568714724, 5590.993621148233, 5730.36965933747, 5736.741846616912, 5739.598228124075, 5754.0505816540635, 5409.377921538995, 5450.8909821803345, 5475.917861232085, 5483.396826349099, 5509.035918714209, 5547.195656629766, 5547.5007249347755, 5547.833564993057, 5549.861253468695, 5550.361708403505, 5367.731613419313, 5437.0, 5536.944630553643, 5541.030319694038, 5582.413846546055, 5559.63862348946, 5590.944090559124, 5593.105103183471, 5598.356189038313, 5639.943600564024, 4313.892152696208, 4345.956540434619, 4351.19502891966, 4355.912881742347, 4391.5827996340295, 3848.8845334640005, 3867.8259478323544, 3900.278448487039, 3907.9218415631526, 3939.625735555118, 5157.406898206679, 5178.119719647669, 5179.61152913533, 5180.766865491062, 5194.792208311701, 5584.301962254718, 5604.915926261109, 5609.887802244014, 5611.523020543218, 5659.547236221092, 5074.2895994560795, 5142.537171654569, 5159.716215608102, 5170.1727723564045, 5253.868653283622, 4686.742229177428, 4697.976510117427, 4707.7881495332795, 4711.8350857719815, 4750.026244619845, 5679.119736440858, 5684.118961560965, 5688.601797874192, 5692.857678557986, 5697.857553561194, 5409.594280429063, 5514.5864060196445, 5606.775728970795, 5617.691026993554, 5694.373618902, 5707.971460142673, 5715.085586306171, 5715.913976344481, 5717.371089180104, 5725.742341594555, 5382.219578161223, 5410.48600382963, 5435.0, 5470.72646367688, 5471.753771080232, 5495.368032676293, 5551.500364967173, 5578.163275508544, 5588.38527761954, 5623.718814059363, 5378.515933565998, 5378.892422151457, 5405.297311349656, 5425.891482170414, 5435.592330575144, 5380.192971054373, 5409.1345384739825, 5435.130379139477, 5479.643823151482, 5501.889962200654, 5328.8401347959625, 5332.706701131475, 5367.865803354791, 5378.112611419228, 5415.350157981067, 5453.863653408696, 5480.095784195563, 5508.586855985897, 5510.8071217507195, 5516.310461192351, 5244.265802787689, 5330.920036199383, 5342.0, 5373.247745315737, 5387.111126664213], "unit": "score", "name": "dojo.html", "value": 5138.2797736666935}, {"lowerIsBetter": false, "replicates": [542.4927692607409, 557.66818742848, 568.0059895183429, 587.7619564076549, 588.6085752974269, 27538.724612753867, 35898.0, 36228.637713622855, 36239.2752144957, 36299.274014519695, 38988.80505597475, 39168.60831391692, 39238.21523569527, 39243.80378098113, 39432.80283598585, 8324.33405327574, 8580.957095214546, 8585.141485851427, 8596.656133754643, 8602.48385096893, 8434.662613495453, 8547.145285471433, 8571.699990500334, 8577.356698247626, 8733.0, 8718.258947989429, 8808.075152109033, 8821.823563528758, 8826.426282291663, 8834.293256539493, 8700.30397568193, 8776.517291548962, 8783.165599268059, 8785.6046477908, 8788.824223515527, 8622.094680058566, 8734.86897696535, 8749.47503149813, 8751.299896008304, 8760.167784060504, 37420.25159496795, 37651.24697506062, 37755.0, 37818.621813781785, 38066.0, 3258.885938992124, 3382.8477718502727, 3490.738194635387, 3497.3529896969144, 3615.5842078161086, 29190.41619167626, 29610.70389296101, 29684.257893552618, 30105.397892042256, 30491.847540762377, 3833.923321533554, 3987.1029018470904, 4012.3981402789523, 4041.97979010106, 4148.792560372, 253591.0, 254359.0, 254481.0, 254719.72640136865, 255055.0, 50175.74912125416, 50883.745581271854, 56523.0, 57447.42552574504, 57541.0, 50647.49352506428, 50787.492125079014, 50832.49167508352, 50900.745496272284, 50922.49077509178, 13881.722365552632, 14526.128432294096, 14662.266886655625, 14711.632209194855, 14816.0, 10910.672679819618, 10916.34501929871, 10967.232293739362, 10969.780604388026, 10975.780484390427, 17780.822191778174, 17900.373486927896, 17902.641947160984, 18226.179821908045, 18620.906895465436, 7325.6337183141695, 7535.246475352421, 7570.848583028309, 7669.194734552903, 7741.419393545507, 985.6156099121205, 1040.0483557544912, 1121.2935850414349, 1127.5997021057572, 1132.105636547135, 29166.562501562494, 29717.257068573457, 29752.2561935949, 30094.09717708472, 30327.241818954702, 1092.2845536173818, 1108.2408550143177, 1109.4341885638382, 1248.3259040118417, 1260.7478504299177, 15471.845281547041, 15556.922215388851, 15646.921765391327, 15676.843231567538, 15907.443239486794, 304960.0, 308920.0, 309389.0, 309471.0, 310325.0, 43486.0, 47311.0, 49287.50712492901, 51709.7414512925, 52167.73916130395, 1318.2420108437686, 1318.6176008957486, 1332.8333958255218, 1335.0587835576089, 1338.8661133886533, 26268.21195364142, 26927.730722693304, 28983.7101628981, 29537.0, 30385.69614303917, 41683.37474937939, 46984.0, 48214.27678584754, 48452.5154748448, 48644.27033594428, 191906.0, 192251.07748922892, 192963.0, 193056.0347198255, 193658.0, 30087.097387078422, 30326.696733032386, 30371.69628303777, 30405.0, 30422.847885760428, 42492.362614561425, 43101.0, 43230.783846080565, 44236.336454953846, 44314.77842610766, 35967.82016089903, 36322.455163172046, 36609.816950915076, 37388.439173411876, 37627.81186094052, 35587.418138519955, 36776.63223367732, 36901.8799127294, 37367.43948840715, 37468.0, 35913.0, 36919.26161476702, 37786.24427511379, 38056.242969628795, 38077.238455231294, 28660.0, 31285.530717038808, 31679.84160079185, 31827.36345273128, 31848.36303273968, 24072.518549629258, 24129.0, 24346.02615895415, 24447.38881527976, 24962.875185623954], "unit": "score", "name": "ext.html", "value": 17942.388407174873}, {"lowerIsBetter": false, "replicates": [344.4677972532437, 354.78358201497065, 355.4082452716228, 364.14426098668133, 370.8831718008827, 13505.527306544273, 13788.655283617914, 16187.919060404696, 17249.13754312284, 18209.362672306455, 15027.924860375682, 15722.0, 15871.682566348665, 15897.52307430779, 16772.41296554621, 5426.864328391792, 5596.300462442195, 5597.63615365, 5597.916031259534, 5600.439956004388, 4096.5903409659095, 5483.8080667176655, 5531.917021244684, 5870.11948207768, 6136.447719705226, 5982.6410415375, 6040.667763273018, 6087.2086628738425, 6091.543134264925, 6091.908621370683, 5978.521718262528, 6067.9696601516935, 6108.633481991051, 6110.480609148228, 6134.631922084667, 5266.131088370415, 5353.759080841332, 5369.5972802040005, 5381.408045115034, 5389.029974604569, 19967.50081247966, 19997.50006249841, 20203.39389818293, 20276.188952442033, 20333.779973201654, 1994.700794880765, 2080.2719048333115, 2096.979030209709, 2401.0515846240637, 2483.466054798227, 9175.44947303164, 9268.814623707556, 9336.3464557481, 9706.320557560974, 12445.25328480294, 1887.1885089411549, 1893.1575448925234, 1894.8484121270264, 1896.1277812206401, 1975.812297831718, 51074.74462627663, 57244.42755572432, 58916.41083589195, 59967.0, 60859.0, 9754.512274386252, 10075.697729068139, 10180.185585153169, 10185.0, 10249.74375640615, 13185.14296570739, 13192.0, 13211.40548675312, 13213.339333033502, 13218.140820846615, 7185.3533182012825, 7349.0, 7359.8160045999275, 7383.335499805044, 7518.173000969889, 7085.964570177116, 7106.040684507629, 7123.572585644878, 7166.175889772743, 7166.78499645001, 4147.751134931914, 4385.649148068147, 4404.537523560044, 4441.133978874089, 4466.57567531084, 1771.8936863788215, 1772.8758986871053, 1787.25828781057, 1789.454216463965, 1816.7456556082159, 445.14309953339693, 454.42742144897005, 899.2760827533898, 955.9330846840794, 1029.145808978546, 10557.894421055844, 10650.201234907257, 10733.248672592843, 10743.14054875608, 11219.214654974074, 473.54303097510376, 476.07403599997673, 483.6880212263141, 928.2342067794096, 1070.7804899995638, 8788.95605521981, 9279.443233406017, 9285.442873427615, 9377.827771528559, 9477.28920330978, 493860.0, 498360.0, 512009.0, 513180.0, 516371.0, 45840.0, 56594.15108773372, 63860.0, 63903.680481597294, 70873.0, 1128.3568366031448, 1135.812590922505, 1179.2688533109526, 1186.661801386618, 1189.7323102301914, 14379.352929118424, 14487.0, 14744.0, 15146.848531514544, 15577.844221558093, 30375.0, 30497.54253686152, 30640.693593064676, 31163.0, 31397.8430107848, 41613.0, 42524.0, 43207.567924321615, 43385.44452832407, 43522.56477435185, 7430.628468576658, 7650.31147196755, 7676.232376762279, 7707.845843083219, 7720.0, 8000.0, 9327.414339562156, 10479.895201047892, 11503.712407189887, 11567.421628918351, 7377.446691498052, 7560.395168386626, 8987.595558199766, 9684.273679474209, 10185.287029908131, 9588.256676077759, 9655.951720241354, 9751.317407781387, 9904.405735655884, 10028.147607453157, 9331.813363732823, 10141.645042423479, 10181.389116652728, 10307.226957978331, 11037.172212083966, 7590.848183036419, 7654.617269136632, 7734.6132693366235, 7773.650185741542, 7870.212978702084, 9331.580078896603, 9795.804083918425, 10136.695899123039, 10318.331503841871, 10790.946045269724], "unit": "score", "name": "jquery.html", "value": 7962.243555797006}, {"lowerIsBetter": false, "replicates": [1343.8253027106487, 1470.8014418053563, 1470.8529147085292, 1611.8468745469183, 1763.8765286429955, 7010.754623588169, 7627.0, 7789.493682910607, 7798.5320880747195, 7803.492772969753, 7628.626847167508, 7775.727849525254, 7827.804304892381, 7829.647665855036, 7842.451028427998, 2049.5183631846503, 2261.231181398324, 2325.43026958395, 2333.614953532665, 2350.471143992605, 2322.280093171122, 2326.26722582386, 2327.860328380294, 2328.382978510696, 2330.0796185506715, 2286.5084006938505, 2359.044586942291, 2359.4337359033793, 2361.9645705314433, 2362.5038741864228, 2290.0839664134396, 2315.6873822033976, 2342.7891489765916, 2343.425860664131, 2345.8592484450987, 2292.3810571145696, 2299.9655005174936, 2314.849534780234, 2321.1991862807304, 2324.732655744594, 7931.206879312081, 7935.08746494149, 7979.760607181794, 7990.920090799075, 8010.399220058519, 4806.375171227718, 4928.0, 4930.408350997904, 4933.679310844784, 4938.9753051234875, 3096.6748491408302, 3109.0, 3151.038933125396, 3268.9182770430693, 3279.6884295991845, 1055.4352922398568, 1071.6999240212754, 1077.2136340471422, 1091.6791775619156, 1099.3019432660237, 10162.085412312854, 10386.169106471463, 10406.999999999924, 10430.0, 10432.791344173074, 4260.147970405931, 4283.935740963888, 4354.150940566559, 4362.1493808707, 4367.235733746582, 8082.959585202154, 8113.0, 8114.269715725613, 8127.146649601825, 8127.674893004214, 4679.415073115861, 4691.108689349013, 4703.106409782131, 4712.552307530779, 4744.3595114659765, 4426.22541055314, 4429.335599660012, 4442.977785111054, 4446.73319600825, 4451.154280686724, 3213.1645772099423, 3260.054584170611, 3436.1924947637285, 3480.7563470557325, 3503.649635036476, 1009.6466236817055, 1015.223354134088, 1015.8882522922472, 1018.1549314069305, 1036.486938965202, 1316.7432350691715, 1325.9933700331437, 1328.448693792085, 1347.3936728472227, 1380.2270728392132, 7340.44946629005, 7533.322001019935, 7742.070951485858, 7742.341900938371, 7767.106782719947, 1127.2053202492223, 1137.9601713939971, 1140.994295028536, 1142.360278244186, 1169.1997665590861, 5480.232767412565, 5521.3926468088475, 5526.226328314039, 5527.944720552823, 5535.750891209906, 9145.405548639317, 9162.267018638493, 9420.481873497023, 9532.571034303335, 9554.90445095554, 9556.617735290649, 9688.564014619358, 9697.709068727949, 9701.417914924987, 9711.417314961125, 7491.6254187290415, 7522.134954480195, 7686.269804368688, 7701.4608977371045, 7705.730299439605, 7315.743948961761, 7324.63376831167, 7353.632318383952, 7364.189939106587, 7370.742024029133, 8071.031476222891, 8115.594220288844, 8331.16688331162, 8497.235248827636, 8511.91488085136, 8398.370122240734, 8404.53775042354, 8411.411201215857, 8570.74287771368, 8574.442661227, 6345.302016778243, 6815.591064536144, 6952.617606031717, 6954.443644508326, 6954.443644508528, 6833.111695479556, 7331.816704582215, 7484.663190156347, 7504.774856754306, 7506.361959233308, 6899.0, 7067.787966361017, 7074.0, 7151.177614574391, 7187.712491500281, 6896.448284137357, 6899.0, 6968.477364197807, 7014.368706816411, 7138.571685698875, 7030.121234845645, 7043.401310888426, 7076.964615176891, 7092.468064895257, 7253.673584688807, 6678.966605166943, 6729.932700672931, 6731.158605174353, 6739.460843132636, 6746.730130794714, 6635.834104147242, 6685.364890335605, 6731.057651928832, 6737.191537015589, 6742.089817874524], "unit": "score", "name": "mootools.html", "value": 4520.211893141499}, {"lowerIsBetter": false, "replicates": [336.98315084245786, 343.1524135385598, 346.70876463770435, 347.48398628037376, 352.3393636930755, 5707.6290041147295, 5846.918320110783, 5878.676672782995, 5914.083317085848, 5931.673757943317, 5724.055530837417, 5800.390958949313, 5850.5612079094135, 5870.530357571395, 5881.735321910513, 4576.222042252808, 4586.724796512203, 4595.678302518825, 4603.355530225755, 4604.930926036112, 4357.520672725997, 4451.443569553806, 4499.932501012488, 4579.473360563527, 4588.678792484528, 4530.093981203756, 4543.636509079266, 4548.295014272793, 4549.61328287096, 4569.840055598055, 4546.477155127153, 4557.248054071091, 4562.498125206224, 4569.177548041352, 4572.885677858047, 4010.7393019453643, 4013.337799263147, 4023.3160362738404, 4033.3949907514107, 4039.0508230565792, 5400.189971504266, 5548.140038294071, 5572.60991730579, 5596.2165296858475, 5612.35457922336, 5173.249878767595, 5184.611154163453, 5190.299309593194, 5205.869853253699, 5213.0, 5922.58541902067, 6230.7819226326865, 6232.532560057968, 6240.188775459162, 6250.312465628777, 4218.810153543067, 4346.413234213404, 4352.064306174156, 4354.673399495019, 4388.034632380871, 6417.711202995876, 6515.7067931943175, 6524.93475065248, 6532.248791388956, 6538.967305163491, 4376.343548467756, 4386.824527018884, 4390.100029493946, 4391.012022294958, 4395.428594282723, 4363.2364336241035, 4415.381846541487, 4440.222960981815, 4452.0873220989615, 4454.510003899569, 5163.845084647466, 5168.9741551292755, 5178.171492561248, 5179.19722443022, 5192.506711862367, 6299.590526615755, 6310.7791227306825, 6314.242290925118, 6320.304766475684, 6340.144080549159, 1555.4478160252947, 1578.8105427348562, 1581.0671703694645, 1584.3187429405466, 1585.2866210205455, 1052.6263176572359, 1059.502034043998, 1061.851340812287, 1079.1312993040679, 1086.6359769477315, 5906.350301466835, 5914.201582786355, 5915.881682366328, 5917.644941303535, 5918.053111502139, 6465.0, 6465.321141280192, 6467.062275970052, 6471.5146364022885, 6473.06140609609, 5906.7637294508595, 5908.05471124618, 5910.970445147746, 5913.083472061838, 5917.349091599921, 3401.4557670772556, 3507.2985402919517, 3508.210652603195, 3510.4558793387064, 3510.684038436553, 6755.763548275885, 6758.05387245786, 6761.797146085625, 6766.18805743314, 6775.220849602359, 6652.966735166293, 6657.1345725055435, 6664.8000559983275, 6666.100076489612, 6667.6666166691475, 6551.475881929434, 6781.796546103625, 6827.726890924308, 6828.248892621708, 6831.555948863308, 6222.191115155001, 6370.235571731422, 6531.0, 6533.346665333429, 6546.934530654633, 6264.906026409516, 6317.273513545817, 6370.968145159244, 6392.616443013434, 6398.968005159944, 6707.765228217184, 6732.394084532416, 6742.393184613408, 6744.898826517704, 6749.156355455568, 4341.0, 4413.7351758894565, 4465.5087940327185, 4468.195724769573, 4475.731456112644, 6493.805185844432, 6493.902591461037, 6496.350364963466, 6497.967510162419, 6507.0, 6274.403931626488, 6284.366064823087, 6309.305976342507, 6310.4320611143385, 6311.116443697978, 6194.225721784777, 6281.497480201481, 6294.685265736786, 6308.905366419415, 6316.431521162934, 6193.194884664965, 6195.349488303663, 6196.969015155076, 6197.318294987638, 6202.0, 6320.5575609706875, 6322.272938612118, 6337.968310158604, 6338.207724034496, 6344.143540622142, 6065.6663883486835, 6174.660393678211, 6180.783672571439, 6189.84525386869, 6195.597286176384], "unit": "score", "name": "prototype.html", "value": 4731.210013459164}, {"lowerIsBetter": false, "replicates": [725.6335550546974, 732.0812380462519, 770.6647608290394, 791.5053091817614, 792.659156562678, 13575.52485663002, 13838.169709817417, 13896.096753711014, 13919.860801391984, 13952.441902323908, 11940.402979851016, 12988.350582470863, 13016.0, 13033.869661303384, 13047.21716696999, 683.4532374100725, 687.8417963868313, 819.5041999590252, 832.0057531250159, 832.3632421197789, 813.7599408174602, 829.5437509369852, 835.6114406800837, 837.3636036612188, 837.5728378526965, 878.6046279174365, 887.3034667785789, 887.414306557672, 888.0409158109227, 888.1074520107284, 706.6537396675618, 712.2165617820382, 826.7478419082178, 880.2605811118627, 880.3793325705362, 643.9001954697029, 644.1947565543071, 644.9290578036412, 645.6771614192903, 645.8675971425846, 13423.932880335537, 13457.86542134576, 13494.392752326168, 13500.392482338319, 13531.255780932044, 12651.785937461, 12978.675533111653, 13111.344432778324, 13241.602751917362, 13245.271510066943, 10363.170946324275, 10364.844527332096, 10454.477276136238, 10599.947000265027, 10695.679129626124, 3544.432890737495, 3612.8193590320643, 3652.3243200008083, 3658.2683463307444, 3689.4281386384887, 47403.525964740256, 47718.52281477176, 47739.0, 49232.753836231306, 49440.0, 9794.118529332252, 9832.508374581243, 10450.268481206243, 10459.84310235347, 10740.248182627141, 17719.911400442914, 17756.644867102586, 17855.28578856857, 17860.9106954467, 17899.821001789816, 7591.696332146763, 7781.221877812287, 7954.840903181904, 8045.436819422701, 8059.879101813477, 4450.287953927356, 4451.11974258103, 4518.796654150571, 4534.161180181677, 4543.0, 3195.7123858852815, 3232.4181647303712, 3236.417444859948, 3240.4329242382487, 3248.59392575928, 588.114887094928, 590.1678633127356, 601.1133577972543, 603.3333166850655, 607.875385545962, 597.2802772658936, 601.2454369765916, 615.4829942848029, 643.0900276109346, 659.2451642868888, 9043.32175086871, 9172.54137293146, 9432.575534100983, 9534.189593884597, 9585.520723963775, 563.8364874186522, 566.7053132371144, 580.4340767751493, 636.1507387637463, 698.8916717908733, 3763.322601931624, 3932.292187406237, 4089.6221468768476, 4113.547509773923, 4196.391523229115, 56481.15278270829, 58473.70763146242, 59366.10950835741, 59702.40297597055, 59771.70114149401, 48979.0, 49005.26492102621, 49569.0, 49579.25631115536, 50454.49545504571, 44772.32841507315, 44957.55042449599, 45248.773756131006, 46140.53859461429, 46415.535844641796, 8638.78403039929, 8801.427907186013, 8806.383553151218, 8868.201861832466, 8869.911300886908, 33234.16914577155, 34242.48636270508, 34615.0, 35212.647873521964, 35468.645313546534, 39223.62717304995, 39276.41085383664, 40774.0, 42926.14147717091, 43132.56867431411, 10607.257491975797, 11084.390358530036, 11100.000999910048, 11134.3876086816, 11389.829152562885, 12273.631791046282, 12392.0, 12403.75192496127, 12604.936975315064, 12788.232706037668, 10886.782264354826, 11013.724656883642, 11021.338719676525, 11198.160137989846, 11298.322100673986, 11040.116790656888, 11041.227114101936, 11146.996770290389, 11359.261647992855, 11646.24299420535, 11317.151213658844, 11725.34966596867, 11797.056235500968, 11846.585369512026, 11893.76212475763, 9090.772910435453, 9233.492157931378, 9249.953750231205, 9251.583678734338, 9769.413835169913, 9118.680846170351, 9295.581698823704, 9745.707628771148, 10097.848532272168, 10238.12975897057], "unit": "score", "name": "yui.html", "value": 6327.452712209822}], "name": "dromaeo_css", "value": 6805.421729663648}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 106.0, 111.0, 112.0, 111.0, 101.0, 112.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 155.0, 162.0, 128.0, 144.0, 151.0, 131.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 163.0, 161.0, 165.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 93.0, 98.0, 73.0, 75.0, 73.0, 104.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 141.0, 94.0, 95.0, 96.0, 139.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 118.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.7}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 151.0, 144.0, 145.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 55.0, 56.0, 58.0, 55.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 93.0, 86.0, 86.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 115.0, 113.0, 127.0, 119.0, 114.0, 121.0, 115.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [156.0, 141.0, 153.0, 157.0, 153.0, 141.0, 143.0, 152.0, 150.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 68.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1509.1000000000001}]} 06:58:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1509.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6805.42"}}} 06:58:53 INFO - Return code: 0 06:58:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:58:53 INFO - # TBPL SUCCESS # 06:58:53 INFO - Running post-action listener: _resource_record_post_action 06:58:53 INFO - Running post-run listener: _resource_record_post_run 06:58:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537612288; Read time: 280; Write time: 1510300 06:58:54 INFO - install - Wall time: 18s; CPU: 19.0%; Read bytes: 0; Write bytes: 241553408; Read time: 0; Write time: 1037284 06:58:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296058880; Read time: 280; Write time: 473016 06:58:54 INFO - Running post-run listener: _upload_blobber_files 06:58:54 INFO - Blob upload gear active. 06:58:54 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:58:54 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:58:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:58:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:58:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:58:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:56 INFO - (blobuploader) - INFO - Done attempting. 06:58:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:58:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:58:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:58:56 INFO - (blobuploader) - INFO - Done attempting. 06:58:56 INFO - (blobuploader) - INFO - Iteration through files over. 06:58:56 INFO - Return code: 0 06:58:56 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:58:56 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:58:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0985123da1604f19d63190b60a1e20b3315e33820b6cafddfb45107e17d8da703c88a9bef49b9f5a600fbf14c7ec34c86b349410ffacc3dbc67a48205cde1cb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a48d4f78436179a1ae75b803b82a4a0ba0435f0b07f7a339903e793dace4fd94ab928ba1e6720457e2c4acc16bebe8755600b71f7b5c455e0cd27088b2ce436"} 06:58:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:58:56 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:58:56 INFO - Contents: 06:58:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0985123da1604f19d63190b60a1e20b3315e33820b6cafddfb45107e17d8da703c88a9bef49b9f5a600fbf14c7ec34c86b349410ffacc3dbc67a48205cde1cb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a48d4f78436179a1ae75b803b82a4a0ba0435f0b07f7a339903e793dace4fd94ab928ba1e6720457e2c4acc16bebe8755600b71f7b5c455e0cd27088b2ce436"} 06:58:56 INFO - Running post-run listener: copy_logs_to_upload_dir 06:58:56 INFO - Copying logs to upload dir... 06:58:56 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:58:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.435060 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-02-07 06:58:56.069757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-07 06:58:56.073657) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0985123da1604f19d63190b60a1e20b3315e33820b6cafddfb45107e17d8da703c88a9bef49b9f5a600fbf14c7ec34c86b349410ffacc3dbc67a48205cde1cb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a48d4f78436179a1ae75b803b82a4a0ba0435f0b07f7a339903e793dace4fd94ab928ba1e6720457e2c4acc16bebe8755600b71f7b5c455e0cd27088b2ce436"} build_url:https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/cnr6wVmZSMSoqFq2bRKVGA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0985123da1604f19d63190b60a1e20b3315e33820b6cafddfb45107e17d8da703c88a9bef49b9f5a600fbf14c7ec34c86b349410ffacc3dbc67a48205cde1cb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a48d4f78436179a1ae75b803b82a4a0ba0435f0b07f7a339903e793dace4fd94ab928ba1e6720457e2c4acc16bebe8755600b71f7b5c455e0cd27088b2ce436"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-07 06:58:56.098535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:58:56.098869) ========= 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-1454847372.61331-627555222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-07 06:58:56.183471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-07 06:58:56.183817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-07 06:58:56.184178) ========= ========= Total master_lag: 0.28 =========