builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1454133338.0 results: success (0) buildid: 20160129193148 builduid: e89b1ed5538f487c91953322ea87cf8f revision: 4891238709e17274db6ffa4880730b97ff6c24da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:37.998628) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:37.999491) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:37.999846) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.029256) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.029622) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.046664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.047024) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.096630) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.096981) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.097468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.097792) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-29 21:55:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 82.3M=0s 2016-01-29 21:55:38 (82.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.276168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.276537) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014589 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:38.328047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 21:55:38.328417) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4891238709e17274db6ffa4880730b97ff6c24da --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4891238709e17274db6ffa4880730b97ff6c24da --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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-29 21:55:38,862 truncating revision to first 12 chars 2016-01-29 21:55:38,862 Setting DEBUG logging. 2016-01-29 21:55:38,862 attempt 1/10 2016-01-29 21:55:38,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4891238709e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 21:55:39,877 unpacking tar archive at: mozilla-inbound-4891238709e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 21:55:39.602665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:39.603086) ========= echo 4891238709e17274db6ffa4880730b97ff6c24da in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4891238709e17274db6ffa4880730b97ff6c24da'] 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4891238709e17274db6ffa4880730b97ff6c24da program finished with exit code 0 elapsedTime=0.004568 script_repo_revision: '4891238709e17274db6ffa4880730b97ff6c24da' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:39.672879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:39.673279) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 21:55:39.683856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-01-29 21:55:39.684178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:40 INFO - MultiFileLogger online at 20160129 21:55:40 in /builds/slave/test-pgo 21:55:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:55:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:55:40 INFO - {'append_to_log': False, 21:55:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:55:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:55:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:55:40 INFO - 'branch': 'Mozilla-Inbound', 21:55:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:40 INFO - 'config_files': ('talos/linux_config.py',), 21:55:40 INFO - 'default_actions': ('clobber', 21:55:40 INFO - 'read-buildbot-config', 21:55:40 INFO - 'download-and-extract', 21:55:40 INFO - 'populate-webroot', 21:55:40 INFO - 'create-virtualenv', 21:55:40 INFO - 'install', 21:55:40 INFO - 'run-tests'), 21:55:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:40 INFO - 'download_minidump_stackwalk': True, 21:55:40 INFO - 'download_symbols': 'ondemand', 21:55:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:40 INFO - 'installer_path': 'installer.exe', 21:55:40 INFO - 'log_level': 'info', 21:55:40 INFO - 'log_name': 'talos', 21:55:40 INFO - 'log_to_console': True, 21:55:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:40 INFO - 'opt_config_files': (), 21:55:40 INFO - 'pip_index': False, 21:55:40 INFO - 'sps_profile': False, 21:55:40 INFO - 'sps_profile_interval': 0, 21:55:40 INFO - 'suite': 'dromaeojs', 21:55:40 INFO - 'system_bits': '32', 21:55:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:40 INFO - 'title': 'talos-linux64-ix-012', 21:55:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:40 INFO - 'use_talos_json': True, 21:55:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:55:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:40 INFO - 'work_dir': 'build'} 21:55:40 INFO - ##### 21:55:40 INFO - ##### Running clobber step. 21:55:40 INFO - ##### 21:55:40 INFO - Running pre-action listener: _resource_record_pre_action 21:55:40 INFO - Running main action method: clobber 21:55:40 INFO - rmtree: /builds/slave/test-pgo/build 21:55:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:55:41 INFO - Running post-action listener: _resource_record_post_action 21:55:41 INFO - ##### 21:55:41 INFO - ##### Running read-buildbot-config step. 21:55:41 INFO - ##### 21:55:41 INFO - Running pre-action listener: _resource_record_pre_action 21:55:41 INFO - Running main action method: read_buildbot_config 21:55:41 INFO - Using buildbot properties: 21:55:41 INFO - { 21:55:41 INFO - "project": "", 21:55:41 INFO - "product": "firefox", 21:55:41 INFO - "script_repo_revision": "production", 21:55:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:55:41 INFO - "repository": "", 21:55:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:55:41 INFO - "buildid": "20160129193148", 21:55:41 INFO - "pgo_build": "True", 21:55:41 INFO - "basedir": "/builds/slave/test-pgo", 21:55:41 INFO - "buildnumber": 1468, 21:55:41 INFO - "slavename": "talos-linux64-ix-012", 21:55:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:55:41 INFO - "platform": "ubuntu64_hw", 21:55:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:55:41 INFO - "branch": "mozilla-inbound", 21:55:41 INFO - "repo_path": "integration/mozilla-inbound", 21:55:41 INFO - "revision": "4891238709e17274db6ffa4880730b97ff6c24da", 21:55:41 INFO - "stage_platform": "linux64-pgo", 21:55:41 INFO - "builduid": "e89b1ed5538f487c91953322ea87cf8f", 21:55:41 INFO - "slavebuilddir": "test" 21:55:41 INFO - } 21:55:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 21:55:41 INFO - Running post-action listener: _resource_record_post_action 21:55:41 INFO - ##### 21:55:41 INFO - ##### Running download-and-extract step. 21:55:41 INFO - ##### 21:55:41 INFO - Running pre-action listener: _resource_record_pre_action 21:55:41 INFO - Running main action method: download_and_extract 21:55:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:41 INFO - https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/test_packages.json 21:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/test_packages.json 21:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:55:42 INFO - Downloaded 1448 bytes. 21:55:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:55:42 INFO - Using the following test package requirements: 21:55:42 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:55:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:55:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'jsshell-linux-x86_64.zip'], 21:55:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:55:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:55:42 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:55:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:55:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 21:55:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 21:55:42 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:55:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:55: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')]} 21:55:42 INFO - https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:44 INFO - Downloaded 22544672 bytes. 21:55:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:55:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:55:45 INFO - Return code: 0 21:55:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:55: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')]} 21:55:45 INFO - https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 21:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:46 INFO - Downloaded 22544672 bytes. 21:55:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:55:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 21:55:48 INFO - Return code: 0 21:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:48 INFO - https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 21:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:55:49 INFO - Downloaded 10706582 bytes. 21:55:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 21:55:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 21:55:49 INFO - Return code: 0 21:55: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')]} 21:55:49 INFO - https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:55:50 INFO - Downloaded 55990496 bytes. 21:55:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:55:50 INFO - mkdir: /builds/slave/test-pgo/properties 21:55:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:55:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:55:50 INFO - Contents: 21:55:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 21:55:50 INFO - Running post-action listener: _resource_record_post_action 21:55:50 INFO - Running post-action listener: set_extra_try_arguments 21:55:50 INFO - ##### 21:55:50 INFO - ##### Running populate-webroot step. 21:55:50 INFO - ##### 21:55:50 INFO - Running pre-action listener: _resource_record_pre_action 21:55:50 INFO - Running main action method: populate_webroot 21:55:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:55:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:55:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:55:50 INFO - '--tppagecycles', 21:55:50 INFO - '7'], 21:55:50 INFO - 'tests': ['tsvgm']}}, 21:55:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:55:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:55:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:55:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:55:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'tests': ['damp', 'tps']}, 21:55:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['damp', 'tps']}, 21:55:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:55:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:55:50 INFO - 'other': {'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'other_l64': {'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'other_nol64': {'tests': ['a11yr', 21:55:50 INFO - 'ts_paint', 21:55:50 INFO - 'tpaint', 21:55:50 INFO - 'sessionrestore', 21:55:50 INFO - 'sessionrestore_no_auto_restore']}, 21:55:50 INFO - 'svgr': {'tests': ['tsvgx', 21:55:50 INFO - 'tsvgr_opacity', 21:55:50 INFO - 'tart', 21:55:50 INFO - 'tscrollx', 21:55:50 INFO - 'cart']}, 21:55:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['tsvgx', 21:55:50 INFO - 'tsvgr_opacity', 21:55:50 INFO - 'tart', 21:55:50 INFO - 'tscrollx', 21:55:50 INFO - 'cart']}, 21:55:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'tests': ['tp5o']}, 21:55:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'talos_options': ['--e10s'], 21:55:50 INFO - 'tests': ['tp5o']}, 21:55:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'talos_options': ['--xperf_path', 21:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:50 INFO - 'tests': ['tp5n']}, 21:55:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:50 INFO - 'talos_options': ['--e10s', 21:55:50 INFO - '--xperf_path', 21:55:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:50 INFO - 'tests': ['tp5n']}}, 21:55:50 INFO - 'talos.zip': {'path': '', 21:55:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:55:50 INFO - Running post-action listener: _resource_record_post_action 21:55:50 INFO - ##### 21:55:50 INFO - ##### Running create-virtualenv step. 21:55:50 INFO - ##### 21:55:50 INFO - Running pre-action listener: _resource_record_pre_action 21:55:50 INFO - Running main action method: create_virtualenv 21:55:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:55:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:55:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:55:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:55:50 INFO - Using real prefix '/usr' 21:55:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:55:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:55:53 INFO - Installing pip.................done. 21:55:53 INFO - Return code: 0 21:55:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:55: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')]} 21:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:55: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:55: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 pip>=1.5 21:55:53 INFO - Using env: {'DISPLAY': ':0', 21:55:53 INFO - 'HOME': '/home/cltbld', 21:55:53 INFO - 'LANG': 'en_US.UTF-8', 21:55:53 INFO - 'LANGUAGE': 'en_US:en', 21:55:53 INFO - 'LOGNAME': 'cltbld', 21:55:53 INFO - 'MAIL': '/var/mail/cltbld', 21:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:53 INFO - 'MOZ_NO_REMOTE': '1', 21:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:53 INFO - 'NO_EM_RESTART': '1', 21:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:53 INFO - 'SHELL': '/bin/bash', 21:55:53 INFO - 'SHLVL': '1', 21:55:53 INFO - 'TERM': 'linux', 21:55:53 INFO - 'TMOUT': '86400', 21:55:53 INFO - 'USER': 'cltbld', 21:55:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:53 INFO - '_': '/tools/buildbot/bin/python'} 21:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:55:53 INFO - Cleaning up... 21:55:53 INFO - Return code: 0 21:55:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:55: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')]} 21:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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', '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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:55: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:55: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 psutil>=0.7.1 21:55:53 INFO - Using env: {'DISPLAY': ':0', 21:55:53 INFO - 'HOME': '/home/cltbld', 21:55:53 INFO - 'LANG': 'en_US.UTF-8', 21:55:53 INFO - 'LANGUAGE': 'en_US:en', 21:55:53 INFO - 'LOGNAME': 'cltbld', 21:55:53 INFO - 'MAIL': '/var/mail/cltbld', 21:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:53 INFO - 'MOZ_NO_REMOTE': '1', 21:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:53 INFO - 'NO_EM_RESTART': '1', 21:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:53 INFO - 'SHELL': '/bin/bash', 21:55:53 INFO - 'SHLVL': '1', 21:55:53 INFO - 'TERM': 'linux', 21:55:53 INFO - 'TMOUT': '86400', 21:55:53 INFO - 'USER': 'cltbld', 21:55:53 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:53 INFO - '_': '/tools/buildbot/bin/python'} 21:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:53 INFO - Downloading/unpacking psutil>=0.7.1 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:55 INFO - Installing collected packages: psutil 21:55:55 INFO - Running setup.py install for psutil 21:55:55 INFO - building 'psutil._psutil_linux' extension 21:55:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:55:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:55:55 INFO - building 'psutil._psutil_posix' extension 21:55:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:55:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:55:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:55 INFO - Successfully installed psutil 21:55:55 INFO - Cleaning up... 21:55:55 INFO - Return code: 0 21:55:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:55: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')]} 21:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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', '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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:55: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:55: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 mozsystemmonitor==0.0.0 21:55:55 INFO - Using env: {'DISPLAY': ':0', 21:55:55 INFO - 'HOME': '/home/cltbld', 21:55:55 INFO - 'LANG': 'en_US.UTF-8', 21:55:55 INFO - 'LANGUAGE': 'en_US:en', 21:55:55 INFO - 'LOGNAME': 'cltbld', 21:55:55 INFO - 'MAIL': '/var/mail/cltbld', 21:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:55 INFO - 'MOZ_NO_REMOTE': '1', 21:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:55 INFO - 'NO_EM_RESTART': '1', 21:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:55 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:55 INFO - 'SHELL': '/bin/bash', 21:55:55 INFO - 'SHLVL': '1', 21:55:55 INFO - 'TERM': 'linux', 21:55:55 INFO - 'TMOUT': '86400', 21:55:55 INFO - 'USER': 'cltbld', 21:55:55 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:55 INFO - '_': '/tools/buildbot/bin/python'} 21:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:55:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:55:57 INFO - Installing collected packages: mozsystemmonitor 21:55:57 INFO - Running setup.py install for mozsystemmonitor 21:55:58 INFO - Successfully installed mozsystemmonitor 21:55:58 INFO - Cleaning up... 21:55:58 INFO - Return code: 0 21:55:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:58 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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:55:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:55:58 INFO - Using env: {'DISPLAY': ':0', 21:55:58 INFO - 'HOME': '/home/cltbld', 21:55:58 INFO - 'LANG': 'en_US.UTF-8', 21:55:58 INFO - 'LANGUAGE': 'en_US:en', 21:55:58 INFO - 'LOGNAME': 'cltbld', 21:55:58 INFO - 'MAIL': '/var/mail/cltbld', 21:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:58 INFO - 'MOZ_NO_REMOTE': '1', 21:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:58 INFO - 'NO_EM_RESTART': '1', 21:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 21:55:58 INFO - 'SHELL': '/bin/bash', 21:55:58 INFO - 'SHLVL': '1', 21:55:58 INFO - 'TERM': 'linux', 21:55:58 INFO - 'TMOUT': '86400', 21:55:58 INFO - 'USER': 'cltbld', 21:55:58 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:58 INFO - '_': '/tools/buildbot/bin/python'} 21:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:58 INFO - Downloading/unpacking blobuploader==1.2.4 21:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - Downloading docopt-0.6.1.tar.gz 21:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:00 INFO - Running setup.py install for blobuploader 21:56:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:56:00 INFO - Running setup.py install for requests 21:56:01 INFO - Running setup.py install for docopt 21:56:01 INFO - Successfully installed blobuploader requests docopt 21:56:01 INFO - Cleaning up... 21:56:01 INFO - Return code: 0 21:56:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:01 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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:01 INFO - Using env: {'DISPLAY': ':0', 21:56:01 INFO - 'HOME': '/home/cltbld', 21:56:01 INFO - 'LANG': 'en_US.UTF-8', 21:56:01 INFO - 'LANGUAGE': 'en_US:en', 21:56:01 INFO - 'LOGNAME': 'cltbld', 21:56:01 INFO - 'MAIL': '/var/mail/cltbld', 21:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:01 INFO - 'MOZ_NO_REMOTE': '1', 21:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:01 INFO - 'NO_EM_RESTART': '1', 21:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:01 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:01 INFO - 'SHELL': '/bin/bash', 21:56:01 INFO - 'SHLVL': '1', 21:56:01 INFO - 'TERM': 'linux', 21:56:01 INFO - 'TMOUT': '86400', 21:56:01 INFO - 'USER': 'cltbld', 21:56:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:01 INFO - '_': '/tools/buildbot/bin/python'} 21:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:01 INFO - Running setup.py (path:/tmp/pip-mejvcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:01 INFO - Running setup.py (path:/tmp/pip-ZOGIx3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:01 INFO - Running setup.py (path:/tmp/pip-bIGdJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:01 INFO - Running setup.py (path:/tmp/pip-BMv9wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:01 INFO - Running setup.py (path:/tmp/pip-xgrR7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:01 INFO - Running setup.py (path:/tmp/pip-PyHl1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:02 INFO - Running setup.py (path:/tmp/pip-9gYBoG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:02 INFO - Running setup.py (path:/tmp/pip-H9ZctS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:02 INFO - Running setup.py (path:/tmp/pip-YocZF3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:02 INFO - Running setup.py (path:/tmp/pip-K30BZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:02 INFO - Running setup.py (path:/tmp/pip-lBqD5r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:02 INFO - Running setup.py (path:/tmp/pip-gINJ6l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:02 INFO - Running setup.py (path:/tmp/pip-7bqAgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:02 INFO - Running setup.py (path:/tmp/pip-hurR5x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:02 INFO - Running setup.py (path:/tmp/pip-DdpMia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:02 INFO - Running setup.py (path:/tmp/pip-ytkWDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:02 INFO - Running setup.py (path:/tmp/pip-ooLcaP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:02 INFO - Running setup.py install for manifestparser 21:56:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:56:02 INFO - Running setup.py install for mozcrash 21:56:03 INFO - Running setup.py install for mozdebug 21:56:03 INFO - Running setup.py install for mozdevice 21:56:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for mozfile 21:56:03 INFO - Running setup.py install for mozhttpd 21:56:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for mozinfo 21:56:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for mozInstall 21:56:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for mozleak 21:56:03 INFO - Running setup.py install for mozlog 21:56:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for moznetwork 21:56:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:56:03 INFO - Running setup.py install for mozprocess 21:56:04 INFO - Running setup.py install for mozprofile 21:56:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:56:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:56:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:56:04 INFO - Running setup.py install for mozrunner 21:56:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:56:04 INFO - Running setup.py install for mozscreenshot 21:56:04 INFO - Running setup.py install for moztest 21:56:04 INFO - Running setup.py install for mozversion 21:56:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:56:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:04 INFO - Cleaning up... 21:56:04 INFO - Return code: 0 21:56:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:56:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:04 INFO - Using env: {'DISPLAY': ':0', 21:56:04 INFO - 'HOME': '/home/cltbld', 21:56:04 INFO - 'LANG': 'en_US.UTF-8', 21:56:04 INFO - 'LANGUAGE': 'en_US:en', 21:56:04 INFO - 'LOGNAME': 'cltbld', 21:56:04 INFO - 'MAIL': '/var/mail/cltbld', 21:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:04 INFO - 'MOZ_NO_REMOTE': '1', 21:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:04 INFO - 'NO_EM_RESTART': '1', 21:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:04 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:04 INFO - 'SHELL': '/bin/bash', 21:56:04 INFO - 'SHLVL': '1', 21:56:04 INFO - 'TERM': 'linux', 21:56:04 INFO - 'TMOUT': '86400', 21:56:04 INFO - 'USER': 'cltbld', 21:56:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:04 INFO - '_': '/tools/buildbot/bin/python'} 21:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:04 INFO - Running setup.py (path:/tmp/pip-P4Va91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:04 INFO - Running setup.py (path:/tmp/pip-oK0KOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:56:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:04 INFO - Running setup.py (path:/tmp/pip-Nd6h7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:05 INFO - Running setup.py (path:/tmp/pip-zvLgfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:05 INFO - Running setup.py (path:/tmp/pip-ZmFH2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:05 INFO - Running setup.py (path:/tmp/pip-xk7Cbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:05 INFO - Running setup.py (path:/tmp/pip-_jM3Kv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:05 INFO - Running setup.py (path:/tmp/pip-C5GByL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:05 INFO - Running setup.py (path:/tmp/pip-Ow0AUb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:05 INFO - Running setup.py (path:/tmp/pip-ZWz4vG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:05 INFO - Running setup.py (path:/tmp/pip-EY612H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:05 INFO - Running setup.py (path:/tmp/pip-dYMokp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:05 INFO - Running setup.py (path:/tmp/pip-iwEloE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:05 INFO - Running setup.py (path:/tmp/pip-H4Sfel-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:05 INFO - Running setup.py (path:/tmp/pip-6hfenX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:56:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:05 INFO - Running setup.py (path:/tmp/pip-wKW9bw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:56:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:06 INFO - Running setup.py (path:/tmp/pip-6JnHSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - Downloading blessings-1.6.tar.gz 21:56:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:07 INFO - Installing collected packages: blessings 21:56:07 INFO - Running setup.py install for blessings 21:56:08 INFO - Successfully installed blessings 21:56:08 INFO - Cleaning up... 21:56:08 INFO - Return code: 0 21:56:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:56:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:56:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:56:08 INFO - Reading from file tmpfile_stdout 21:56:08 INFO - Current package versions: 21:56:08 INFO - argparse == 1.2.1 21:56:08 INFO - blessings == 1.6 21:56:08 INFO - blobuploader == 1.2.4 21:56:08 INFO - docopt == 0.6.1 21:56:08 INFO - manifestparser == 1.1 21:56:08 INFO - mozInstall == 1.12 21:56:08 INFO - mozcrash == 0.16 21:56:08 INFO - mozdebug == 0.1 21:56:08 INFO - mozdevice == 0.48 21:56:08 INFO - mozfile == 1.2 21:56:08 INFO - mozhttpd == 0.7 21:56:08 INFO - mozinfo == 0.9 21:56:08 INFO - mozleak == 0.1 21:56:08 INFO - mozlog == 3.1 21:56:08 INFO - moznetwork == 0.27 21:56:08 INFO - mozprocess == 0.22 21:56:08 INFO - mozprofile == 0.28 21:56:08 INFO - mozrunner == 6.11 21:56:08 INFO - mozscreenshot == 0.1 21:56:08 INFO - mozsystemmonitor == 0.0 21:56:08 INFO - moztest == 0.7 21:56:08 INFO - mozversion == 1.4 21:56:08 INFO - psutil == 3.1.1 21:56:08 INFO - requests == 1.2.3 21:56:08 INFO - wsgiref == 0.1.2 21:56:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:56:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:08 INFO - Using env: {'DISPLAY': ':0', 21:56:08 INFO - 'HOME': '/home/cltbld', 21:56:08 INFO - 'LANG': 'en_US.UTF-8', 21:56:08 INFO - 'LANGUAGE': 'en_US:en', 21:56:08 INFO - 'LOGNAME': 'cltbld', 21:56:08 INFO - 'MAIL': '/var/mail/cltbld', 21:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:08 INFO - 'MOZ_NO_REMOTE': '1', 21:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:08 INFO - 'NO_EM_RESTART': '1', 21:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:08 INFO - 'SHELL': '/bin/bash', 21:56:08 INFO - 'SHLVL': '1', 21:56:08 INFO - 'TERM': 'linux', 21:56:08 INFO - 'TMOUT': '86400', 21:56:08 INFO - 'USER': 'cltbld', 21:56:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:08 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:56:08 INFO - Cleaning up... 21:56:08 INFO - Return code: 0 21:56:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:08 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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:56:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:08 INFO - Using env: {'DISPLAY': ':0', 21:56:08 INFO - 'HOME': '/home/cltbld', 21:56:08 INFO - 'LANG': 'en_US.UTF-8', 21:56:08 INFO - 'LANGUAGE': 'en_US:en', 21:56:08 INFO - 'LOGNAME': 'cltbld', 21:56:08 INFO - 'MAIL': '/var/mail/cltbld', 21:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:08 INFO - 'MOZ_NO_REMOTE': '1', 21:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:08 INFO - 'NO_EM_RESTART': '1', 21:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:08 INFO - 'SHELL': '/bin/bash', 21:56:08 INFO - 'SHLVL': '1', 21:56:08 INFO - 'TERM': 'linux', 21:56:08 INFO - 'TMOUT': '86400', 21:56:08 INFO - 'USER': 'cltbld', 21:56:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:08 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Downloading/unpacking jsonschema 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:10 INFO - Downloading/unpacking functools32 (from jsonschema) 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:10 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:10 INFO - warning: no files found matching '*.txt' 21:56:10 INFO - no previously-included directories found matching 'build' 21:56:10 INFO - no previously-included directories found matching 'dist' 21:56:10 INFO - no previously-included directories found matching '.git*' 21:56:10 INFO - Installing collected packages: jsonschema, functools32 21:56:10 INFO - Running setup.py install for functools32 21:56:10 INFO - warning: no files found matching '*.txt' 21:56:10 INFO - no previously-included directories found matching 'build' 21:56:10 INFO - no previously-included directories found matching 'dist' 21:56:10 INFO - no previously-included directories found matching '.git*' 21:56:10 INFO - Successfully installed jsonschema functools32 21:56:10 INFO - Cleaning up... 21:56:10 INFO - Return code: 0 21:56:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:10 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 0x7f40865b2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:56:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:56:10 INFO - Using env: {'DISPLAY': ':0', 21:56:10 INFO - 'HOME': '/home/cltbld', 21:56:10 INFO - 'LANG': 'en_US.UTF-8', 21:56:10 INFO - 'LANGUAGE': 'en_US:en', 21:56:10 INFO - 'LOGNAME': 'cltbld', 21:56:10 INFO - 'MAIL': '/var/mail/cltbld', 21:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:10 INFO - 'MOZ_NO_REMOTE': '1', 21:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:10 INFO - 'NO_EM_RESTART': '1', 21:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:10 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:10 INFO - 'SHELL': '/bin/bash', 21:56:10 INFO - 'SHLVL': '1', 21:56:10 INFO - 'TERM': 'linux', 21:56:10 INFO - 'TMOUT': '86400', 21:56:10 INFO - 'USER': 'cltbld', 21:56:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:10 INFO - '_': '/tools/buildbot/bin/python'} 21:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:11 INFO - Downloading/unpacking flake8 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:56:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:56:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:13 INFO - no previously-included directories found matching 'docs/_build' 21:56:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:56:13 INFO - Running setup.py install for pep8 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:56:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:56:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:56:13 INFO - no previously-included directories found matching 'docs/_build' 21:56:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:56:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:56:13 INFO - Cleaning up... 21:56:13 INFO - Return code: 0 21:56:13 INFO - Running post-action listener: _resource_record_post_action 21:56:13 INFO - Running post-action listener: _start_resource_monitoring 21:56:13 INFO - Starting resource monitoring. 21:56:13 INFO - ##### 21:56:13 INFO - ##### Running install step. 21:56:13 INFO - ##### 21:56:13 INFO - Running pre-action listener: _resource_record_pre_action 21:56:13 INFO - Running main action method: install 21:56:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:56:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:56:14 INFO - Reading from file tmpfile_stdout 21:56:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:56:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:56:14 INFO - Reading from file tmpfile_stdout 21:56:14 INFO - Output received: 21:56:14 INFO - Usage: mozinstall [options] installer 21:56:14 INFO - Options: 21:56:14 INFO - -h, --help show this help message and exit 21:56:14 INFO - -d DEST, --destination=DEST 21:56:14 INFO - Directory to install application into. [default: 21:56:14 INFO - "/builds/slave/test-pgo"] 21:56:14 INFO - --app=APP Application being installed. [default: firefox] 21:56:14 INFO - mkdir: /builds/slave/test-pgo/build/application 21:56:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:56:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:56:30 INFO - Reading from file tmpfile_stdout 21:56:30 INFO - Output received: 21:56:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:56:30 INFO - Running post-action listener: _resource_record_post_action 21:56:30 INFO - ##### 21:56:30 INFO - ##### Running run-tests step. 21:56:30 INFO - ##### 21:56:30 INFO - Running pre-action listener: _resource_record_pre_action 21:56:30 INFO - Running main action method: run_tests 21:56:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:56:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:56:30 INFO - Python 2.7.3 21:56:30 INFO - Return code: 0 21:56:30 INFO - grabbing minidump binary from tooltool 21:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:30 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 0x1b7e7f0>, '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 0x1aea2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aea760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:56:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:56:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:56:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:30 INFO - Return code: 0 21:56:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:56:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:56:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:56:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:56:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:56:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:56:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:56:31 INFO - Return code: 0 21:56:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:56:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:56:31 INFO - Using env: {'DISPLAY': ':0', 21:56:31 INFO - 'HOME': '/home/cltbld', 21:56:31 INFO - 'LANG': 'en_US.UTF-8', 21:56:31 INFO - 'LANGUAGE': 'en_US:en', 21:56:31 INFO - 'LOGNAME': 'cltbld', 21:56:31 INFO - 'MAIL': '/var/mail/cltbld', 21:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:31 INFO - 'MOZ_NO_REMOTE': '1', 21:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:31 INFO - 'NO_EM_RESTART': '1', 21:56:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:31 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:56:31 INFO - 'SHELL': '/bin/bash', 21:56:31 INFO - 'SHLVL': '1', 21:56:31 INFO - 'TERM': 'linux', 21:56:31 INFO - 'TMOUT': '86400', 21:56:31 INFO - 'USER': 'cltbld', 21:56:31 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385', 21:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:31 INFO - '_': '/tools/buildbot/bin/python'} 21:56:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:56:31 INFO - mozversion application_buildid: 20160129193148 21:56:31 INFO - mozversion application_changeset: 4891238709e17274db6ffa4880730b97ff6c24da 21:56:31 INFO - mozversion application_display_name: Nightly 21:56:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:31 INFO - mozversion application_name: Firefox 21:56:31 INFO - mozversion application_remotingname: firefox 21:56:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:31 INFO - mozversion application_vendor: Mozilla 21:56:31 INFO - mozversion application_version: 47.0a1 21:56:31 INFO - mozversion platform_buildid: 20160129193148 21:56:31 INFO - mozversion platform_changeset: 4891238709e17274db6ffa4880730b97ff6c24da 21:56:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:56:31 INFO - mozversion platform_version: 47.0a1 21:56:31 INFO - using testdate: 1454133391 21:56:31 INFO - actual date: 1454133391 21:56:31 INFO - starting webserver on 'localhost:60030' 21:56:31 INFO - SUITE-START | Running 2 tests 21:56:31 INFO - TEST-START | dromaeo_css 21:56:31 INFO - operating with platform_type : linux_ 21:56:31 INFO - Initialising browser for dromaeo_css test... 21:56:31 INFO - TEST-INFO | started process 8999 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqGIjFp/profile http://localhost:60030/getInfo.html) 21:56:34 INFO - PROCESS | 8999 | __metrics Screen width/height:1600/1200 21:56:34 INFO - PROCESS | 8999 | colorDepth:24 21:56:34 INFO - PROCESS | 8999 | Browser inner width/height: 1024/697 21:56:34 INFO - PROCESS | 8999 | __metrics 21:56:35 INFO - PROCESS | 8999 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:56:35 INFO - PROCESS | 8999 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:56:36 INFO - TEST-INFO | 8999: exit 0 21:56:36 INFO - Browser initialized. 21:56:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:36 INFO - TEST-INFO | started process 9091 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqGIjFp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:47 INFO - PROCESS | 9091 | RSS: Main: 148434944 21:56:47 INFO - PROCESS | 9091 | 21:57:39 INFO - PROCESS | 9091 | 1454133459425 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:59:47 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60030/tests/dromaeo/cssquery-ext.html) 21:59:48 INFO - PROCESS | 9091 | RSS: Main: 230162432 21:59:48 INFO - PROCESS | 9091 | 22:02:50 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-ext.html (next: http://localhost:60030/tests/dromaeo/cssquery-jquery.html) 22:02:51 INFO - PROCESS | 9091 | RSS: Main: 236199936 22:02:51 INFO - PROCESS | 9091 | 22:05:53 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60030/tests/dromaeo/cssquery-mootools.html) 22:05:53 INFO - PROCESS | 9091 | RSS: Main: 235720704 22:05:53 INFO - PROCESS | 9091 | 22:08:55 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60030/tests/dromaeo/cssquery-prototype.html) 22:08:56 INFO - PROCESS | 9091 | RSS: Main: 215805952 22:08:56 INFO - PROCESS | 9091 | 22:11:58 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60030/tests/dromaeo/cssquery-yui.html) 22:11:59 INFO - PROCESS | 9091 | RSS: Main: 216092672 22:11:59 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | Cycle 1(1): loaded http://localhost:60030/tests/dromaeo/cssquery-yui.html (next: http://localhost:60030/tests/dromaeo/cssquery-dojo.html) 22:15:02 INFO - PROCESS | 9091 | RSS: Main: 261472256 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | __start_tp_report 22:15:02 INFO - PROCESS | 9091 | _x_x_mozilla_page_load 22:15:02 INFO - PROCESS | 9091 | _x_x_mozilla_page_load_details 22:15:02 INFO - PROCESS | 9091 | |i|pagename|runs| 22:15:02 INFO - PROCESS | 9091 | |0;dojo.html;3102.751779857611;3141.5287706843956;3158.3525377297656;3167.0657156138936;3172.762042846786;5045.268436076767;5110.770015349309;5145.536901678848;5153.4846515348445;5203.8959220815605;5142.588592912567;5210.817621383252;5217.217417387385;5221.477852214776;5233.973830130844;4672.55610716983;4692.741899195551;4709.717416954976;4757.714537127766;4765.380500534926;4848.345473361104;4852.1508735971065;4862.63530235232;4879.853604391874;4903.239997800347;4625.907481850361;4660.580547750718;4684.578387945085;4703.106409782131;4746.691465054761;4757.310190022427;4758.595519380822;4765.28520721891;4787.377640906695;4811.941372897957;4729.692569982974;4750.596199323062;4760.619150467989;4769.833055843029;4776.229786723727;4998.775055122528;5004;5093.898122037575;5115.181570948667;5147.459516750762;5529.281193444866;5539.584531160139;5542.889142217174;5545.195946587763;5545.445455454463;5548.472895075001;5558.583106267046;5563.721813909328;5565.916511252334;5572.58205634579;5215.295935048758;5251.553617942442;5268.130758424817;5296.947030529723;5323.653962492464;5718.714064296769;5748.712564371848;5749.195112684228;5749.741261643236;5757.424257574293;5359.624826262124;5439.728013599304;5540.307461567304;5544.833654990357;5559.610827242135;5534.335879694462;5578.358488773762;5579.246801681802;5591.27313449249;5618.634788738719;5548.5838562108;5550.417206193372;5557.472040156179;5561.5272701820795;5564.026295398289;5487.176923461433;5505.394406615269;5509.173623956439;5516.475934786189;5522.420145884625;4283.357496375568;4322.827086916488;4322.913541729148;4323.286657701444;4357.934630980538;3846.0192650873846;3850.961490385116;3863;3883;3885.3394922862617;5062.190049592121;5096.872578185501;5099.209622508517;5134.589232861437;5147.022065807485;5517.531009864207;5563.304586926634;5592.105263157875;5603.719814009283;5642.294713160855;5165.767540460688;5209.6874187548865;5210.869728256824;5219.556337711261;5261.631685782035;4686.27362758773;4699.882502937454;4780.856574302777;4823.083614113307;4839.008003359303;5700;5708.143778433268;5720.513756330759;5721.799737009184;5730.455606717355;5527.2538207341495;5527.8894422110525;5528.281323427928;5533.253010843485;5541.362743284574;5676.091825307931;5676.545876329801;5725.914111288417;5755.65466072037;5773.278340207474;5448.264484294569;5448.918266226089;5455.809046683347;5456.181572764117;5470.042742519963;5470.480304371078;5509.146082357241;5514.310711161105;5516.613837031369;5576.219329293821;5355.4376790436445;5397.298351214317;5407;5410.21551874968;5471.781128754806;5438.293021907127;5452.672839629635;5456.645318054314;5458.317710286215;5461.9453805461435;5310.123829568232;5342.465753424626;5343.519083282523;5347.51872331492;5392.272043274108;5411.269478620336;5452.291202143696;5489.231507588861;5514.531264842533;5548.861278467909;5251.606129540223;5287.10119279731;5327.547158491571;5338.145896656516;5373.247745315581 22:15:02 INFO - PROCESS | 9091 | |1;ext.html;520.1209955175752;529.4678847758003;541.4342012596836;546.1098409592364;550.9035918714226;28051.719482805165;28813.711862881366;35480.2903941921;35822.46266306001;36206;38596.61403385965;38666.226675466474;38758.806205969;38809.80595097028;38859.222815543675;8327.20891515305;8501.06488286288;8515.23362897339;8518.27594654455;8520.19058189471;8363.456375335614;8552.35857310701;8552.828943421127;8553.40126191167;8555.10171432;8430.283425908805;8564.657413703444;8565.614547345385;8566.871496927552;8574.742757717248;8470.534120623362;8549.273311768507;8554.18735220153;8568.443051201652;8572.571371431466;8436.36727245459;8549.615267312985;8603.741887743377;8605.010423801217;8628.22345988864;37831.432528512094;38022.23955520874;38122.23755524874;38137;38141.427878581846;3045.0408121441897;3301.059198128522;3406.9488957665408;3560.305740380627;3565.53648025755;29086.27284317888;29394.70605293941;29914.102576922727;29961.70038299611;30544.847275763703;3648.945265821015;3653.1232504199065;3655.981720091409;3686.2627474505207;3765.3787125124322;261755;262272.9999999981;262845;263920;265036;50920.490795092315;52142.73928630409;56259.71870140623;56451;56671;60518;61226;61384.38615613876;61694.69152654208;61764.69117654383;15420.92289538545;15622.843771562366;15637.452689156053;15642.45251416195;15645.139517326428;10855.294405863751;10900.40047797363;11821.113416493625;11944.701382465508;11991.340476273714;18197.7270340945;18404.539886502946;18579;18667.90666046661;18698.34555790541;6966.3730264276455;7139.785806425815;7142.678579463936;7176.92823071773;7370.926290737131;940.1209868772719;1030.2633616963906;1043.2175868098925;1061.8088744025995;1093.578972095749;24136.155234566704;24367.878160609438;24404.877975610365;24489.387765305655;24490.265292041266;984.640606178754;995.7411073120896;1000.8899021107673;1017.6896046705825;1042.280826229914;12489.437975291134;12875.098743088081;12950.805737913939;14824.184669843262;15161.841556222183;313880;319324;319474;319507;319561;50811.49188508068;50829;50890.236646450336;51158.48841511612;51310.48689513132;1140.298716289476;1218.65268398506;1240.8262843201958;1296.786030304989;1308.4308325878274;24913.252602421955;26674.466510670067;26819.86590067037;26848.59727104056;26967.190984269717;46401.76799115983;49164.262536062706;49271;49292;49343.25985110298;285002;289377;290262;295114;295497;28785.424291513635;28916;28939;28991.42017159687;29008.709912901446;39332;39857;40062.1987560253;40099.599004009586;40683.3897491532;35002.824985874904;35285.29429411346;35725.89152247525;35900.281994359444;36743.81628091842;35365.29269414546;35989.46015809713;36141.84368797517;36181.638183617826;36198.45702314415;34498.31003379868;35504.64495355013;35587;35588.28823423465;35594.28811423809;30102.698973010865;32350.514742278414;32622;33012.50481242735;33217.501737473474;24524;25102.748972510042;25259.115930942327;25426.491470170862;25725.485490289717 22:15:02 INFO - PROCESS | 9091 | |2;jquery.html;356.5792365009289;357.51526888127506;360.796150175151;360.98917032489004;361.2486029059556;13437.596872093853;13865.792013119812;15904.20478976051;16510.83489165108;16976.811623186382;14176.787348189786;15097.924510377461;15562.144082075481;15678.137702426362;15737.291821868015;5299.708516031607;5464.016477034133;5465.180222966547;5467.17992301154;5468.234447177399;4013.337799263118;4155.62599366057;5383.784648614051;5405.4324295948945;5712.914306285388;5897.557683173758;5901.734421951022;5909.290885093795;5916.171735956969;5918;6203.069539569078;6314.368563143695;6357.968210158966;6360.236771587439;6363.777267795628;6025.066114752177;6059.242594675666;6062.878742425127;6210.068489726532;6220.377962203744;21075.78924210769;21365.67951480729;21454.785452145436;21641;21888.12447502098;2293.289080385086;2343.0737545891325;2442.438239204993;2569.717331093578;2798.6501687289087;12018.879811201863;13007.479700811957;13154.60536183916;13767.655808604764;13969.092009019381;1951.5023668964322;1952.541152829084;1955.4817973237105;1961.3331467301186;1986.2849374225268;60416;61460.69269653668;62904;63896.68051659758;65859.3414065858;14887.925560372345;15156.24218789056;15432.614184645248;15475.767863482057;15499.690006200039;22874.656880146813;22918.770812291998;23119;23220.419489512897;23242.418939526648;6879.5184337095925;7140.678669459887;7250.492465527468;7276.854462910712;9192.126747958933;6723.125993620798;6764.188297404245;6768.289329620417;6818.386345228953;6878.828029299208;4369.541198174146;4441.644668426518;4447.533009034005;4454.10917816438;4507;1688.0968681755448;1700.0874016731177;1738.313366220361;1738.4871462918215;1822.3803906671794;889.9866502002475;907.9591418386188;915.7115508614766;1017.9389236645825;1035.5805898611075;13471.865281347062;15156.166410847289;15432.38270469191;15660.451884183998;15757.715131305897;885.6457417033238;887.2547060469237;888.3071204460531;936.0592604432502;960.3325688646323;8698.826023479622;9176.265898728087;9195.862062069074;9315.161635452707;9324.627014919328;366863;372438;378606;379402;411035;71147;72379;72944.2705572948;73444;73716;1015.7257540464034;1040.245821779204;1080.6703955293553;1096.9122470202365;1137.4995002199005;13880.097793643381;13938.930305348815;14401.351939162554;14637;14880.181590012653;29933.700662993964;30369.69630303757;30554.694453056076;31376.843115784275;32321.676783231866;42050.1589968205;42204.155916882104;42483.78758106189;42524.149517010104;42681.78659106685;7044.718211271492;7173.820654483471;7211.567305961449;7217.314355136254;7250.274972502708;8522.872156917776;10647.733806654896;10686.57253709874;10910.345379277269;11242.66272011841;9099;9204.735389818972;9234.584443700183;9318.627254909728;9588.472634005197;9330.206932410549;9586.424814511152;9660.565274562521;10091.091801737879;10121.949390253001;9019.233365163773;9051.230645395215;9065.138811812867;9233.261339092991;9469.431834089977;6791.796246112624;6951.339622735832;7041.647917603997;7240.384567311838;7356.77929662111;8338.416310858182;9210;9276.536173191449;9316.627334906529;9367.85948210791 22:15:02 INFO - PROCESS | 9091 | |3;mootools.html;1336.7675981111543;1396.427464739457;1402.9368678409471;1532.9233538323087;1750.728637061255;6726.26011138775;7274.090738657668;7396.223396543366;7438.367738742207;7442.739504117357;7560.96219518903;7749.612519374037;7750.457467977244;7752.844943101135;7761.41789365797;1992.870463419873;2036.419620408184;2234.519578290667;2272.534130503247;2298.0577963035157;2238.6642003699494;2240.7311122665224;2241.7758224177533;2243.8541494802867;2244.9438764030947;2209.5249521352907;2290.633498640218;2292.3925159832656;2293.9770602294016;2294.506681063571;2230.241717815942;2234.296196698043;2257.7064981552376;2288.233441797;2303.9539209215723;2241.3388050525136;2248.415411992877;2259.35608351619;2260.062074239189;2292.954140917189;7845.803854903616;7915.762527124196;7922;7926.167752385974;7942.801429964239;4712.64655150865;4798.616110711169;4827.517248275144;4829.975850120762;4836.274558816206;2899.797014209006;2936.6476022877177;2977.4640564698348;2978.27032377069;3009.6839831817565;903.2548147778109;906.7823722306599;911.4258017449031;927.2813569483636;941.482184798365;10964.780704385868;10984;10997.725056873562;11002.889971100267;11030.50362733671;4205.36919462077;4208.7685177314925;4257.74453532789;4270.0605866709275;4272.551382104896;9437.386569872937;9446.149846513847;9458.763530911645;9461.621535138655;9470.100340467645;4712.410948631421;4736.976315118402;4765.666403351732;4765.9523404766205;4767.308740232646;4312.37470566766;4336.111097225062;4339.262325404688;4340.565943405634;4348.543402942709;3363.024722830352;3417.0773891049275;3627.655372739638;3674.9081272968388;3725.5529336479794;1187.5784096645739;1213.4963989944074;1216.3614102596207;1225.2587184753274;1229.5266322465736;1017.9592816287413;1025.2464438637596;1050.0706874416196;1052.3422860712055;1057.5875408590655;7247.456440766858;7283.198848126702;7318;7326.377257933029;7361.852762944711;1083.2958576924905;1105.4251789069638;1112.844201811747;1113.7716768062528;1155.7052951497315;5757.366689664133;5850.619709718854;5852.034414321589;5854.882902342015;5862.70686465675;9254.86117708235;9721.756956076013;9830;9837.458939758382;9839.458829764288;9491.572879220452;9495.857562136573;9500.097490738368;9631.229501639851;9632.711018669452;7247.746328878569;7423.331900129015;7473.103227612722;7483.738069167553;7520.699172033057;7089.539179953286;7107.75122870697;7144.3927266182955;7168.820779480555;7169.569825810259;8455.11221321777;8459.323254139777;8675.089115642766;8703.173198546128;8725.171108744658;8506.659733610586;8776.210141087333;8787.121287871418;8879.156480134377;8914;6983.6857341418745;6998.090248267693;7017.789466316019;7037.612931288623;7058.400035996792;6608.306127856698;6797.048413222054;7183.856322873408;7326.3406293433845;7333;6936.132983377078;6984.196817366068;6984.2317345093015;7104.218535960937;7121.572705637678;6895.931040689529;6953.548019378724;6989.091418115816;7024.964875175591;7035.577865328097;6852.211995620568;6894.827629309107;6942.930570694229;6953.617551034539;6971.163460384786;6443.903341449788;6506.772262970773;6515.185601799775;6515.804525864231;6515.934840651533;6311.2426508819235;6467.773627923;6472.579282346633;6478.5141114415665;6483.643399613066 22:15:02 INFO - PROCESS | 9091 | |4;prototype.html;334.93468773589154;344.6708393484223;345.3593583901863;354.3975242088447;360.8628721085987;5583.246261754662;5722.7424765885535;5732.426757324265;5741.224934633823;5752.712364381775;5537.501624853762;5596.552275817935;5610.24261724667;5638.351589567191;5643.8024669136585;4425.645948324142;4429.313456414261;4439.890027493127;4443.711158774686;4446.933296000562;4280.229558679436;4330.328799036154;4409.206342858284;4459.754713490756;4465.24090904547;4413.337999300099;4431.756253406062;4443.46678398591;4444.866654000385;4459.241928872099;4449.777511124431;4452.354408610733;4456.420665313504;4459.888502787457;4470.687051906368;3924.9018774530578;3924.9607503925167;3927.960720392788;3929.8035098244973;3933.940990885139;5299.251247088451;5425.755840987165;5426.2674538937135;5440.238366628675;5447.428020057877;5141.5886729061585;5145.794168233266;5147.305113809625;5148;5158.793648254065;6031.065184896348;6033.306169790487;6035.185249991239;6036.5170786336985;6048.304444988838;4340.08858139791;4341.479022517318;4351.0862718829085;4351.238533256699;4357.106793107406;5833.066709326487;5955.851103722398;6213.937860621381;6329.588576742497;6333.80998570039;4383.5835595619;4384.978075109604;4389.517153113155;4391.231534481453;4395.53846846083;4448.5551444855255;4452.732836029849;4454.443194600675;4459.0413061192;4460.330950357472;5108.693478391308;5110.2590124431745;5114.667546609458;5115.897682046412;5124.666896651705;5985.25184351956;6097.847553811191;6098.634081955097;6098.908516372258;6103.755849766048;1578.9605259868365;1600.9199540022953;1601.8237993820671;1601.9359225631076;1602.2389365051508;1096.0354887698775;1103.773726386089;1112.6884472347756;1127.9548818047351;1135.926164799302;5761.596688231867;5774.960507108677;5781.624194427349;5781.94218057814;5782.2483077199695;6047.758089676452;6186.4741496973265;6256.280527739277;6256.468200203034;6262.279837818709;5645.125005624135;5787.797427090116;5803.564732645069;5833.183354330397;5833.241678581842;3354.4297469430257;3389.508521264452;3391.9824052784065;3392.9830350848583;3395.3888300105723;6422;6576.868462630816;6595.340465953366;6596.901046484307;6603.240627327823;6449;6451.967740161363;6452.548321617535;6454.677266136769;6462.515311351667;6591.901121483182;6592.373724496165;6593.274739778716;6599.241087274929;6602.438792702674;6192.2569291683485;6300.968495157678;6305.211848518935;6317.4630156437215;6318.052292156213;6243.875122497616;6254.8123556293385;6257.812265632038;6261.217347831521;6262.592931459622;6576.2766095728475;6581.736730530916;6586.571872828251;6587.47300215972;6593.934060659524;4512.503624601226;4512.729236245836;4516.774161291856;4517.570830771071;4522.276435770261;6206.038064100072;6276.9372306276355;6316.084167795736;6317.336679648571;6329.177206963065;6090.360512146338;6118.785842495491;6119.694015299128;6156.29202641702;6186.969065154645;6149.7847575334645;6154.1999540059505;6155.938440615716;6158.938410616016;6161.075838624063;5947.1079338099635;6015.72929218195;6043.184170136975;6049.485793707584;6053.727582258721;6180.381961803783;6220.688965551613;6224.066390041349;6225.097360882556;6225.346338634378;6049.576529642883;6051.425114614105;6055.939440605714;6063.363346848518;6064.423879731418 22:15:02 INFO - PROCESS | 9091 | |5;yui.html;654.9869002619951;662.4501663619196;687.6286805125233;765.3800421658457;788.2826627768729;13663.590092297234;13719.862801371983;13781.58655240342;13783.448662053532;13787.586372408843;12463.065270104757;12908.483660653586;12921.612351629467;12930;13024.34878256088;756.4780301591898;768.9730859419893;768.9846203075936;769.4037121231063;769.4114002787871;643.6331291164039;650.5966300893452;757.3146302596159;758.8444368904361;761.2539711083142;803.3894240377297;804.1154729797234;805.6012273924416;813.9470934389275;814.1004190369645;673.7002034094829;807.2532907060975;811.2739098506833;811.6469335838899;812.212154210415;505.2244804225496;592.1709606550863;601.1523751510393;601.1703848688825;602.9638221706712;12668.493260269579;12762.23426594398;12791.296478693668;12793.424295906707;12794.808077878839;11884.227525210834;11910.523579056828;12131.454084566216;12649.873501264961;12703.872961270454;10161.796764064751;10347.5343609537;10402.47987600617;10535.73660658482;10589.364638121737;3486.6687664671817;3500.282442099389;3508.736844736655;3510.3154884797473;3619.7828130312264;44851;45151.54848451539;45225;45274.54725452769;45928.999999999665;9866.210703143732;9986.35088719231;10010.399376037461;10032.79934401308;10102.646407375854;17185.656286874444;17201.31194752221;17228.741568876478;17246.568835779206;17282.913585431994;7372.152202496674;7543.47195696307;7631.3513351364645;7792.727254546064;7858.0570331560575;4304.418903447994;4410.140022695544;4422.469303683579;4462.3752674625575;4473.597376236155;3132.530120481946;3139.3564319314487;3152.6059242594674;3180.220845892725;3184.1084496341064;543.1011675676762;552.5938435250088;554.8196836028307;563.4196777319368;565.5871214013711;586.694604504973;593.4391999560374;599.3227652752449;601.9414592130196;629.3894921925724;8210.630521626541;8296.502209867427;8616.310695144373;8955.2835773138;9168.404053736485;563.0203446004006;589.6992533807789;614.8217017065001;662.3596810787637;689.5483458334799;3815.3132436161204;3993.6405723485027;4182.811773470201;4225.281752058169;4316.762578058237;53722.73138634282;54176.45823541793;54361.72819135879;54628;54675.453245467834;45972.770136149775;47573.28640070402;47603.285950710764;48287;48344.51655483471;41488.79255603703;42175;42532.36201456981;42581.36127958083;42588.57411425908;8261.586920654063;8534.274586660204;8672.52301123419;8736.606852691772;8790.824183516166;34315.82842085774;34438.31123377568;34878.65121348754;35376;35478;40185.598144018186;40471.392929105496;43635.56364436442;43755;43878;10650.57397704083;10791.02880740737;10796.028357447867;11065.280756750786;11187.496562654538;11388.430578471209;11887.465064071965;11918.344491053076;11970.46132924038;12149.81775273354;10609.8939010612;10918.07196388316;10935;11041.779164416826;11245.831312530483;9605.423674579548;9779.902200977898;10349.534270957674;10840.620578280037;10960;7830.530168189927;10314.278000540191;10541.31481453703;10553.841692374774;10809.027187553158;8536.530490823065;9049.954750226207;9810.75473113178;10057.515547093628;10118.49407529606;9136.588853501742;9141.268698504236;9445.178992156596;9635.373700709431;9636.951815240878 22:15:02 INFO - PROCESS | 9091 | __end_tp_report 22:15:02 INFO - PROCESS | 9091 | __start_cc_report 22:15:02 INFO - PROCESS | 9091 | _x_x_mozilla_cycle_collect,923 22:15:02 INFO - PROCESS | 9091 | __end_cc_report 22:15:02 INFO - PROCESS | 9091 | __startTimestamp1454134502386__endTimestamp 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | ------- Summary: start ------- 22:15:02 INFO - PROCESS | 9091 | Number of tests: 6 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#0] dojo.html Cycles:165 Average:5164.39 Median:5347.52 stddev:556.00 (10.4%) stddev-sans-first:533.67 22:15:02 INFO - PROCESS | 9091 | Values: 3102.8 3141.5 3158.4 3167.1 3172.8 5045.3 5110.8 5145.5 5153.5 5203.9 5142.6 5210.8 5217.2 5221.5 5234.0 4672.6 4692.7 4709.7 4757.7 4765.4 4848.3 4852.2 4862.6 4879.9 4903.2 4625.9 4660.6 4684.6 4703.1 4746.7 4757.3 4758.6 4765.3 4787.4 4811.9 4729.7 4750.6 4760.6 4769.8 4776.2 4998.8 5004.0 5093.9 5115.2 5147.5 5529.3 5539.6 5542.9 5545.2 5545.4 5548.5 5558.6 5563.7 5565.9 5572.6 5215.3 5251.6 5268.1 5296.9 5323.7 5718.7 5748.7 5749.2 5749.7 5757.4 5359.6 5439.7 5540.3 5544.8 5559.6 5534.3 5578.4 5579.2 5591.3 5618.6 5548.6 5550.4 5557.5 5561.5 5564.0 5487.2 5505.4 5509.2 5516.5 5522.4 4283.4 4322.8 4322.9 4323.3 4357.9 3846.0 3851.0 3863.0 3883.0 3885.3 5062.2 5096.9 5099.2 5134.6 5147.0 5517.5 5563.3 5592.1 5603.7 5642.3 5165.8 5209.7 5210.9 5219.6 5261.6 4686.3 4699.9 4780.9 4823.1 4839.0 5700.0 5708.1 5720.5 5721.8 5730.5 5527.3 5527.9 5528.3 5533.3 5541.4 5676.1 5676.5 5725.9 5755.7 5773.3 5448.3 5448.9 5455.8 5456.2 5470.0 5470.5 5509.1 5514.3 5516.6 5576.2 5355.4 5397.3 5407.0 5410.2 5471.8 5438.3 5452.7 5456.6 5458.3 5461.9 5310.1 5342.5 5343.5 5347.5 5392.3 5411.3 5452.3 5489.2 5514.5 5548.9 5251.6 5287.1 5327.5 5338.1 5373.2 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#1] ext.html Cycles:180 Average:45326.16 Median:19577.30 stddev:76332.32 (389.9%) stddev-sans-first:76472.32 22:15:02 INFO - PROCESS | 9091 | Values: 520.1 529.5 541.4 546.1 550.9 28051.7 28813.7 35480.3 35822.5 36206.0 38596.6 38666.2 38758.8 38809.8 38859.2 8327.2 8501.1 8515.2 8518.3 8520.2 8363.5 8552.4 8552.8 8553.4 8555.1 8430.3 8564.7 8565.6 8566.9 8574.7 8470.5 8549.3 8554.2 8568.4 8572.6 8436.4 8549.6 8603.7 8605.0 8628.2 37831.4 38022.2 38122.2 38137.0 38141.4 3045.0 3301.1 3406.9 3560.3 3565.5 29086.3 29394.7 29914.1 29961.7 30544.8 3648.9 3653.1 3656.0 3686.3 3765.4 261755.0 262273.0 262845.0 263920.0 265036.0 50920.5 52142.7 56259.7 56451.0 56671.0 60518.0 61226.0 61384.4 61694.7 61764.7 15420.9 15622.8 15637.5 15642.5 15645.1 10855.3 10900.4 11821.1 11944.7 11991.3 18197.7 18404.5 18579.0 18667.9 18698.3 6966.4 7139.8 7142.7 7176.9 7370.9 940.1 1030.3 1043.2 1061.8 1093.6 24136.2 24367.9 24404.9 24489.4 24490.3 984.6 995.7 1000.9 1017.7 1042.3 12489.4 12875.1 12950.8 14824.2 15161.8 313880.0 319324.0 319474.0 319507.0 319561.0 50811.5 50829.0 50890.2 51158.5 51310.5 1140.3 1218.7 1240.8 1296.8 1308.4 24913.3 26674.5 26819.9 26848.6 26967.2 46401.8 49164.3 49271.0 49292.0 49343.3 285002.0 289377.0 290262.0 295114.0 295497.0 28785.4 28916.0 28939.0 28991.4 29008.7 39332.0 39857.0 40062.2 40099.6 40683.4 35002.8 35285.3 35725.9 35900.3 36743.8 35365.3 35989.5 36141.8 36181.6 36198.5 34498.3 35504.6 35587.0 35588.3 35594.3 30102.7 32350.5 32622.0 33012.5 33217.5 24524.0 25102.7 25259.1 25426.5 25725.5 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#2] jquery.html Cycles:180 Average:23660.18 Median:4405.59 stddev:62761.15 (1424.6%) stddev-sans-first:62912.82 22:15:02 INFO - PROCESS | 9091 | Values: 356.6 357.5 360.8 361.0 361.2 13437.6 13865.8 15904.2 16510.8 16976.8 14176.8 15097.9 15562.1 15678.1 15737.3 5299.7 5464.0 5465.2 5467.2 5468.2 4013.3 4155.6 5383.8 5405.4 5712.9 5897.6 5901.7 5909.3 5916.2 5918.0 6203.1 6314.4 6358.0 6360.2 6363.8 6025.1 6059.2 6062.9 6210.1 6220.4 21075.8 21365.7 21454.8 21641.0 21888.1 2293.3 2343.1 2442.4 2569.7 2798.7 12018.9 13007.5 13154.6 13767.7 13969.1 1951.5 1952.5 1955.5 1961.3 1986.3 60416.0 61460.7 62904.0 63896.7 65859.3 14887.9 15156.2 15432.6 15475.8 15499.7 22874.7 22918.8 23119.0 23220.4 23242.4 6879.5 7140.7 7250.5 7276.9 9192.1 6723.1 6764.2 6768.3 6818.4 6878.8 4369.5 4441.6 4447.5 4454.1 4507.0 1688.1 1700.1 1738.3 1738.5 1822.4 890.0 908.0 915.7 1017.9 1035.6 13471.9 15156.2 15432.4 15660.5 15757.7 885.6 887.3 888.3 936.1 960.3 8698.8 9176.3 9195.9 9315.2 9324.6 366863.0 372438.0 378606.0 379402.0 411035.0 71147.0 72379.0 72944.3 73444.0 73716.0 1015.7 1040.2 1080.7 1096.9 1137.5 13880.1 13938.9 14401.4 14637.0 14880.2 29933.7 30369.7 30554.7 31376.8 32321.7 42050.2 42204.2 42483.8 42524.1 42681.8 7044.7 7173.8 7211.6 7217.3 7250.3 8522.9 10647.7 10686.6 10910.3 11242.7 9099.0 9204.7 9234.6 9318.6 9588.5 9330.2 9586.4 9660.6 10091.1 10121.9 9019.2 9051.2 9065.1 9233.3 9469.4 6791.8 6951.3 7041.6 7240.4 7356.8 8338.4 9210.0 9276.5 9316.6 9367.9 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#3] mootools.html Cycles:180 Average:5478.73 Median:6495.21 stddev:2890.75 (44.5%) stddev-sans-first:2882.09 22:15:02 INFO - PROCESS | 9091 | Values: 1336.8 1396.4 1402.9 1532.9 1750.7 6726.3 7274.1 7396.2 7438.4 7442.7 7561.0 7749.6 7750.5 7752.8 7761.4 1992.9 2036.4 2234.5 2272.5 2298.1 2238.7 2240.7 2241.8 2243.9 2244.9 2209.5 2290.6 2292.4 2294.0 2294.5 2230.2 2234.3 2257.7 2288.2 2304.0 2241.3 2248.4 2259.4 2260.1 2293.0 7845.8 7915.8 7922.0 7926.2 7942.8 4712.6 4798.6 4827.5 4830.0 4836.3 2899.8 2936.6 2977.5 2978.3 3009.7 903.3 906.8 911.4 927.3 941.5 10964.8 10984.0 10997.7 11002.9 11030.5 4205.4 4208.8 4257.7 4270.1 4272.6 9437.4 9446.1 9458.8 9461.6 9470.1 4712.4 4737.0 4765.7 4766.0 4767.3 4312.4 4336.1 4339.3 4340.6 4348.5 3363.0 3417.1 3627.7 3674.9 3725.6 1187.6 1213.5 1216.4 1225.3 1229.5 1018.0 1025.2 1050.1 1052.3 1057.6 7247.5 7283.2 7318.0 7326.4 7361.9 1083.3 1105.4 1112.8 1113.8 1155.7 5757.4 5850.6 5852.0 5854.9 5862.7 9254.9 9721.8 9830.0 9837.5 9839.5 9491.6 9495.9 9500.1 9631.2 9632.7 7247.7 7423.3 7473.1 7483.7 7520.7 7089.5 7107.8 7144.4 7168.8 7169.6 8455.1 8459.3 8675.1 8703.2 8725.2 8506.7 8776.2 8787.1 8879.2 8914.0 6983.7 6998.1 7017.8 7037.6 7058.4 6608.3 6797.0 7183.9 7326.3 7333.0 6936.1 6984.2 6984.2 7104.2 7121.6 6895.9 6953.5 6989.1 7025.0 7035.6 6852.2 6894.8 6942.9 6953.6 6971.2 6443.9 6506.8 6515.2 6515.8 6515.9 6311.2 6467.8 6472.6 6478.5 6483.6 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#4] prototype.html Cycles:180 Average:5122.32 Median:5757.15 stddev:1515.69 (26.3%) stddev-sans-first:1476.73 22:15:02 INFO - PROCESS | 9091 | Values: 334.9 344.7 345.4 354.4 360.9 5583.2 5722.7 5732.4 5741.2 5752.7 5537.5 5596.6 5610.2 5638.4 5643.8 4425.6 4429.3 4439.9 4443.7 4446.9 4280.2 4330.3 4409.2 4459.8 4465.2 4413.3 4431.8 4443.5 4444.9 4459.2 4449.8 4452.4 4456.4 4459.9 4470.7 3924.9 3925.0 3928.0 3929.8 3933.9 5299.3 5425.8 5426.3 5440.2 5447.4 5141.6 5145.8 5147.3 5148.0 5158.8 6031.1 6033.3 6035.2 6036.5 6048.3 4340.1 4341.5 4351.1 4351.2 4357.1 5833.1 5955.9 6213.9 6329.6 6333.8 4383.6 4385.0 4389.5 4391.2 4395.5 4448.6 4452.7 4454.4 4459.0 4460.3 5108.7 5110.3 5114.7 5115.9 5124.7 5985.3 6097.8 6098.6 6098.9 6103.8 1579.0 1600.9 1601.8 1601.9 1602.2 1096.0 1103.8 1112.7 1128.0 1135.9 5761.6 5775.0 5781.6 5781.9 5782.2 6047.8 6186.5 6256.3 6256.5 6262.3 5645.1 5787.8 5803.6 5833.2 5833.2 3354.4 3389.5 3392.0 3393.0 3395.4 6422.0 6576.9 6595.3 6596.9 6603.2 6449.0 6452.0 6452.5 6454.7 6462.5 6591.9 6592.4 6593.3 6599.2 6602.4 6192.3 6301.0 6305.2 6317.5 6318.1 6243.9 6254.8 6257.8 6261.2 6262.6 6576.3 6581.7 6586.6 6587.5 6593.9 4512.5 4512.7 4516.8 4517.6 4522.3 6206.0 6276.9 6316.1 6317.3 6329.2 6090.4 6118.8 6119.7 6156.3 6187.0 6149.8 6154.2 6155.9 6158.9 6161.1 5947.1 6015.7 6043.2 6049.5 6053.7 6180.4 6220.7 6224.1 6225.1 6225.3 6049.6 6051.4 6055.9 6063.4 6064.4 22:15:02 INFO - PROCESS | 9091 | 22:15:02 INFO - PROCESS | 9091 | [#5] yui.html Cycles:180 Average:13198.41 Median:4467.99 stddev:14954.74 (334.7%) stddev-sans-first:14967.03 22:15:02 INFO - PROCESS | 9091 | Values: 655.0 662.5 687.6 765.4 788.3 13663.6 13719.9 13781.6 13783.4 13787.6 12463.1 12908.5 12921.6 12930.0 13024.3 756.5 769.0 769.0 769.4 769.4 643.6 650.6 757.3 758.8 761.3 803.4 804.1 805.6 813.9 814.1 673.7 807.3 811.3 811.6 812.2 505.2 592.2 601.2 601.2 603.0 12668.5 12762.2 12791.3 12793.4 12794.8 11884.2 11910.5 12131.5 12649.9 12703.9 10161.8 10347.5 10402.5 10535.7 10589.4 3486.7 3500.3 3508.7 3510.3 3619.8 44851.0 45151.5 45225.0 45274.5 45929.0 9866.2 9986.4 10010.4 10032.8 10102.6 17185.7 17201.3 17228.7 17246.6 17282.9 7372.2 7543.5 7631.4 7792.7 7858.1 4304.4 4410.1 4422.5 4462.4 4473.6 3132.5 3139.4 3152.6 3180.2 3184.1 543.1 552.6 554.8 563.4 565.6 586.7 593.4 599.3 601.9 629.4 8210.6 8296.5 8616.3 8955.3 9168.4 563.0 589.7 614.8 662.4 689.5 3815.3 3993.6 4182.8 4225.3 4316.8 53722.7 54176.5 54361.7 54628.0 54675.5 45972.8 47573.3 47603.3 48287.0 48344.5 41488.8 42175.0 42532.4 42581.4 42588.6 8261.6 8534.3 8672.5 8736.6 8790.8 34315.8 34438.3 34878.7 35376.0 35478.0 40185.6 40471.4 43635.6 43755.0 43878.0 10650.6 10791.0 10796.0 11065.3 11187.5 11388.4 11887.5 11918.3 11970.5 12149.8 10609.9 10918.1 10935.0 11041.8 11245.8 9605.4 9779.9 10349.5 10840.6 10960.0 7830.5 10314.3 10541.3 10553.8 10809.0 8536.5 9050.0 9810.8 10057.5 10118.5 9136.6 9141.3 9445.2 9635.4 9637.0 22:15:02 INFO - PROCESS | 9091 | -------- Summary: end -------- 22:15:02 INFO - PROCESS | 9091 | 22:15:03 INFO - TEST-INFO | 9091: exit 0 22:15:03 INFO - TEST-OK | dromaeo_css | took 1111554ms 22:15:03 INFO - TEST-START | kraken 22:15:03 INFO - operating with platform_type : linux_ 22:15:03 INFO - Initialising browser for kraken test... 22:15:03 INFO - TEST-INFO | started process 9278 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB2fkXE/profile http://localhost:60030/getInfo.html) 22:15:06 INFO - PROCESS | 9278 | __metrics Screen width/height:1600/1200 22:15:06 INFO - PROCESS | 9278 | colorDepth:24 22:15:06 INFO - PROCESS | 9278 | Browser inner width/height: 1024/697 22:15:06 INFO - PROCESS | 9278 | __metrics 22:15:06 INFO - PROCESS | 9278 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:15:06 INFO - PROCESS | 9278 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:15:07 INFO - TEST-INFO | 9278: exit 0 22:15:07 INFO - Browser initialized. 22:15:07 INFO - Running cycle 1/1 for kraken test... 22:15:07 INFO - TEST-INFO | started process 9360 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpB2fkXE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:19 INFO - PROCESS | 9360 | RSS: Main: 150306816 22:15:19 INFO - PROCESS | 9360 | 22:15:21 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60030/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:22 INFO - PROCESS | 9360 | RSS: Main: 189050880 22:15:22 INFO - PROCESS | 9360 | 22:15:25 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60030/tests/kraken/driver.html?testName=audio-dft) 22:15:25 INFO - PROCESS | 9360 | RSS: Main: 179462144 22:15:25 INFO - PROCESS | 9360 | 22:15:28 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60030/tests/kraken/driver.html?testName=audio-fft) 22:15:29 INFO - PROCESS | 9360 | RSS: Main: 164216832 22:15:29 INFO - PROCESS | 9360 | 22:15:31 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60030/tests/kraken/driver.html?testName=audio-oscillator) 22:15:31 INFO - PROCESS | 9360 | RSS: Main: 166678528 22:15:31 INFO - PROCESS | 9360 | 22:15:34 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:34 INFO - PROCESS | 9360 | RSS: Main: 167555072 22:15:34 INFO - PROCESS | 9360 | 22:15:37 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60030/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:38 INFO - PROCESS | 9360 | RSS: Main: 169259008 22:15:38 INFO - PROCESS | 9360 | 22:15:41 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60030/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:42 INFO - PROCESS | 9360 | RSS: Main: 168140800 22:15:42 INFO - PROCESS | 9360 | 22:15:44 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60030/tests/kraken/driver.html?testName=json-parse-financial) 22:15:45 INFO - PROCESS | 9360 | RSS: Main: 168402944 22:15:45 INFO - PROCESS | 9360 | 22:15:47 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:15:47 INFO - PROCESS | 9360 | RSS: Main: 178634752 22:15:47 INFO - PROCESS | 9360 | 22:15:49 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:15:50 INFO - PROCESS | 9360 | RSS: Main: 178634752 22:15:50 INFO - PROCESS | 9360 | 22:15:52 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:15:52 INFO - PROCESS | 9360 | RSS: Main: 189059072 22:15:52 INFO - PROCESS | 9360 | 22:15:55 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:15:55 INFO - PROCESS | 9360 | RSS: Main: 197042176 22:15:55 INFO - PROCESS | 9360 | 22:15:58 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:15:58 INFO - PROCESS | 9360 | RSS: Main: 193712128 22:15:58 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | Cycle 1(1): loaded http://localhost:60030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60030/tests/kraken/driver.html?testName=ai-astar) 22:16:00 INFO - PROCESS | 9360 | RSS: Main: 253685760 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | __start_tp_report 22:16:00 INFO - PROCESS | 9360 | _x_x_mozilla_page_load 22:16:00 INFO - PROCESS | 9360 | _x_x_mozilla_page_load_details 22:16:00 INFO - PROCESS | 9360 | |i|pagename|runs| 22:16:00 INFO - PROCESS | 9360 | |0;ai-astar;110;112;105;112;111;110;100;110;110;111 22:16:00 INFO - PROCESS | 9360 | |1;audio-beat-detection;158;126;149;164;127;151;160;127;162;135 22:16:00 INFO - PROCESS | 9360 | |2;audio-dft;162;163;161;161;162;162;162;164;162;161 22:16:00 INFO - PROCESS | 9360 | |3;audio-fft;72;73;102;93;73;72;76;113;95;74 22:16:00 INFO - PROCESS | 9360 | |4;audio-oscillator;95;96;138;96;95;96;144;96;97;136 22:16:00 INFO - PROCESS | 9360 | |5;imaging-gaussian-blur;119;116;115;115;115;115;115;115;114;115 22:16:00 INFO - PROCESS | 9360 | |6;imaging-darkroom;145;145;146;145;146;146;146;146;145;146 22:16:00 INFO - PROCESS | 9360 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 22:16:00 INFO - PROCESS | 9360 | |8;json-parse-financial;54;57;55;54;54;55;53;64;53;52 22:16:00 INFO - PROCESS | 9360 | |9;json-stringify-tinderbox;67;68;68;69;68;68;68;68;68;67 22:16:00 INFO - PROCESS | 9360 | |10;stanford-crypto-aes;82;84;84;83;83;81;83;84;83;84 22:16:00 INFO - PROCESS | 9360 | |11;stanford-crypto-ccm;120;135;117;116;123;116;115;119;114;116 22:16:00 INFO - PROCESS | 9360 | |12;stanford-crypto-pbkdf2;157;138;148;149;142;143;141;147;145;158 22:16:00 INFO - PROCESS | 9360 | |13;stanford-crypto-sha256-iterative;67;69;70;70;69;69;68;68;66;66 22:16:00 INFO - PROCESS | 9360 | __end_tp_report 22:16:00 INFO - PROCESS | 9360 | __start_cc_report 22:16:00 INFO - PROCESS | 9360 | _x_x_mozilla_cycle_collect,963 22:16:00 INFO - PROCESS | 9360 | __end_cc_report 22:16:00 INFO - PROCESS | 9360 | __startTimestamp1454134560829__endTimestamp 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | ------- Summary: start ------- 22:16:00 INFO - PROCESS | 9360 | Number of tests: 14 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.75 (3.4%) stddev-sans-first:3.97 22:16:00 INFO - PROCESS | 9360 | Values: 110.0 112.0 105.0 112.0 111.0 110.0 100.0 110.0 110.0 111.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:154.50 stddev:15.62 (10.1%) stddev-sans-first:15.95 22:16:00 INFO - PROCESS | 9360 | Values: 158.0 126.0 149.0 164.0 127.0 151.0 160.0 127.0 162.0 135.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 22:16:00 INFO - PROCESS | 9360 | Values: 162.0 163.0 161.0 161.0 162.0 162.0 162.0 164.0 162.0 161.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#3] audio-fft Cycles:10 Average:84.30 Median:73.50 stddev:15.13 (20.6%) stddev-sans-first:15.38 22:16:00 INFO - PROCESS | 9360 | Values: 72.0 73.0 102.0 93.0 73.0 72.0 76.0 113.0 95.0 74.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:21.10 (22.0%) stddev-sans-first:21.77 22:16:00 INFO - PROCESS | 9360 | Values: 95.0 96.0 138.0 96.0 95.0 96.0 144.0 96.0 97.0 136.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 22:16:00 INFO - PROCESS | 9360 | Values: 119.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:16:00 INFO - PROCESS | 9360 | Values: 145.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:16:00 INFO - PROCESS | 9360 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:3.41 (6.3%) stddev-sans-first:3.60 22:16:00 INFO - PROCESS | 9360 | Values: 54.0 57.0 55.0 54.0 54.0 55.0 53.0 64.0 53.0 52.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 22:16:00 INFO - PROCESS | 9360 | Values: 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 67.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:0.99 (1.2%) stddev-sans-first:0.97 22:16:00 INFO - PROCESS | 9360 | Values: 82.0 84.0 84.0 83.0 83.0 81.0 83.0 84.0 83.0 84.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:118.00 stddev:6.19 (5.2%) stddev-sans-first:6.56 22:16:00 INFO - PROCESS | 9360 | Values: 120.0 135.0 117.0 116.0 123.0 116.0 115.0 119.0 114.0 116.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:147.50 stddev:6.56 (4.4%) stddev-sans-first:5.83 22:16:00 INFO - PROCESS | 9360 | Values: 157.0 138.0 148.0 149.0 142.0 143.0 141.0 147.0 145.0 158.0 22:16:00 INFO - PROCESS | 9360 | 22:16:00 INFO - PROCESS | 9360 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.50 22:16:00 INFO - PROCESS | 9360 | Values: 67.0 69.0 70.0 70.0 69.0 69.0 68.0 68.0 66.0 66.0 22:16:00 INFO - PROCESS | 9360 | -------- Summary: end -------- 22:16:00 INFO - PROCESS | 9360 | 22:16:01 INFO - TEST-INFO | 9360: exit 0 22:16:01 INFO - TEST-OK | kraken | took 58646ms 22:16:01 INFO - SUITE-END | took 1170s 22:16:01 INFO - Completed test suite (00:19:30) 22:16:01 INFO - Working with test: dromaeo_css 22:16:01 INFO - Generating results file: dromaeo_css 22:16:01 INFO - Working with test: kraken 22:16:01 INFO - Generating results file: kraken 22:16:01 INFO - javascript benchmark 22:16:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:16:02 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:16:02 INFO - process_Request line: dromaeo_css 6770.42 graph.html#tests=[[72,63,35]] 22:16:02 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:16:02 INFO - process_Request line: kraken 1507.20 graph.html#tests=[[232,63,35]] 22:16:02 INFO - RETURN: dromaeo_css: 6770.42 22:16:02 INFO - RETURN: kraken: 1507.20 22:16:02 INFO - javascript benchmark 22:16:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.751779857611, 3141.5287706843956, 3158.3525377297656, 3167.0657156138936, 3172.762042846786, 5045.268436076767, 5110.770015349309, 5145.536901678848, 5153.4846515348445, 5203.8959220815605, 5142.588592912567, 5210.817621383252, 5217.217417387385, 5221.477852214776, 5233.973830130844, 4672.55610716983, 4692.741899195551, 4709.717416954976, 4757.714537127766, 4765.380500534926, 4848.345473361104, 4852.1508735971065, 4862.63530235232, 4879.853604391874, 4903.239997800347, 4625.907481850361, 4660.580547750718, 4684.578387945085, 4703.106409782131, 4746.691465054761, 4757.310190022427, 4758.595519380822, 4765.28520721891, 4787.377640906695, 4811.941372897957, 4729.692569982974, 4750.596199323062, 4760.619150467989, 4769.833055843029, 4776.229786723727, 4998.775055122528, 5004.0, 5093.898122037575, 5115.181570948667, 5147.459516750762, 5529.281193444866, 5539.584531160139, 5542.889142217174, 5545.195946587763, 5545.445455454463, 5548.472895075001, 5558.583106267046, 5563.721813909328, 5565.916511252334, 5572.58205634579, 5215.295935048758, 5251.553617942442, 5268.130758424817, 5296.947030529723, 5323.653962492464, 5718.714064296769, 5748.712564371848, 5749.195112684228, 5749.741261643236, 5757.424257574293, 5359.624826262124, 5439.728013599304, 5540.307461567304, 5544.833654990357, 5559.610827242135, 5534.335879694462, 5578.358488773762, 5579.246801681802, 5591.27313449249, 5618.634788738719, 5548.5838562108, 5550.417206193372, 5557.472040156179, 5561.5272701820795, 5564.026295398289, 5487.176923461433, 5505.394406615269, 5509.173623956439, 5516.475934786189, 5522.420145884625, 4283.357496375568, 4322.827086916488, 4322.913541729148, 4323.286657701444, 4357.934630980538, 3846.0192650873846, 3850.961490385116, 3863.0, 3883.0, 3885.3394922862617, 5062.190049592121, 5096.872578185501, 5099.209622508517, 5134.589232861437, 5147.022065807485, 5517.531009864207, 5563.304586926634, 5592.105263157875, 5603.719814009283, 5642.294713160855, 5165.767540460688, 5209.6874187548865, 5210.869728256824, 5219.556337711261, 5261.631685782035, 4686.27362758773, 4699.882502937454, 4780.856574302777, 4823.083614113307, 4839.008003359303, 5700.0, 5708.143778433268, 5720.513756330759, 5721.799737009184, 5730.455606717355, 5527.2538207341495, 5527.8894422110525, 5528.281323427928, 5533.253010843485, 5541.362743284574, 5676.091825307931, 5676.545876329801, 5725.914111288417, 5755.65466072037, 5773.278340207474, 5448.264484294569, 5448.918266226089, 5455.809046683347, 5456.181572764117, 5470.042742519963, 5470.480304371078, 5509.146082357241, 5514.310711161105, 5516.613837031369, 5576.219329293821, 5355.4376790436445, 5397.298351214317, 5407.0, 5410.21551874968, 5471.781128754806, 5438.293021907127, 5452.672839629635, 5456.645318054314, 5458.317710286215, 5461.9453805461435, 5310.123829568232, 5342.465753424626, 5343.519083282523, 5347.51872331492, 5392.272043274108, 5411.269478620336, 5452.291202143696, 5489.231507588861, 5514.531264842533, 5548.861278467909, 5251.606129540223, 5287.10119279731, 5327.547158491571, 5338.145896656516, 5373.247745315581], "unit": "score", "name": "dojo.html", "value": 5129.40162431435}, {"lowerIsBetter": false, "replicates": [520.1209955175752, 529.4678847758003, 541.4342012596836, 546.1098409592364, 550.9035918714226, 28051.719482805165, 28813.711862881366, 35480.2903941921, 35822.46266306001, 36206.0, 38596.61403385965, 38666.226675466474, 38758.806205969, 38809.80595097028, 38859.222815543675, 8327.20891515305, 8501.06488286288, 8515.23362897339, 8518.27594654455, 8520.19058189471, 8363.456375335614, 8552.35857310701, 8552.828943421127, 8553.40126191167, 8555.10171432, 8430.283425908805, 8564.657413703444, 8565.614547345385, 8566.871496927552, 8574.742757717248, 8470.534120623362, 8549.273311768507, 8554.18735220153, 8568.443051201652, 8572.571371431466, 8436.36727245459, 8549.615267312985, 8603.741887743377, 8605.010423801217, 8628.22345988864, 37831.432528512094, 38022.23955520874, 38122.23755524874, 38137.0, 38141.427878581846, 3045.0408121441897, 3301.059198128522, 3406.9488957665408, 3560.305740380627, 3565.53648025755, 29086.27284317888, 29394.70605293941, 29914.102576922727, 29961.70038299611, 30544.847275763703, 3648.945265821015, 3653.1232504199065, 3655.981720091409, 3686.2627474505207, 3765.3787125124322, 261755.0, 262272.9999999981, 262845.0, 263920.0, 265036.0, 50920.490795092315, 52142.73928630409, 56259.71870140623, 56451.0, 56671.0, 60518.0, 61226.0, 61384.38615613876, 61694.69152654208, 61764.69117654383, 15420.92289538545, 15622.843771562366, 15637.452689156053, 15642.45251416195, 15645.139517326428, 10855.294405863751, 10900.40047797363, 11821.113416493625, 11944.701382465508, 11991.340476273714, 18197.7270340945, 18404.539886502946, 18579.0, 18667.90666046661, 18698.34555790541, 6966.3730264276455, 7139.785806425815, 7142.678579463936, 7176.92823071773, 7370.926290737131, 940.1209868772719, 1030.2633616963906, 1043.2175868098925, 1061.8088744025995, 1093.578972095749, 24136.155234566704, 24367.878160609438, 24404.877975610365, 24489.387765305655, 24490.265292041266, 984.640606178754, 995.7411073120896, 1000.8899021107673, 1017.6896046705825, 1042.280826229914, 12489.437975291134, 12875.098743088081, 12950.805737913939, 14824.184669843262, 15161.841556222183, 313880.0, 319324.0, 319474.0, 319507.0, 319561.0, 50811.49188508068, 50829.0, 50890.236646450336, 51158.48841511612, 51310.48689513132, 1140.298716289476, 1218.65268398506, 1240.8262843201958, 1296.786030304989, 1308.4308325878274, 24913.252602421955, 26674.466510670067, 26819.86590067037, 26848.59727104056, 26967.190984269717, 46401.76799115983, 49164.262536062706, 49271.0, 49292.0, 49343.25985110298, 285002.0, 289377.0, 290262.0, 295114.0, 295497.0, 28785.424291513635, 28916.0, 28939.0, 28991.42017159687, 29008.709912901446, 39332.0, 39857.0, 40062.1987560253, 40099.599004009586, 40683.3897491532, 35002.824985874904, 35285.29429411346, 35725.89152247525, 35900.281994359444, 36743.81628091842, 35365.29269414546, 35989.46015809713, 36141.84368797517, 36181.638183617826, 36198.45702314415, 34498.31003379868, 35504.64495355013, 35587.0, 35588.28823423465, 35594.28811423809, 30102.698973010865, 32350.514742278414, 32622.0, 33012.50481242735, 33217.501737473474, 24524.0, 25102.748972510042, 25259.115930942327, 25426.491470170862, 25725.485490289717], "unit": "score", "name": "ext.html", "value": 17794.44692213565}, {"lowerIsBetter": false, "replicates": [356.5792365009289, 357.51526888127506, 360.796150175151, 360.98917032489004, 361.2486029059556, 13437.596872093853, 13865.792013119812, 15904.20478976051, 16510.83489165108, 16976.811623186382, 14176.787348189786, 15097.924510377461, 15562.144082075481, 15678.137702426362, 15737.291821868015, 5299.708516031607, 5464.016477034133, 5465.180222966547, 5467.17992301154, 5468.234447177399, 4013.337799263118, 4155.62599366057, 5383.784648614051, 5405.4324295948945, 5712.914306285388, 5897.557683173758, 5901.734421951022, 5909.290885093795, 5916.171735956969, 5918.0, 6203.069539569078, 6314.368563143695, 6357.968210158966, 6360.236771587439, 6363.777267795628, 6025.066114752177, 6059.242594675666, 6062.878742425127, 6210.068489726532, 6220.377962203744, 21075.78924210769, 21365.67951480729, 21454.785452145436, 21641.0, 21888.12447502098, 2293.289080385086, 2343.0737545891325, 2442.438239204993, 2569.717331093578, 2798.6501687289087, 12018.879811201863, 13007.479700811957, 13154.60536183916, 13767.655808604764, 13969.092009019381, 1951.5023668964322, 1952.541152829084, 1955.4817973237105, 1961.3331467301186, 1986.2849374225268, 60416.0, 61460.69269653668, 62904.0, 63896.68051659758, 65859.3414065858, 14887.925560372345, 15156.24218789056, 15432.614184645248, 15475.767863482057, 15499.690006200039, 22874.656880146813, 22918.770812291998, 23119.0, 23220.419489512897, 23242.418939526648, 6879.5184337095925, 7140.678669459887, 7250.492465527468, 7276.854462910712, 9192.126747958933, 6723.125993620798, 6764.188297404245, 6768.289329620417, 6818.386345228953, 6878.828029299208, 4369.541198174146, 4441.644668426518, 4447.533009034005, 4454.10917816438, 4507.0, 1688.0968681755448, 1700.0874016731177, 1738.313366220361, 1738.4871462918215, 1822.3803906671794, 889.9866502002475, 907.9591418386188, 915.7115508614766, 1017.9389236645825, 1035.5805898611075, 13471.865281347062, 15156.166410847289, 15432.38270469191, 15660.451884183998, 15757.715131305897, 885.6457417033238, 887.2547060469237, 888.3071204460531, 936.0592604432502, 960.3325688646323, 8698.826023479622, 9176.265898728087, 9195.862062069074, 9315.161635452707, 9324.627014919328, 366863.0, 372438.0, 378606.0, 379402.0, 411035.0, 71147.0, 72379.0, 72944.2705572948, 73444.0, 73716.0, 1015.7257540464034, 1040.245821779204, 1080.6703955293553, 1096.9122470202365, 1137.4995002199005, 13880.097793643381, 13938.930305348815, 14401.351939162554, 14637.0, 14880.181590012653, 29933.700662993964, 30369.69630303757, 30554.694453056076, 31376.843115784275, 32321.676783231866, 42050.1589968205, 42204.155916882104, 42483.78758106189, 42524.149517010104, 42681.78659106685, 7044.718211271492, 7173.820654483471, 7211.567305961449, 7217.314355136254, 7250.274972502708, 8522.872156917776, 10647.733806654896, 10686.57253709874, 10910.345379277269, 11242.66272011841, 9099.0, 9204.735389818972, 9234.584443700183, 9318.627254909728, 9588.472634005197, 9330.206932410549, 9586.424814511152, 9660.565274562521, 10091.091801737879, 10121.949390253001, 9019.233365163773, 9051.230645395215, 9065.138811812867, 9233.261339092991, 9469.431834089977, 6791.796246112624, 6951.339622735832, 7041.647917603997, 7240.384567311838, 7356.77929662111, 8338.416310858182, 9210.0, 9276.536173191449, 9316.627334906529, 9367.85948210791], "unit": "score", "name": "jquery.html", "value": 8375.286180179453}, {"lowerIsBetter": false, "replicates": [1336.7675981111543, 1396.427464739457, 1402.9368678409471, 1532.9233538323087, 1750.728637061255, 6726.26011138775, 7274.090738657668, 7396.223396543366, 7438.367738742207, 7442.739504117357, 7560.96219518903, 7749.612519374037, 7750.457467977244, 7752.844943101135, 7761.41789365797, 1992.870463419873, 2036.419620408184, 2234.519578290667, 2272.534130503247, 2298.0577963035157, 2238.6642003699494, 2240.7311122665224, 2241.7758224177533, 2243.8541494802867, 2244.9438764030947, 2209.5249521352907, 2290.633498640218, 2292.3925159832656, 2293.9770602294016, 2294.506681063571, 2230.241717815942, 2234.296196698043, 2257.7064981552376, 2288.233441797, 2303.9539209215723, 2241.3388050525136, 2248.415411992877, 2259.35608351619, 2260.062074239189, 2292.954140917189, 7845.803854903616, 7915.762527124196, 7922.0, 7926.167752385974, 7942.801429964239, 4712.64655150865, 4798.616110711169, 4827.517248275144, 4829.975850120762, 4836.274558816206, 2899.797014209006, 2936.6476022877177, 2977.4640564698348, 2978.27032377069, 3009.6839831817565, 903.2548147778109, 906.7823722306599, 911.4258017449031, 927.2813569483636, 941.482184798365, 10964.780704385868, 10984.0, 10997.725056873562, 11002.889971100267, 11030.50362733671, 4205.36919462077, 4208.7685177314925, 4257.74453532789, 4270.0605866709275, 4272.551382104896, 9437.386569872937, 9446.149846513847, 9458.763530911645, 9461.621535138655, 9470.100340467645, 4712.410948631421, 4736.976315118402, 4765.666403351732, 4765.9523404766205, 4767.308740232646, 4312.37470566766, 4336.111097225062, 4339.262325404688, 4340.565943405634, 4348.543402942709, 3363.024722830352, 3417.0773891049275, 3627.655372739638, 3674.9081272968388, 3725.5529336479794, 1187.5784096645739, 1213.4963989944074, 1216.3614102596207, 1225.2587184753274, 1229.5266322465736, 1017.9592816287413, 1025.2464438637596, 1050.0706874416196, 1052.3422860712055, 1057.5875408590655, 7247.456440766858, 7283.198848126702, 7318.0, 7326.377257933029, 7361.852762944711, 1083.2958576924905, 1105.4251789069638, 1112.844201811747, 1113.7716768062528, 1155.7052951497315, 5757.366689664133, 5850.619709718854, 5852.034414321589, 5854.882902342015, 5862.70686465675, 9254.86117708235, 9721.756956076013, 9830.0, 9837.458939758382, 9839.458829764288, 9491.572879220452, 9495.857562136573, 9500.097490738368, 9631.229501639851, 9632.711018669452, 7247.746328878569, 7423.331900129015, 7473.103227612722, 7483.738069167553, 7520.699172033057, 7089.539179953286, 7107.75122870697, 7144.3927266182955, 7168.820779480555, 7169.569825810259, 8455.11221321777, 8459.323254139777, 8675.089115642766, 8703.173198546128, 8725.171108744658, 8506.659733610586, 8776.210141087333, 8787.121287871418, 8879.156480134377, 8914.0, 6983.6857341418745, 6998.090248267693, 7017.789466316019, 7037.612931288623, 7058.400035996792, 6608.306127856698, 6797.048413222054, 7183.856322873408, 7326.3406293433845, 7333.0, 6936.132983377078, 6984.196817366068, 6984.2317345093015, 7104.218535960937, 7121.572705637678, 6895.931040689529, 6953.548019378724, 6989.091418115816, 7024.964875175591, 7035.577865328097, 6852.211995620568, 6894.827629309107, 6942.930570694229, 6953.617551034539, 6971.163460384786, 6443.903341449788, 6506.772262970773, 6515.185601799775, 6515.804525864231, 6515.934840651533, 6311.2426508819235, 6467.773627923, 6472.579282346633, 6478.5141114415665, 6483.643399613066], "unit": "score", "name": "mootools.html", "value": 4464.383141822053}, {"lowerIsBetter": false, "replicates": [334.93468773589154, 344.6708393484223, 345.3593583901863, 354.3975242088447, 360.8628721085987, 5583.246261754662, 5722.7424765885535, 5732.426757324265, 5741.224934633823, 5752.712364381775, 5537.501624853762, 5596.552275817935, 5610.24261724667, 5638.351589567191, 5643.8024669136585, 4425.645948324142, 4429.313456414261, 4439.890027493127, 4443.711158774686, 4446.933296000562, 4280.229558679436, 4330.328799036154, 4409.206342858284, 4459.754713490756, 4465.24090904547, 4413.337999300099, 4431.756253406062, 4443.46678398591, 4444.866654000385, 4459.241928872099, 4449.777511124431, 4452.354408610733, 4456.420665313504, 4459.888502787457, 4470.687051906368, 3924.9018774530578, 3924.9607503925167, 3927.960720392788, 3929.8035098244973, 3933.940990885139, 5299.251247088451, 5425.755840987165, 5426.2674538937135, 5440.238366628675, 5447.428020057877, 5141.5886729061585, 5145.794168233266, 5147.305113809625, 5148.0, 5158.793648254065, 6031.065184896348, 6033.306169790487, 6035.185249991239, 6036.5170786336985, 6048.304444988838, 4340.08858139791, 4341.479022517318, 4351.0862718829085, 4351.238533256699, 4357.106793107406, 5833.066709326487, 5955.851103722398, 6213.937860621381, 6329.588576742497, 6333.80998570039, 4383.5835595619, 4384.978075109604, 4389.517153113155, 4391.231534481453, 4395.53846846083, 4448.5551444855255, 4452.732836029849, 4454.443194600675, 4459.0413061192, 4460.330950357472, 5108.693478391308, 5110.2590124431745, 5114.667546609458, 5115.897682046412, 5124.666896651705, 5985.25184351956, 6097.847553811191, 6098.634081955097, 6098.908516372258, 6103.755849766048, 1578.9605259868365, 1600.9199540022953, 1601.8237993820671, 1601.9359225631076, 1602.2389365051508, 1096.0354887698775, 1103.773726386089, 1112.6884472347756, 1127.9548818047351, 1135.926164799302, 5761.596688231867, 5774.960507108677, 5781.624194427349, 5781.94218057814, 5782.2483077199695, 6047.758089676452, 6186.4741496973265, 6256.280527739277, 6256.468200203034, 6262.279837818709, 5645.125005624135, 5787.797427090116, 5803.564732645069, 5833.183354330397, 5833.241678581842, 3354.4297469430257, 3389.508521264452, 3391.9824052784065, 3392.9830350848583, 3395.3888300105723, 6422.0, 6576.868462630816, 6595.340465953366, 6596.901046484307, 6603.240627327823, 6449.0, 6451.967740161363, 6452.548321617535, 6454.677266136769, 6462.515311351667, 6591.901121483182, 6592.373724496165, 6593.274739778716, 6599.241087274929, 6602.438792702674, 6192.2569291683485, 6300.968495157678, 6305.211848518935, 6317.4630156437215, 6318.052292156213, 6243.875122497616, 6254.8123556293385, 6257.812265632038, 6261.217347831521, 6262.592931459622, 6576.2766095728475, 6581.736730530916, 6586.571872828251, 6587.47300215972, 6593.934060659524, 4512.503624601226, 4512.729236245836, 4516.774161291856, 4517.570830771071, 4522.276435770261, 6206.038064100072, 6276.9372306276355, 6316.084167795736, 6317.336679648571, 6329.177206963065, 6090.360512146338, 6118.785842495491, 6119.694015299128, 6156.29202641702, 6186.969065154645, 6149.7847575334645, 6154.1999540059505, 6155.938440615716, 6158.938410616016, 6161.075838624063, 5947.1079338099635, 6015.72929218195, 6043.184170136975, 6049.485793707584, 6053.727582258721, 6180.381961803783, 6220.688965551613, 6224.066390041349, 6225.097360882556, 6225.346338634378, 6049.576529642883, 6051.425114614105, 6055.939440605714, 6063.363346848518, 6064.423879731418], "unit": "score", "name": "prototype.html", "value": 4642.963707261593}, {"lowerIsBetter": false, "replicates": [654.9869002619951, 662.4501663619196, 687.6286805125233, 765.3800421658457, 788.2826627768729, 13663.590092297234, 13719.862801371983, 13781.58655240342, 13783.448662053532, 13787.586372408843, 12463.065270104757, 12908.483660653586, 12921.612351629467, 12930.0, 13024.34878256088, 756.4780301591898, 768.9730859419893, 768.9846203075936, 769.4037121231063, 769.4114002787871, 643.6331291164039, 650.5966300893452, 757.3146302596159, 758.8444368904361, 761.2539711083142, 803.3894240377297, 804.1154729797234, 805.6012273924416, 813.9470934389275, 814.1004190369645, 673.7002034094829, 807.2532907060975, 811.2739098506833, 811.6469335838899, 812.212154210415, 505.2244804225496, 592.1709606550863, 601.1523751510393, 601.1703848688825, 602.9638221706712, 12668.493260269579, 12762.23426594398, 12791.296478693668, 12793.424295906707, 12794.808077878839, 11884.227525210834, 11910.523579056828, 12131.454084566216, 12649.873501264961, 12703.872961270454, 10161.796764064751, 10347.5343609537, 10402.47987600617, 10535.73660658482, 10589.364638121737, 3486.6687664671817, 3500.282442099389, 3508.736844736655, 3510.3154884797473, 3619.7828130312264, 44851.0, 45151.54848451539, 45225.0, 45274.54725452769, 45928.999999999665, 9866.210703143732, 9986.35088719231, 10010.399376037461, 10032.79934401308, 10102.646407375854, 17185.656286874444, 17201.31194752221, 17228.741568876478, 17246.568835779206, 17282.913585431994, 7372.152202496674, 7543.47195696307, 7631.3513351364645, 7792.727254546064, 7858.0570331560575, 4304.418903447994, 4410.140022695544, 4422.469303683579, 4462.3752674625575, 4473.597376236155, 3132.530120481946, 3139.3564319314487, 3152.6059242594674, 3180.220845892725, 3184.1084496341064, 543.1011675676762, 552.5938435250088, 554.8196836028307, 563.4196777319368, 565.5871214013711, 586.694604504973, 593.4391999560374, 599.3227652752449, 601.9414592130196, 629.3894921925724, 8210.630521626541, 8296.502209867427, 8616.310695144373, 8955.2835773138, 9168.404053736485, 563.0203446004006, 589.6992533807789, 614.8217017065001, 662.3596810787637, 689.5483458334799, 3815.3132436161204, 3993.6405723485027, 4182.811773470201, 4225.281752058169, 4316.762578058237, 53722.73138634282, 54176.45823541793, 54361.72819135879, 54628.0, 54675.453245467834, 45972.770136149775, 47573.28640070402, 47603.285950710764, 48287.0, 48344.51655483471, 41488.79255603703, 42175.0, 42532.36201456981, 42581.36127958083, 42588.57411425908, 8261.586920654063, 8534.274586660204, 8672.52301123419, 8736.606852691772, 8790.824183516166, 34315.82842085774, 34438.31123377568, 34878.65121348754, 35376.0, 35478.0, 40185.598144018186, 40471.392929105496, 43635.56364436442, 43755.0, 43878.0, 10650.57397704083, 10791.02880740737, 10796.028357447867, 11065.280756750786, 11187.496562654538, 11388.430578471209, 11887.465064071965, 11918.344491053076, 11970.46132924038, 12149.81775273354, 10609.8939010612, 10918.07196388316, 10935.0, 11041.779164416826, 11245.831312530483, 9605.423674579548, 9779.902200977898, 10349.534270957674, 10840.620578280037, 10960.0, 7830.530168189927, 10314.278000540191, 10541.31481453703, 10553.841692374774, 10809.027187553158, 8536.530490823065, 9049.954750226207, 9810.75473113178, 10057.515547093628, 10118.49407529606, 9136.588853501742, 9141.268698504236, 9445.178992156596, 9635.373700709431, 9636.951815240878], "unit": "score", "name": "yui.html", "value": 6077.818358571786}], "name": "dromaeo_css", "value": 6770.419925031818}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 112.0, 111.0, 110.0, 100.0, 110.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 149.0, 164.0, 127.0, 151.0, 160.0, 127.0, 162.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 162.0, 162.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 102.0, 93.0, 73.0, 72.0, 76.0, 113.0, 95.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 96.0, 95.0, 96.0, 144.0, 96.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 54.0, 54.0, 55.0, 53.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 83.0, 83.0, 81.0, 83.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [120.0, 135.0, 117.0, 116.0, 123.0, 116.0, 115.0, 119.0, 114.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [157.0, 138.0, 148.0, 149.0, 142.0, 143.0, 141.0, 147.0, 145.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1507.1999999999998}]} 22:16:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1507.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6770.42"}}} 22:16:02 INFO - Return code: 0 22:16:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:16:02 INFO - # TBPL SUCCESS # 22:16:02 INFO - Running post-action listener: _resource_record_post_action 22:16:02 INFO - Running post-run listener: _resource_record_post_run 22:16:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 535490560; Read time: 0; Write time: 536708 22:16:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249405440; Read time: 0; Write time: 289560 22:16:03 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 285487104; Read time: 0; Write time: 246208 22:16:03 INFO - Running post-run listener: _upload_blobber_files 22:16:03 INFO - Blob upload gear active. 22:16:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:16:03 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:16:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:16:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:16:03 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:16:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:04 INFO - (blobuploader) - INFO - Done attempting. 22:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:05 INFO - (blobuploader) - INFO - Done attempting. 22:16:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:05 INFO - Return code: 0 22:16:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:16:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd4a7ea93b5cd0f6671be69ba8571546b65fdf07ecfb77e9d477836ba09b4fae9c6a90c1b32b4eac98bd6f838b1054ecd7a81a8a4e193eb610ca6a893fd623f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7ef7d95c53d2d5d919e359116949bdb1b0f2cd563f2cf902b36439b0b9a8400ff51dd9ec1248569978fe7bf2edd76c592a2d537ace6db88683d6e411eb0057e"} 22:16:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:16:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:16:05 INFO - Contents: 22:16:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd4a7ea93b5cd0f6671be69ba8571546b65fdf07ecfb77e9d477836ba09b4fae9c6a90c1b32b4eac98bd6f838b1054ecd7a81a8a4e193eb610ca6a893fd623f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7ef7d95c53d2d5d919e359116949bdb1b0f2cd563f2cf902b36439b0b9a8400ff51dd9ec1248569978fe7bf2edd76c592a2d537ace6db88683d6e411eb0057e"} 22:16:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:05 INFO - Copying logs to upload dir... 22:16:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:16:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.195253 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-01-29 22:16:04.900538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 22:16:04.903915) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd4a7ea93b5cd0f6671be69ba8571546b65fdf07ecfb77e9d477836ba09b4fae9c6a90c1b32b4eac98bd6f838b1054ecd7a81a8a4e193eb610ca6a893fd623f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7ef7d95c53d2d5d919e359116949bdb1b0f2cd563f2cf902b36439b0b9a8400ff51dd9ec1248569978fe7bf2edd76c592a2d537ace6db88683d6e411eb0057e"} build_url:https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/DHk6NRS_SyuWjHko26qYww/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bd4a7ea93b5cd0f6671be69ba8571546b65fdf07ecfb77e9d477836ba09b4fae9c6a90c1b32b4eac98bd6f838b1054ecd7a81a8a4e193eb610ca6a893fd623f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7ef7d95c53d2d5d919e359116949bdb1b0f2cd563f2cf902b36439b0b9a8400ff51dd9ec1248569978fe7bf2edd76c592a2d537ace6db88683d6e411eb0057e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 22:16:04.929583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 22:16:04.929958) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1454117795.274233-1489968385 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 22:16:05.015031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 22:16:05.015417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 22:16:05.015797) ========= ========= Total master_lag: 0.32 =========