builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1458173116.37 results: success (0) buildid: 20160316144441 builduid: 40d3df7e66054a0bb6f341c80db31e1f revision: 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.370352) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.370726) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.371010) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006376 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.396272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.396537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.412416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.412680) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.460931) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.461208) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.461526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.461811) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-16 17:05:16-- 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% 29.6M=0s 2016-03-16 17:05:16 (29.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089676 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.661663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.661945) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016671 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.693483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:16.693800) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 --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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-16 17:05:16,950 truncating revision to first 12 chars 2016-03-16 17:05:16,950 Setting DEBUG logging. 2016-03-16 17:05:16,950 attempt 1/10 2016-03-16 17:05:16,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/831b9b1f8df2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:05:17,351 unpacking tar archive at: mozilla-aurora-831b9b1f8df2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.717826 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:17.424130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:17.424474) ========= echo 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4'] 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 program finished with exit code 0 elapsedTime=0.004263 script_repo_revision: '831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:17.474115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:17.474431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 17:05:17.484080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 17:05:17.484362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:05:17 INFO - MultiFileLogger online at 20160316 17:05:17 in /builds/slave/test-pgo 17:05:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:05:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:05:17 INFO - {'append_to_log': False, 17:05:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:05:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:05:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:05:17 INFO - 'branch': 'Mozilla-Aurora', 17:05:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:17 INFO - 'config_files': ('talos/linux_config.py',), 17:05:17 INFO - 'default_actions': ('clobber', 17:05:17 INFO - 'read-buildbot-config', 17:05:17 INFO - 'download-and-extract', 17:05:17 INFO - 'populate-webroot', 17:05:17 INFO - 'create-virtualenv', 17:05:17 INFO - 'install', 17:05:17 INFO - 'run-tests'), 17:05:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:17 INFO - 'download_minidump_stackwalk': True, 17:05:17 INFO - 'download_symbols': 'ondemand', 17:05:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:17 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:17 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:17 INFO - 'installer_path': 'installer.exe', 17:05:17 INFO - 'log_level': 'info', 17:05:17 INFO - 'log_name': 'talos', 17:05:17 INFO - 'log_to_console': True, 17:05:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:05:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:05:17 INFO - 'opt_config_files': (), 17:05:17 INFO - 'pip_index': False, 17:05:17 INFO - 'sps_profile': False, 17:05:17 INFO - 'sps_profile_interval': 0, 17:05:17 INFO - 'suite': 'dromaeojs', 17:05:17 INFO - 'system_bits': '32', 17:05:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:17 INFO - 'title': 'talos-linux64-ix-062', 17:05:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:17 INFO - 'use_talos_json': True, 17:05:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:05:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:17 INFO - 'work_dir': 'build'} 17:05:17 INFO - ##### 17:05:17 INFO - ##### Running clobber step. 17:05:17 INFO - ##### 17:05:17 INFO - Running pre-action listener: _resource_record_pre_action 17:05:17 INFO - Running main action method: clobber 17:05:17 INFO - rmtree: /builds/slave/test-pgo/build 17:05:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:05:18 INFO - Running post-action listener: _resource_record_post_action 17:05:18 INFO - ##### 17:05:18 INFO - ##### Running read-buildbot-config step. 17:05:18 INFO - ##### 17:05:18 INFO - Running pre-action listener: _resource_record_pre_action 17:05:18 INFO - Running main action method: read_buildbot_config 17:05:18 INFO - Using buildbot properties: 17:05:18 INFO - { 17:05:18 INFO - "project": "", 17:05:18 INFO - "product": "firefox", 17:05:18 INFO - "script_repo_revision": "production", 17:05:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:05:18 INFO - "repository": "", 17:05:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:05:18 INFO - "buildid": "20160316144441", 17:05:18 INFO - "pgo_build": "True", 17:05:18 INFO - "basedir": "/builds/slave/test-pgo", 17:05:18 INFO - "buildnumber": 357, 17:05:18 INFO - "slavename": "talos-linux64-ix-062", 17:05:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:05:18 INFO - "platform": "ubuntu64_hw", 17:05:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:05:18 INFO - "branch": "mozilla-aurora", 17:05:18 INFO - "repo_path": "releases/mozilla-aurora", 17:05:18 INFO - "revision": "831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4", 17:05:18 INFO - "stage_platform": "linux64-pgo", 17:05:18 INFO - "builduid": "40d3df7e66054a0bb6f341c80db31e1f", 17:05:18 INFO - "slavebuilddir": "test" 17:05:18 INFO - } 17:05:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 17:05:18 INFO - Running post-action listener: _resource_record_post_action 17:05:18 INFO - ##### 17:05:18 INFO - ##### Running download-and-extract step. 17:05:18 INFO - ##### 17:05:18 INFO - Running pre-action listener: _resource_record_pre_action 17:05:18 INFO - Running main action method: download_and_extract 17:05:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:05:18 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')]} 17:05:18 INFO - https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:05:20 INFO - Downloaded 1448 bytes. 17:05:20 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 17:05:20 INFO - Using the following test package requirements: 17:05:20 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:05:20 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:05:20 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:05:20 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'jsshell-linux-x86_64.zip'], 17:05:20 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:05:20 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:05:20 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:05:20 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:05:20 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:05:20 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 17:05:20 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 17:05:20 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:05:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:05:20 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')]} 17:05:20 INFO - https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:05:21 INFO - Downloaded 23308402 bytes. 17:05:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:05:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:05:22 INFO - Return code: 0 17:05:22 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:22 INFO - https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:05:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 17:05:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:05:29 INFO - Downloaded 23308402 bytes. 17:05:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:05:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:05:30 INFO - Return code: 0 17:05: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')]} 17:05:30 INFO - https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 17:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:05:31 INFO - Downloaded 10845161 bytes. 17:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:05:31 INFO - Return code: 0 17:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:31 INFO - https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:05:34 INFO - Downloaded 60438758 bytes. 17:05:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:05:34 INFO - mkdir: /builds/slave/test-pgo/properties 17:05:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:05:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:05:34 INFO - Contents: 17:05:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 17:05:34 INFO - Running post-action listener: _resource_record_post_action 17:05:34 INFO - Running post-action listener: set_extra_try_arguments 17:05:34 INFO - ##### 17:05:34 INFO - ##### Running populate-webroot step. 17:05:34 INFO - ##### 17:05:34 INFO - Running pre-action listener: _resource_record_pre_action 17:05:34 INFO - Running main action method: populate_webroot 17:05:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:05:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:05:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:05:34 INFO - '--tppagecycles', 17:05:34 INFO - '7'], 17:05:34 INFO - 'tests': ['tsvgm']}}, 17:05:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:05:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:05:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:05:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:05:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:05:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:05:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'tests': ['damp', 'tps']}, 17:05:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['damp', 'tps']}, 17:05:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:05:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:05:34 INFO - 'other': {'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'other_l64': {'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'other_nol64': {'tests': ['a11yr', 17:05:34 INFO - 'ts_paint', 17:05:34 INFO - 'tpaint', 17:05:34 INFO - 'sessionrestore', 17:05:34 INFO - 'sessionrestore_no_auto_restore', 17:05:34 INFO - 'tabpaint']}, 17:05:34 INFO - 'svgr': {'tests': ['tsvgx', 17:05:34 INFO - 'tsvgr_opacity', 17:05:34 INFO - 'tart', 17:05:34 INFO - 'tscrollx', 17:05:34 INFO - 'cart']}, 17:05:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['tsvgx', 17:05:34 INFO - 'tsvgr_opacity', 17:05:34 INFO - 'tart', 17:05:34 INFO - 'tscrollx', 17:05:34 INFO - 'cart']}, 17:05:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'tests': ['tp5o']}, 17:05:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'talos_options': ['--e10s'], 17:05:34 INFO - 'tests': ['tp5o']}, 17:05:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'talos_options': ['--xperf_path', 17:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:05:34 INFO - 'tests': ['tp5n']}, 17:05:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:05:34 INFO - 'talos_options': ['--e10s', 17:05:34 INFO - '--xperf_path', 17:05:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:05:34 INFO - 'tests': ['tp5n']}}, 17:05:34 INFO - 'talos.zip': {'path': '', 17:05:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:05:34 INFO - Running post-action listener: _resource_record_post_action 17:05:34 INFO - ##### 17:05:34 INFO - ##### Running create-virtualenv step. 17:05:34 INFO - ##### 17:05:34 INFO - Running pre-action listener: _resource_record_pre_action 17:05:34 INFO - Running main action method: create_virtualenv 17:05:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:05:34 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 17:05:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:05:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:05:34 INFO - Using real prefix '/usr' 17:05:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:05:35 INFO - Installing distribute.............................................................................................................................................................................................done. 17:05:37 INFO - Installing pip.................done. 17:05:37 INFO - Return code: 0 17:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:05:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:05:37 INFO - Using env: {'DISPLAY': ':0', 17:05:37 INFO - 'HOME': '/home/cltbld', 17:05:37 INFO - 'LANG': 'en_US.UTF-8', 17:05:37 INFO - 'LANGUAGE': 'en_US:en', 17:05:37 INFO - 'LOGNAME': 'cltbld', 17:05:37 INFO - 'MAIL': '/var/mail/cltbld', 17:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:37 INFO - 'MOZ_NO_REMOTE': '1', 17:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:37 INFO - 'NO_EM_RESTART': '1', 17:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:37 INFO - 'SHELL': '/bin/bash', 17:05:37 INFO - 'SHLVL': '1', 17:05:37 INFO - 'TERM': 'linux', 17:05:37 INFO - 'TMOUT': '86400', 17:05:37 INFO - 'USER': 'cltbld', 17:05:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:37 INFO - '_': '/tools/buildbot/bin/python'} 17:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:05:37 INFO - Cleaning up... 17:05:37 INFO - Return code: 0 17:05:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:05:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:05:37 INFO - Using env: {'DISPLAY': ':0', 17:05:37 INFO - 'HOME': '/home/cltbld', 17:05:37 INFO - 'LANG': 'en_US.UTF-8', 17:05:37 INFO - 'LANGUAGE': 'en_US:en', 17:05:37 INFO - 'LOGNAME': 'cltbld', 17:05:37 INFO - 'MAIL': '/var/mail/cltbld', 17:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:37 INFO - 'MOZ_NO_REMOTE': '1', 17:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:37 INFO - 'NO_EM_RESTART': '1', 17:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:37 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:37 INFO - 'SHELL': '/bin/bash', 17:05:37 INFO - 'SHLVL': '1', 17:05:37 INFO - 'TERM': 'linux', 17:05:37 INFO - 'TMOUT': '86400', 17:05:37 INFO - 'USER': 'cltbld', 17:05:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:37 INFO - '_': '/tools/buildbot/bin/python'} 17:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:37 INFO - Downloading/unpacking psutil>=0.7.1 17:05:37 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 17:05:37 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 17:05:37 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 17:05:37 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 17:05:37 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 17:05:37 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 17:05:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:05:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:39 INFO - Installing collected packages: psutil 17:05:39 INFO - Running setup.py install for psutil 17:05:39 INFO - building 'psutil._psutil_linux' extension 17:05:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:05:39 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 17:05:40 INFO - building 'psutil._psutil_posix' extension 17:05:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:05:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:40 INFO - Successfully installed psutil 17:05:40 INFO - Cleaning up... 17:05:40 INFO - Return code: 0 17:05:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:05:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:05:40 INFO - Using env: {'DISPLAY': ':0', 17:05:40 INFO - 'HOME': '/home/cltbld', 17:05:40 INFO - 'LANG': 'en_US.UTF-8', 17:05:40 INFO - 'LANGUAGE': 'en_US:en', 17:05:40 INFO - 'LOGNAME': 'cltbld', 17:05:40 INFO - 'MAIL': '/var/mail/cltbld', 17:05:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:40 INFO - 'MOZ_NO_REMOTE': '1', 17:05:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:40 INFO - 'NO_EM_RESTART': '1', 17:05:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:40 INFO - 'SHELL': '/bin/bash', 17:05:40 INFO - 'SHLVL': '1', 17:05:40 INFO - 'TERM': 'linux', 17:05:40 INFO - 'TMOUT': '86400', 17:05:40 INFO - 'USER': 'cltbld', 17:05:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:40 INFO - '_': '/tools/buildbot/bin/python'} 17:05:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:05:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:05:42 INFO - Installing collected packages: mozsystemmonitor 17:05:42 INFO - Running setup.py install for mozsystemmonitor 17:05:42 INFO - Successfully installed mozsystemmonitor 17:05:42 INFO - Cleaning up... 17:05:42 INFO - Return code: 0 17:05:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:05: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')]} 17:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:05:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:05:42 INFO - Using env: {'DISPLAY': ':0', 17:05:42 INFO - 'HOME': '/home/cltbld', 17:05:42 INFO - 'LANG': 'en_US.UTF-8', 17:05:42 INFO - 'LANGUAGE': 'en_US:en', 17:05:42 INFO - 'LOGNAME': 'cltbld', 17:05:42 INFO - 'MAIL': '/var/mail/cltbld', 17:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:42 INFO - 'MOZ_NO_REMOTE': '1', 17:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:42 INFO - 'NO_EM_RESTART': '1', 17:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:42 INFO - 'SHELL': '/bin/bash', 17:05:42 INFO - 'SHLVL': '1', 17:05:42 INFO - 'TERM': 'linux', 17:05:42 INFO - 'TMOUT': '86400', 17:05:42 INFO - 'USER': 'cltbld', 17:05:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:42 INFO - '_': '/tools/buildbot/bin/python'} 17:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:44 INFO - Downloading blobuploader-1.2.4.tar.gz 17:05:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:05:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:05:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:45 INFO - Downloading docopt-0.6.1.tar.gz 17:05:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:05:45 INFO - Installing collected packages: blobuploader, requests, docopt 17:05:45 INFO - Running setup.py install for blobuploader 17:05:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:05:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:05:45 INFO - Running setup.py install for requests 17:05:45 INFO - Running setup.py install for docopt 17:05:45 INFO - Successfully installed blobuploader requests docopt 17:05:45 INFO - Cleaning up... 17:05:45 INFO - Return code: 0 17:05:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:05: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')]} 17:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:05:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:45 INFO - Using env: {'DISPLAY': ':0', 17:05:45 INFO - 'HOME': '/home/cltbld', 17:05:45 INFO - 'LANG': 'en_US.UTF-8', 17:05:45 INFO - 'LANGUAGE': 'en_US:en', 17:05:45 INFO - 'LOGNAME': 'cltbld', 17:05:45 INFO - 'MAIL': '/var/mail/cltbld', 17:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:45 INFO - 'MOZ_NO_REMOTE': '1', 17:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:45 INFO - 'NO_EM_RESTART': '1', 17:05:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:45 INFO - 'SHELL': '/bin/bash', 17:05:45 INFO - 'SHLVL': '1', 17:05:45 INFO - 'TERM': 'linux', 17:05:45 INFO - 'TMOUT': '86400', 17:05:45 INFO - 'USER': 'cltbld', 17:05:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:45 INFO - '_': '/tools/buildbot/bin/python'} 17:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:46 INFO - Running setup.py (path:/tmp/pip-wC5L5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:46 INFO - Running setup.py (path:/tmp/pip-ixl9ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:46 INFO - Running setup.py (path:/tmp/pip-j13WL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:46 INFO - Running setup.py (path:/tmp/pip-3CS_LT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:46 INFO - Running setup.py (path:/tmp/pip-eaY3TU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:46 INFO - Running setup.py (path:/tmp/pip-3zJMIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:46 INFO - Running setup.py (path:/tmp/pip-LCTAb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:46 INFO - Running setup.py (path:/tmp/pip-LDoPao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:46 INFO - Running setup.py (path:/tmp/pip-sY7H3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:46 INFO - Running setup.py (path:/tmp/pip-aK_HNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:46 INFO - Running setup.py (path:/tmp/pip-4GR_Hg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:46 INFO - Running setup.py (path:/tmp/pip-T5sqGx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:47 INFO - Running setup.py (path:/tmp/pip-GjjeBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:47 INFO - Running setup.py (path:/tmp/pip-IYqmsZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:47 INFO - Running setup.py (path:/tmp/pip-srtW20-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:47 INFO - Running setup.py (path:/tmp/pip-kiK6sG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:47 INFO - Running setup.py (path:/tmp/pip-zWPvce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:05:47 INFO - Running setup.py install for manifestparser 17:05:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:05:47 INFO - Running setup.py install for mozcrash 17:05:47 INFO - Running setup.py install for mozdebug 17:05:47 INFO - Running setup.py install for mozdevice 17:05:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:05:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:05:47 INFO - Running setup.py install for mozfile 17:05:47 INFO - Running setup.py install for mozhttpd 17:05:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozinfo 17:05:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozInstall 17:05:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozleak 17:05:48 INFO - Running setup.py install for mozlog 17:05:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for moznetwork 17:05:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozprocess 17:05:48 INFO - Running setup.py install for mozprofile 17:05:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozrunner 17:05:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:05:48 INFO - Running setup.py install for mozscreenshot 17:05:48 INFO - Running setup.py install for moztest 17:05:49 INFO - Running setup.py install for mozversion 17:05:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:05:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:05:49 INFO - Cleaning up... 17:05:49 INFO - Return code: 0 17:05:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:05: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')]} 17:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:05:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:49 INFO - Using env: {'DISPLAY': ':0', 17:05:49 INFO - 'HOME': '/home/cltbld', 17:05:49 INFO - 'LANG': 'en_US.UTF-8', 17:05:49 INFO - 'LANGUAGE': 'en_US:en', 17:05:49 INFO - 'LOGNAME': 'cltbld', 17:05:49 INFO - 'MAIL': '/var/mail/cltbld', 17:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:49 INFO - 'MOZ_NO_REMOTE': '1', 17:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:49 INFO - 'NO_EM_RESTART': '1', 17:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:49 INFO - 'SHELL': '/bin/bash', 17:05:49 INFO - 'SHLVL': '1', 17:05:49 INFO - 'TERM': 'linux', 17:05:49 INFO - 'TMOUT': '86400', 17:05:49 INFO - 'USER': 'cltbld', 17:05:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:49 INFO - '_': '/tools/buildbot/bin/python'} 17:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:49 INFO - Running setup.py (path:/tmp/pip-9qm_ly-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:49 INFO - Running setup.py (path:/tmp/pip-KpjDR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:49 INFO - Running setup.py (path:/tmp/pip-W9Ujdg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:49 INFO - Running setup.py (path:/tmp/pip-YjceX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:49 INFO - Running setup.py (path:/tmp/pip-ABeyRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:49 INFO - Running setup.py (path:/tmp/pip-349I5N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:49 INFO - Running setup.py (path:/tmp/pip-E5m4DB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:49 INFO - Running setup.py (path:/tmp/pip-EhNL9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 17:05:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:49 INFO - Running setup.py (path:/tmp/pip-_XwCyN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:50 INFO - Running setup.py (path:/tmp/pip-hfZTLw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:50 INFO - Running setup.py (path:/tmp/pip-RR_eyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:50 INFO - Running setup.py (path:/tmp/pip-hPsugZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:50 INFO - Running setup.py (path:/tmp/pip-Z_zPPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:50 INFO - Running setup.py (path:/tmp/pip-GVleP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:50 INFO - Running setup.py (path:/tmp/pip-JlIEhR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:50 INFO - Running setup.py (path:/tmp/pip-nMAa9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 17:05:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:50 INFO - Running setup.py (path:/tmp/pip-mr3Mvr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:05:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:52 INFO - Downloading blessings-1.6.tar.gz 17:05:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:05:52 INFO - Installing collected packages: blessings 17:05:52 INFO - Running setup.py install for blessings 17:05:52 INFO - Successfully installed blessings 17:05:52 INFO - Cleaning up... 17:05:52 INFO - Return code: 0 17:05:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:05:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:05:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:05:52 INFO - Reading from file tmpfile_stdout 17:05:52 INFO - Current package versions: 17:05:52 INFO - argparse == 1.2.1 17:05:52 INFO - blessings == 1.6 17:05:52 INFO - blobuploader == 1.2.4 17:05:52 INFO - docopt == 0.6.1 17:05:52 INFO - manifestparser == 1.1 17:05:52 INFO - mozInstall == 1.12 17:05:52 INFO - mozcrash == 0.17 17:05:52 INFO - mozdebug == 0.1 17:05:52 INFO - mozdevice == 0.48 17:05:52 INFO - mozfile == 1.2 17:05:52 INFO - mozhttpd == 0.7 17:05:52 INFO - mozinfo == 0.9 17:05:52 INFO - mozleak == 0.1 17:05:52 INFO - mozlog == 3.1 17:05:52 INFO - moznetwork == 0.27 17:05:52 INFO - mozprocess == 0.22 17:05:52 INFO - mozprofile == 0.28 17:05:52 INFO - mozrunner == 6.11 17:05:52 INFO - mozscreenshot == 0.1 17:05:52 INFO - mozsystemmonitor == 0.0 17:05:52 INFO - moztest == 0.7 17:05:52 INFO - mozversion == 1.4 17:05:52 INFO - psutil == 3.1.1 17:05:52 INFO - requests == 1.2.3 17:05:52 INFO - wsgiref == 0.1.2 17:05:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:05:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:52 INFO - Using env: {'DISPLAY': ':0', 17:05:52 INFO - 'HOME': '/home/cltbld', 17:05:52 INFO - 'LANG': 'en_US.UTF-8', 17:05:52 INFO - 'LANGUAGE': 'en_US:en', 17:05:52 INFO - 'LOGNAME': 'cltbld', 17:05:52 INFO - 'MAIL': '/var/mail/cltbld', 17:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:52 INFO - 'MOZ_NO_REMOTE': '1', 17:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:52 INFO - 'NO_EM_RESTART': '1', 17:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:52 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:52 INFO - 'SHELL': '/bin/bash', 17:05:52 INFO - 'SHLVL': '1', 17:05:52 INFO - 'TERM': 'linux', 17:05:52 INFO - 'TMOUT': '86400', 17:05:52 INFO - 'USER': 'cltbld', 17:05:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:52 INFO - '_': '/tools/buildbot/bin/python'} 17:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 17:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 17:05:53 INFO - Cleaning up... 17:05:53 INFO - Return code: 0 17:05:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:05: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')]} 17:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:05:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:05:53 INFO - Using env: {'DISPLAY': ':0', 17:05:53 INFO - 'HOME': '/home/cltbld', 17:05:53 INFO - 'LANG': 'en_US.UTF-8', 17:05:53 INFO - 'LANGUAGE': 'en_US:en', 17:05:53 INFO - 'LOGNAME': 'cltbld', 17:05:53 INFO - 'MAIL': '/var/mail/cltbld', 17:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:53 INFO - 'MOZ_NO_REMOTE': '1', 17:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:53 INFO - 'NO_EM_RESTART': '1', 17:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:53 INFO - 'SHELL': '/bin/bash', 17:05:53 INFO - 'SHLVL': '1', 17:05:53 INFO - 'TERM': 'linux', 17:05:53 INFO - 'TMOUT': '86400', 17:05:53 INFO - 'USER': 'cltbld', 17:05:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:53 INFO - '_': '/tools/buildbot/bin/python'} 17:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:53 INFO - Downloading/unpacking jsonschema 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:55 INFO - Downloading/unpacking functools32 (from jsonschema) 17:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:05:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:05:55 INFO - warning: no files found matching '*.txt' 17:05:55 INFO - no previously-included directories found matching 'build' 17:05:55 INFO - no previously-included directories found matching 'dist' 17:05:55 INFO - no previously-included directories found matching '.git*' 17:05:55 INFO - Installing collected packages: jsonschema, functools32 17:05:55 INFO - Running setup.py install for functools32 17:05:55 INFO - warning: no files found matching '*.txt' 17:05:55 INFO - no previously-included directories found matching 'build' 17:05:55 INFO - no previously-included directories found matching 'dist' 17:05:55 INFO - no previously-included directories found matching '.git*' 17:05:55 INFO - Successfully installed jsonschema functools32 17:05:55 INFO - Cleaning up... 17:05:55 INFO - Return code: 0 17:05:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:05: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')]} 17:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05: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')]} 17:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a38b8ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aff6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', '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 17:05:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:05:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:05:55 INFO - Using env: {'DISPLAY': ':0', 17:05:55 INFO - 'HOME': '/home/cltbld', 17:05:55 INFO - 'LANG': 'en_US.UTF-8', 17:05:55 INFO - 'LANGUAGE': 'en_US:en', 17:05:55 INFO - 'LOGNAME': 'cltbld', 17:05:55 INFO - 'MAIL': '/var/mail/cltbld', 17:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:55 INFO - 'MOZ_NO_REMOTE': '1', 17:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:55 INFO - 'NO_EM_RESTART': '1', 17:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:55 INFO - 'SHELL': '/bin/bash', 17:05:55 INFO - 'SHLVL': '1', 17:05:55 INFO - 'TERM': 'linux', 17:05:55 INFO - 'TMOUT': '86400', 17:05:55 INFO - 'USER': 'cltbld', 17:05:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:55 INFO - '_': '/tools/buildbot/bin/python'} 17:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:55 INFO - Downloading/unpacking flake8 17:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:05:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:05:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:05:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:58 INFO - no previously-included directories found matching 'docs/_build' 17:05:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:05:58 INFO - Running setup.py install for pep8 17:05:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:05:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:05:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:05:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:05:58 INFO - no previously-included directories found matching 'docs/_build' 17:05:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:05:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:05:58 INFO - Cleaning up... 17:05:58 INFO - Return code: 0 17:05:58 INFO - Running post-action listener: _resource_record_post_action 17:05:58 INFO - Running post-action listener: _start_resource_monitoring 17:05:58 INFO - Starting resource monitoring. 17:05:58 INFO - ##### 17:05:58 INFO - ##### Running install step. 17:05:58 INFO - ##### 17:05:58 INFO - Running pre-action listener: _resource_record_pre_action 17:05:58 INFO - Running main action method: install 17:05:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:05:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:05:59 INFO - Reading from file tmpfile_stdout 17:05:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:05:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:05:59 INFO - Reading from file tmpfile_stdout 17:05:59 INFO - Output received: 17:05:59 INFO - Usage: mozinstall [options] installer 17:05:59 INFO - Options: 17:05:59 INFO - -h, --help show this help message and exit 17:05:59 INFO - -d DEST, --destination=DEST 17:05:59 INFO - Directory to install application into. [default: 17:05:59 INFO - "/builds/slave/test-pgo"] 17:05:59 INFO - --app=APP Application being installed. [default: firefox] 17:05:59 INFO - mkdir: /builds/slave/test-pgo/build/application 17:05:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:05:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:06:14 INFO - Reading from file tmpfile_stdout 17:06:14 INFO - Output received: 17:06:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:06:14 INFO - Running post-action listener: _resource_record_post_action 17:06:14 INFO - ##### 17:06:14 INFO - ##### Running run-tests step. 17:06:14 INFO - ##### 17:06:14 INFO - Running pre-action listener: _resource_record_pre_action 17:06:14 INFO - Running main action method: run_tests 17:06:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:06:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:06:14 INFO - Python 2.7.3 17:06:14 INFO - Return code: 0 17:06:14 INFO - grabbing minidump binary from tooltool 17:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:14 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 0x1b8e920>, '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 0x1b8f820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b8fcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:06:14 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 17:06:14 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 17:06:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:06:14 INFO - Return code: 0 17:06:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:06:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:06:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:06:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:06:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:06:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:06:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:06:15 INFO - Return code: 0 17:06:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:06:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 17:06:15 INFO - Using env: {'DISPLAY': ':0', 17:06:15 INFO - 'HOME': '/home/cltbld', 17:06:15 INFO - 'LANG': 'en_US.UTF-8', 17:06:15 INFO - 'LANGUAGE': 'en_US:en', 17:06:15 INFO - 'LOGNAME': 'cltbld', 17:06:15 INFO - 'MAIL': '/var/mail/cltbld', 17:06:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:06:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:15 INFO - 'MOZ_NO_REMOTE': '1', 17:06:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:15 INFO - 'NO_EM_RESTART': '1', 17:06:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:15 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:06:15 INFO - 'SHELL': '/bin/bash', 17:06:15 INFO - 'SHLVL': '1', 17:06:15 INFO - 'TERM': 'linux', 17:06:15 INFO - 'TMOUT': '86400', 17:06:15 INFO - 'USER': 'cltbld', 17:06:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964', 17:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:15 INFO - '_': '/tools/buildbot/bin/python'} 17:06:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:06:16 INFO - mozversion application_buildid: 20160316144441 17:06:16 INFO - mozversion application_changeset: 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 17:06:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:06:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:06:16 INFO - mozversion application_name: Firefox 17:06:16 INFO - mozversion application_remotingname: firefox-dev 17:06:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:06:16 INFO - mozversion application_vendor: Mozilla 17:06:16 INFO - mozversion application_version: 47.0a2 17:06:16 INFO - mozversion platform_buildid: 20160316144441 17:06:16 INFO - mozversion platform_changeset: 831b9b1f8df25c9cd1f5b9d382bb6228c12d77c4 17:06:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:06:16 INFO - mozversion platform_version: 47.0a2 17:06:16 INFO - using testdate: 1458173176 17:06:16 INFO - actual date: 1458173176 17:06:16 INFO - starting webserver on 'localhost:35521' 17:06:16 INFO - SUITE-START | Running 2 tests 17:06:16 INFO - TEST-START | dromaeo_css 17:06:16 INFO - operating with platform_type : linux_ 17:06:16 INFO - Initialising browser for dromaeo_css test... 17:06:16 INFO - TEST-INFO | started process 24248 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY1sHHc/profile http://localhost:35521/getInfo.html) 17:06:20 INFO - PROCESS | 24248 | __metrics Screen width/height:1600/1200 17:06:20 INFO - PROCESS | 24248 | colorDepth:24 17:06:20 INFO - PROCESS | 24248 | Browser inner width/height: 1024/697 17:06:20 INFO - PROCESS | 24248 | __metrics 17:06:21 INFO - PROCESS | 24248 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:06:22 INFO - TEST-INFO | 24248: exit 0 17:06:22 INFO - Browser initialized. 17:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:06:22 INFO - TEST-INFO | started process 24340 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY1sHHc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:33 INFO - PROCESS | 24340 | RSS: Main: 144904192 17:06:33 INFO - PROCESS | 24340 | 17:07:24 INFO - PROCESS | 24340 | 1458173244784 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] 17:09:32 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35521/tests/dromaeo/cssquery-ext.html) 17:09:33 INFO - PROCESS | 24340 | RSS: Main: 250142720 17:09:33 INFO - PROCESS | 24340 | 17:12:35 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-ext.html (next: http://localhost:35521/tests/dromaeo/cssquery-jquery.html) 17:12:36 INFO - PROCESS | 24340 | RSS: Main: 238092288 17:12:36 INFO - PROCESS | 24340 | 17:15:38 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35521/tests/dromaeo/cssquery-mootools.html) 17:15:38 INFO - PROCESS | 24340 | RSS: Main: 230297600 17:15:38 INFO - PROCESS | 24340 | 17:18:40 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35521/tests/dromaeo/cssquery-prototype.html) 17:18:41 INFO - PROCESS | 24340 | RSS: Main: 215650304 17:18:41 INFO - PROCESS | 24340 | 17:21:43 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35521/tests/dromaeo/cssquery-yui.html) 17:21:44 INFO - PROCESS | 24340 | RSS: Main: 213938176 17:21:44 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | Cycle 1(1): loaded http://localhost:35521/tests/dromaeo/cssquery-yui.html (next: http://localhost:35521/tests/dromaeo/cssquery-dojo.html) 17:24:46 INFO - PROCESS | 24340 | RSS: Main: 257798144 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | __start_tp_report 17:24:46 INFO - PROCESS | 24340 | _x_x_mozilla_page_load 17:24:46 INFO - PROCESS | 24340 | _x_x_mozilla_page_load_details 17:24:46 INFO - PROCESS | 24340 | |i|pagename|runs| 17:24:46 INFO - PROCESS | 24340 | |0;dojo.html;3239.335936133093;3246.626637936637;3269.7874638148533;3272.6727327267263;3295.1432627516847;5274.630775845692;5291.4973077557615;5298.1258092414755;5323.973380133094;5370.624056316059;5322.148456247001;5341.4658534146665;5345.7594408251625;5348.705821179834;5350.678959262447;4828.396450443694;4886.389201349832;4886.973735515538;4926.433460152075;4942.851714448572;4871.269309603553;4875.9756201219125;4888.804447822101;4969.9751501242445;4975.303457515933;4833.540813622718;4915.729634870081;4935.333729946465;4976.4774698656665;4980.726060066695;4873.512648735134;4979.751012449363;5002.674826136289;5003.47463516331;5005.02402031604;4734.644901632391;4783;4834.58905992991;4846.5153484651255;4925.162722337212;5065.772040258197;5097.898042039138;5109.3613298337705;5127.846164615067;5138.486151384869;5700.686462244575;5703.971480142614;5711.257536520226;5714.057180565202;5725.599208055438;5681.488666020036;5712.714364281769;5720.713964301768;5797.246357973437;5806.564507661942;5311.203319502106;5314.813981510667;5320.6275560710765;5334.306540149756;5334.893302133974;5683.175939488751;5719.542436605062;5782.566307526952;5789.768409263666;5795.710214489259;5690.601657883908;5743.023685973395;5763.049096898964;5786.623869448473;5793.449622285876;5695.800646977336;5700.800471983461;5713.085906254979;5719.084946408555;5739.053056245756;5518.310211223597;5653.321601407857;5686.744096515667;5692.089265717465;5692.1461780733225;5665.716714164275;5698.0598201296325;5704.543636509069;5723.627964182315;5751.683657398883;4374.693771436033;4376.94953211227;4381.583749543852;4393.560643935581;4414.205443020223;3895.454636350913;3930.6855451563806;3945.072907866649;3963.900902477461;4017.718759686794;5234.3718753749035;5265.736713164327;5283.709395983258;5285.286486324374;5322.33470816148;5554.527865131428;5568.192612071308;5568.470995255444;5575.665460072328;5604.915926261109;5313.548348390353;5326.44072372403;5444.346678398618;5526.834194974157;5538.9169162462595;4763.0473905218405;4763.642726795504;4768.6661933665;4795.928061079087;4810.831620893322;5726.169705392695;5731.541476681856;5733.369329373765;5739.971300143556;5763.164341170591;5541.972290138524;5569.805056822992;5627.915581266202;5653.406392328746;5669.433056694297;5722.141678748221;5761.769529218785;5765.654060756368;5774.39368866263;5780.826575202751;5474.507294343528;5478.096114141282;5505.807296744595;5513.531349835149;5548.889022219614;5650.180723795109;5717.742701578356;5748.798792042258;5765.538756899354;5793.36273009977;5637.52081073097;5638.2670252866865;5640.915386269127;5673.234113394639;5680.71596420169;5482.451754824486;5485.149801780731;5654.7455364509515;5661.773529058956;5671.262735844314;5540.196671482532;5585.3297604287745;5588.105903055492;5589.385167631639;5625.184348269559;5635.492805647511;5684.175794509855;5686.317641882835;5692.743826527733;5694.943050569441;5422.403535611158;5455.1544510600925;5498.092814685532;5579.079451890392;5604.663720176803 17:24:46 INFO - PROCESS | 24340 | |1;ext.html;561.6377436553422;569.7379205565443;582.1355287398214;582.7727186397309;595.4670569839993;38826;39655.2068958621;39705.20589588206;39709.205815883666;39711;42962.14075718491;43492;43501.564984350145;43667;43674.781626091826;8903.599338029804;9228.6308547658;9231.907680923172;9239.168474837263;9252.722418327461;9063.95468022659;9216.986131525528;9222.446653200795;9224.077592240756;9228.16946474817;9173.770655733593;9223.308251881102;9252.306077044215;9260.444373337621;9272.814543709123;9144.588493517775;9184.26525877935;9198.586063627154;9202.723918282461;9220;9105.317101217435;9257.537123143884;9265.583048762823;9273.860892086625;9276.11876871696;43997.34003989943;44793.104137917384;44794.32808507875;44837.775811121064;45160.3225951611;3691.1141326081815;3792.9810350948346;4088.5707000764787;4292.270314046619;4331.501877284121;33500.83249583761;33755.324893502235;33932.6606733932;33970;33986.83006584976;3590.35373632746;3706.5737440194453;3720.441933709938;3759.6240375962457;3780.243951209769;286538;287908;288723.9999999979;289760;290639;64551.35448645453;66275;66302.66848665726;66343.33656663468;66400.33599664038;74033.62983185158;74208;74363.62818185982;74470.62764686142;74611.62694186495;15349.386024559117;15483.148426836407;15566.066036037648;15668.608284792743;15700.842991570167;12398.13213075094;12507.749845003049;12526.060545459128;12526.749465010831;12543.12198146121;21668.674969875465;21970.231041913456;22071.227507037176;22073.448163796034;23165;8611.827763444697;8704.173103555153;8744.310975154893;8893.377463577617;8893.732098315018;1035.028271143473;1046.6546039806844;1114.7436089699252;1122.231271578971;1165.9098742675626;30264.54603180954;30359.089227323217;30480.69519304823;30800.845995770327;30999.0700278992;1117.8714447838602;1149.4252873563219;1159.3913195572393;1255.3093903922438;1270.7140893298933;15799.842001580068;15923.601909952344;16064.196790160446;16135;16425.01449913009;336411;336511;337687;340556;343650;56046.43953560412;57101;57114.7144264276;57809.4219057804;57940.42059579435;1297.8247936528448;1403.8947078969118;1407.3807524689105;1498.992505037468;1534.508957133729;28153.296167595974;30564;30815.824531116974;32507.34985300328;33208.17355045399;51477.22784158315;51846.74076629593;51864;51952.48047519627;51969.48030519646;246803;246837;248452;248893;249093;30489.23776905595;34462.48306275358;35006.19950404012;35657.64342356543;36196.4570531437;44394.07946401099;45061.77469112633;45180;45440.31839522344;45630;37095.629043710294;37894;38232;38988.80505597454;39099.218015640094;37166.91156030375;37768.244635106596;37985.4302185473;38002.239955201294;38263.80868095753;38164.61835381722;38409;42555.36166957436;42889;43427.34858977055;31607.525887111253;34041.978740637824;34328.65671343354;34570;34591.481127783605;27043.323916902234;27568.724312756614;27681.307967300174;27763.861180693966;27832 17:24:46 INFO - PROCESS | 24340 | |2;jquery.html;378.50037949906135;380.5110433093475;384.609621234447;386.9129445874677;389.38671592242224;17623.471295861113;18570.721439178422;18808.2476700932;18835.811641883578;18868.150933208006;17018.149092545384;17692.557686057855;17943.461696149105;17968.820311796877;17971.730424043617;5437.483439073281;5555.055640541118;5566.053770858964;5597.132444471114;5619.353774315965;4218.240716670998;5520.254765606652;5816.738246778905;6039.4262545058145;6069.726862291185;5994.790182343619;6005.12925625784;6013.939860601382;6014.699265036753;6024.578279520435;5782.768689252425;5892.528597712173;5904.970475147618;5936;5944.762209511636;3803.6006219346846;5101.897962040775;5212.061828870839;5285.814996475144;5294.947050529522;20343;20672.276470323617;20754.48113797152;21119.788802111936;21266;2407.7471865454227;2501.6372625969316;2518.508890766301;2540.5808041673104;3093.9845300773577;12733.108682392236;13516.864831351659;14050.156990580597;14084.92957535216;14302.355229148678;1984.930527431533;2004.6792513197963;2050.733404657385;2073.2018173003353;2083.468715477559;57748.71125644387;60033.69814660192;61392.69303653453;61768.69115654438;63175.68412157956;10764.94617526923;10848.294860834021;10980;11040.33757974508;11118.55525778976;14383;14471.276436178148;14479.276036198358;14480.565583032527;14509.564713058626;8009.159038300894;8149.633266502903;8236.341092712568;8301.709440169565;8309.8338033239;7939.722109726132;7948.364130869517;7960.243776841191;8020.799480013046;8068.8386232275025;4690.249560070372;4760.738159401266;4760.785764640599;4763.69036012658;4807.975960120177;1818.1091265279917;1841.94088399171;1852.8517718582482;1889.6882014467733;1905.3331334032978;927.2581934452411;945.5366870233536;993.7416271769248;1025.2771795883884;1039.6257347354947;17098.82901170997;17148.314067437164;17330.74003889943;17549.649007020045;17789;980.5832521178471;1002.7192386131894;1030.1038096855634;1045.9529321180564;1052.768390953989;9603.9039609603;9868.506574671237;10080.811802606117;10187.643432479828;10226.744331391776;425839;428791;429078;436191;436414;71652.28347716456;71985.64007180036;72648;73206.16984575322;73996.63001684957;1047.5600247895902;1047.9214058945608;1075.6772968109535;1090.2041509697806;1109.2346281066039;15149.545513634608;15193.544193674208;15206.391744330545;15470.14914179686;15478.148701821508;31249.218769530944;31945;32007.67992320047;32398.35203295968;32655.510167347984;47310.29034564553;47678;48005.279920800516;48076.519234808606;48498.5150148494;8145.226203510657;8282.71010514629;8311.792205194919;8341.290990265896;8433.451825631315;9740.512974351395;12094.818577721166;12783.61649150527;12787.488500459878;12840.972722182016;10872.184586156229;10991.450427478754;11284.153688473561;11320.716982075513;11434;10771.353718776898;10777.461126943464;10936.671899843017;11019.779604408028;11625.069994400259;5488.067028605067;7396;9365.68880356737;10775.407352595683;11337.433128343715;8099.716509922125;8199.180081991753;8276.917230827614;8368.874466883124;8604.569771511275;10417.42704151279;11111.333320000826;11169;11605.187636865337;11710.94144529272 17:24:46 INFO - PROCESS | 24340 | |3;mootools.html;1457.7376072306993;1582.2168026826719;1589.3960295087866;1874.5032566369905;2005.6690646043403;7787.9221207787905;7873.330766884822;7936.76189714308;7950.284474397303;7957.72147974821;8038.959805200966;8272.172782721726;8292.875606865886;8303.543305118215;8320.459170153936;2063.6491796394575;2291.2209848651455;2329.3710698111586;2347.495288512969;2378.8096952243864;2308.7922087012166;2311.9422014449688;2313.398516385735;2317.8029867461287;2319.698439202901;2265.2411442166895;2357.257463898875;2366.8106551475926;2369.857808531485;2374.2283757778705;2345.144022431817;2372.893219805113;2415.4685969086772;2418.0811291709215;2419.9274021779374;2351.7648235176516;2354.8116150708074;2359.186080802138;2373.4541055557147;2388.235764555343;8391.076981532027;8428.367872409532;8479.872801907977;8491.74524764258;8510.276626486757;5080.364954380702;5186.325777648919;5196.558292545101;5197.090509160919;5203.5837133029645;3176.8411579420936;3261.2173078461237;3270.16610764256;3280.901572952815;3360.0423879194555;917.4495302818323;921.7096614566457;981.9459929703863;987.6049580167991;1045.8222102242637;11571.594994175248;11577.768444631145;11615.941920290345;11620.186586938918;11621.360825154698;4447.710898791568;4500.662450316239;4533.184026875128;4568.33759104928;4574.313852922089;9933.850992235122;10011.349262297927;10040.297179197387;10046.598136074621;10086.646967356108;4515.1195516873895;5135.820246291362;5170.508801663911;5173.379194496684;5175.741212939338;4431.158079964796;4456.108778244364;4465.642748580106;4466.955330446719;4528.026474307973;3877.806109694504;3944.723869329177;3950.545687245946;3978.9403158952637;4003.959960400417;1233.7224124571899;1275;1277.8530468996184;1279.3795009420423;1290.7999260114698;1408.1551069358304;1431.0841061720507;1435.7200345932652;1445.262915912892;1454.6872422429228;8132.308753755879;8149.022117345838;8197.672093116327;8199;8205.58972051395;487.1596496044366;502.18645793814255;514.8658809235698;516.5247971865892;518.419370305253;6221.9377806222265;6250.312465628777;6259.186305780219;6310.652914089677;6338.366163383625;9923.60305587783;10279.640212592523;10377.792444151075;10393.428361440043;10399.1160751337;9890.604375824887;10137.695869123938;10184.338018028953;10200;10206.591736330463;8030.156833532512;8055.476394034369;8092.71675491355;8113.350931925432;8157.428979971463;7752.18602046777;7810;7815.491993020435;7818.6481608328895;7901.644426000728;9150.542472876197;9175.724728258163;9230.815383692423;9261.86107208379;9405.576749046446;9104.408213466104;9475.526223688927;9497.19273861702;9524.904750952679;9561.521923903916;6625.768098116543;7034.120734908137;7193.280671932765;7453.739119130804;7578.734744283924;7841.607919604111;7843.176466471166;7876.724314649189;7895.644695988809;7902.960485197767;6969.233384327821;7184.6048467334795;7192.352688258082;7275.599842008741;7297.416206703557;7087.964560177166;7101.254368291255;7130;7156.427485801228;7174.605396703231;7474.289942455458;7610.695572177272;7622.8094297643;7637.236276372319;7652.808679782827;6713.295104014203;6725.293844146294;6787.490938179558;6836.623985680835;6865.038894554867;7006.894896576658;7061.6822243000215;7177.964110179416;7205.603691797001;7213 17:24:46 INFO - PROCESS | 24340 | |4;prototype.html;344.45747946983505;352.3850880214027;359.2760587416355;360.6591770776617;366.86976123476165;5867.1492633568105;5903.911441328383;5907.350191478939;5943.227380440537;5948.256467941507;5878.353381128072;5885.793997210088;5887.941120588793;5891.469767720904;5895.263092113486;4396.802143903532;4413.382126502276;4590.655700822435;4616.099860527199;4616.884577885546;4556.066006468666;4578;4578.015726618776;4579.9771001144945;4606.309053641947;4525;4546.1589605922845;4556.9088618227615;4558.065596552716;4571.3143028545655;4352.129574085196;4391.6267117295065;4484.865454036384;4509.503954564995;4521.728696278234;3965.8810235692977;3966.8413263469715;3975.9006024849323;3979.2240513099955;3983.980080099581;5653;5664.4618761218035;5674.801381951612;5678.205051292823;5680.289963754531;5259.631825772198;5261.710605916673;5273;5274.4198138204765;5283.599846040802;6215.533834962396;6217.440430361289;6219.067139929001;6228.128062071313;6236.407541283571;4216.915661686749;4324.372965919955;4330.350447432878;4433.667474939392;4443.7111587746695;6462.773802916875;6496.090547323379;6512.2836487985805;6516.641584712839;6552.115464412291;4403.656884650212;4407.889802754957;4410.735355878657;4413.426254586883;4416.11677664462;4470.351798989128;4470.9105817883465;4471.128130014616;4471.441069866267;4474.7762611869275;5189.532942035235;5191.377034755854;5193.5585475234275;5196.194589838581;5198.948010519922;6042.912275790312;6264.373562643699;6287.339829317947;6294.716737746812;6304.779332723333;1601.6876709041626;1604.3502381535498;1616.7817344658556;1617.6522047759788;1618.5387164658016;1000.1998401278947;1059.7191744187642;1069.1286601419818;1091.7761858818924;1093.5243169221415;6053.031514957585;6101.969490152521;6117.388261173847;6132.754689812357;6148.415900489446;6457.773977910751;6471.191101112361;6473.643949582724;6482.12491313676;6494.545381823227;6070.908936365958;6102.4507794298725;6106.084087386927;6106.4809491192855;6119.632822030692;3449.913752156166;3488.54648895647;3497.283056973365;3501.77238479498;3502.562179727534;6498.155239818793;6664.833379165462;6748.055272261888;6796.184457865088;6803.2856550062525;6692.130023096966;6706;6708.3291670833505;6710.563813352116;6716.194056713226;6767.93232067673;6772.762953296611;6774.119364482585;6778.254392016875;6784.287649796799;6556.409923106943;6605.768798092044;6608.966955165193;6615.636140012153;6622.933770662232;6242.469390101892;6373.93626063752;6393.584417012879;6425.518086143651;6435.871282574416;6709.329067093252;6757.493188011017;6762.748891455097;6810.5913645181445;6815.2162501311;4502.527234640446;4537.4328208973875;4537.909241815211;4543.886402839956;4544.250198717307;6544.6727663617585;6570.014497825365;6574.967125164344;6578.901316480353;6585.143931289093;6102.115193296859;6309.432151106423;6315.431611155018;6321.431071203614;6321.52588555851;6315.5894866833505;6361.2048493938255;6372.044193371032;6382.776602818879;6391.041343798467;6227.221597300338;6241.31345551998;6278.780242691484;6279.623222606659;6298.937010630018;6357.078223657636;6403.871922561616;6412.487001039813;6427.035944608346;6428.935710642833;5977.790777322773;6030.7889223876955;6103.05402662588;6250.343713909974;6253.906191407042 17:24:46 INFO - PROCESS | 24340 | |5;yui.html;849.7195925344637;897.3135551303254;910.4446287764458;915.4370062411618;959.3907868503501;15156.317965691544;15379.538613841574;15393.615159621015;15418;15420.99763515372;13321.400536975834;13422.798658020138;13438.059335846494;13454.1927484351;13472.595822125328;771.4329967473902;792.1009654042674;794.1780257433558;908.8046070094945;923.8568021956573;778.0352363069809;915.9404638698496;940.9905900940971;941.4727752458645;942.4675058591907;983.2527279267772;985.8176237396104;986.595495846703;988.0810845913297;988.906053924876;808.0747544062075;822.7408366364635;979.6277414582448;980.2990861534001;982.228950274035;706.1526168597652;713.4720306972803;714.4927101757759;714.9964250178767;715.899774031636;14441.133531988009;14553.417863285562;14582;14628.488002919847;14681.559553213421;13291.800622990662;13953.441862325495;14005.439782408794;14120.15279083248;14224.502142424966;10679.317152248444;10848.294860834021;11086;11484.368359740294;11623.709407264801;4003.459532963071;4005.4792876926103;4015.036391266075;4121.979390103061;4123.773192474443;52222;52743.73628131835;52962;53057.2041419379;53210.46789532094;10762.838557421645;10822.40476773785;11066.667999960015;11068.446577671084;11189.732264437771;19119.522011949535;19257.614847703248;19290.131944062552;19327.323543676186;19366.4190074298;8342.833143337099;8588.441751286146;8590.87113693295;8742.650293988168;8903.643854245758;4233.745975241495;4466.531014243523;4506.369108324837;4596.655250856199;4655.580997710223;3259.9837000814846;3349.69852713257;3350.8827191048194;3356.9761222826783;3374.1395944034116;602.8040886711836;611.242059845788;616.3897741236144;621.832105331558;622.2626187967273;634.6826586706646;646.7865604350553;651.9869602607921;690.7927621713466;724.5326764237037;9338.719838404859;9431.76420589477;9505.904940950502;9727.270454715925;9809.901900981042;585.0872638683667;655.8950567909112;702.3959394920364;708.3235510087957;738.2691135775543;4112.3420252759415;4410.316400957857;4451.154280686659;4522.415602632288;4536.9092618148115;57361;57708.71145644329;58010.12984805231;59210.70394647999;59793.402065978786;48451.75774121107;52084.47915520872;52618.47381526136;53218;53976.190357144675;41732.79133604373;42144.15711685749;42294.57705422968;42301.15397692029;42825;9395.154436100784;9486.952565237405;9542.141207291377;9542.761430964281;9600.087991640783;33449.66550334466;34289.31421371608;34783.82608086943;35131.824340878135;35824.64175358213;44576.331355029055;44660.77669611761;45242.773786130856;45527.54472455233;45637.54362456333;11565.826512602149;11581.305121692725;11651.941740291244;11834.940825295818;12419.19275247106;12080.39598020113;13206.405711743188;13534.255615941218;13538.59384218475;13599;12816.102872798814;12836.229826210458;12843.486260549847;12868.356582171042;13223.140495867738;11807.114466414881;12730.618081457571;12921.483140674267;13224.074314798256;13356.398962046536;12600.306983116017;12723.745525089631;12734.61796146117;12805.551805686757;12880.806787898377;10317.17462602975;10359.274850760374;10367.688969330931;10470.777607758362;10833.891661083604;10163.339382940085;10241.77098748155;10514.07814706346;10610.787784244427;10621.628243011457 17:24:46 INFO - PROCESS | 24340 | __end_tp_report 17:24:46 INFO - PROCESS | 24340 | __start_cc_report 17:24:46 INFO - PROCESS | 24340 | _x_x_mozilla_cycle_collect,830 17:24:46 INFO - PROCESS | 24340 | __end_cc_report 17:24:46 INFO - PROCESS | 24340 | __startTimestamp1458174286716__endTimestamp 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | ------- Summary: start ------- 17:24:46 INFO - PROCESS | 24340 | Number of tests: 6 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#0] dojo.html Cycles:165 Average:5293.81 Median:5518.31 stddev:565.55 (10.2%) stddev-sans-first:543.83 17:24:46 INFO - PROCESS | 24340 | Values: 3239.3 3246.6 3269.8 3272.7 3295.1 5274.6 5291.5 5298.1 5324.0 5370.6 5322.1 5341.5 5345.8 5348.7 5350.7 4828.4 4886.4 4887.0 4926.4 4942.9 4871.3 4876.0 4888.8 4970.0 4975.3 4833.5 4915.7 4935.3 4976.5 4980.7 4873.5 4979.8 5002.7 5003.5 5005.0 4734.6 4783.0 4834.6 4846.5 4925.2 5065.8 5097.9 5109.4 5127.8 5138.5 5700.7 5704.0 5711.3 5714.1 5725.6 5681.5 5712.7 5720.7 5797.2 5806.6 5311.2 5314.8 5320.6 5334.3 5334.9 5683.2 5719.5 5782.6 5789.8 5795.7 5690.6 5743.0 5763.0 5786.6 5793.4 5695.8 5700.8 5713.1 5719.1 5739.1 5518.3 5653.3 5686.7 5692.1 5692.1 5665.7 5698.1 5704.5 5723.6 5751.7 4374.7 4376.9 4381.6 4393.6 4414.2 3895.5 3930.7 3945.1 3963.9 4017.7 5234.4 5265.7 5283.7 5285.3 5322.3 5554.5 5568.2 5568.5 5575.7 5604.9 5313.5 5326.4 5444.3 5526.8 5538.9 4763.0 4763.6 4768.7 4795.9 4810.8 5726.2 5731.5 5733.4 5740.0 5763.2 5542.0 5569.8 5627.9 5653.4 5669.4 5722.1 5761.8 5765.7 5774.4 5780.8 5474.5 5478.1 5505.8 5513.5 5548.9 5650.2 5717.7 5748.8 5765.5 5793.4 5637.5 5638.3 5640.9 5673.2 5680.7 5482.5 5485.1 5654.7 5661.8 5671.3 5540.2 5585.3 5588.1 5589.4 5625.2 5635.5 5684.2 5686.3 5692.7 5694.9 5422.4 5455.2 5498.1 5579.1 5604.7 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#1] ext.html Cycles:180 Average:48317.67 Median:20889.21 stddev:76856.40 (367.9%) stddev-sans-first:76988.36 17:24:46 INFO - PROCESS | 24340 | Values: 561.6 569.7 582.1 582.8 595.5 38826.0 39655.2 39705.2 39709.2 39711.0 42962.1 43492.0 43501.6 43667.0 43674.8 8903.6 9228.6 9231.9 9239.2 9252.7 9064.0 9217.0 9222.4 9224.1 9228.2 9173.8 9223.3 9252.3 9260.4 9272.8 9144.6 9184.3 9198.6 9202.7 9220.0 9105.3 9257.5 9265.6 9273.9 9276.1 43997.3 44793.1 44794.3 44837.8 45160.3 3691.1 3793.0 4088.6 4292.3 4331.5 33500.8 33755.3 33932.7 33970.0 33986.8 3590.4 3706.6 3720.4 3759.6 3780.2 286538.0 287908.0 288724.0 289760.0 290639.0 64551.4 66275.0 66302.7 66343.3 66400.3 74033.6 74208.0 74363.6 74470.6 74611.6 15349.4 15483.1 15566.1 15668.6 15700.8 12398.1 12507.7 12526.1 12526.7 12543.1 21668.7 21970.2 22071.2 22073.4 23165.0 8611.8 8704.2 8744.3 8893.4 8893.7 1035.0 1046.7 1114.7 1122.2 1165.9 30264.5 30359.1 30480.7 30800.8 30999.1 1117.9 1149.4 1159.4 1255.3 1270.7 15799.8 15923.6 16064.2 16135.0 16425.0 336411.0 336511.0 337687.0 340556.0 343650.0 56046.4 57101.0 57114.7 57809.4 57940.4 1297.8 1403.9 1407.4 1499.0 1534.5 28153.3 30564.0 30815.8 32507.3 33208.2 51477.2 51846.7 51864.0 51952.5 51969.5 246803.0 246837.0 248452.0 248893.0 249093.0 30489.2 34462.5 35006.2 35657.6 36196.5 44394.1 45061.8 45180.0 45440.3 45630.0 37095.6 37894.0 38232.0 38988.8 39099.2 37166.9 37768.2 37985.4 38002.2 38263.8 38164.6 38409.0 42555.4 42889.0 43427.3 31607.5 34042.0 34328.7 34570.0 34591.5 27043.3 27568.7 27681.3 27763.9 27832.0 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#2] jquery.html Cycles:180 Average:25374.16 Median:31597.11 stddev:70603.00 (223.4%) stddev-sans-first:70776.12 17:24:46 INFO - PROCESS | 24340 | Values: 378.5 380.5 384.6 386.9 389.4 17623.5 18570.7 18808.2 18835.8 18868.2 17018.1 17692.6 17943.5 17968.8 17971.7 5437.5 5555.1 5566.1 5597.1 5619.4 4218.2 5520.3 5816.7 6039.4 6069.7 5994.8 6005.1 6013.9 6014.7 6024.6 5782.8 5892.5 5905.0 5936.0 5944.8 3803.6 5101.9 5212.1 5285.8 5294.9 20343.0 20672.3 20754.5 21119.8 21266.0 2407.7 2501.6 2518.5 2540.6 3094.0 12733.1 13516.9 14050.2 14084.9 14302.4 1984.9 2004.7 2050.7 2073.2 2083.5 57748.7 60033.7 61392.7 61768.7 63175.7 10764.9 10848.3 10980.0 11040.3 11118.6 14383.0 14471.3 14479.3 14480.6 14509.6 8009.2 8149.6 8236.3 8301.7 8309.8 7939.7 7948.4 7960.2 8020.8 8068.8 4690.2 4760.7 4760.8 4763.7 4808.0 1818.1 1841.9 1852.9 1889.7 1905.3 927.3 945.5 993.7 1025.3 1039.6 17098.8 17148.3 17330.7 17549.6 17789.0 980.6 1002.7 1030.1 1046.0 1052.8 9603.9 9868.5 10080.8 10187.6 10226.7 425839.0 428791.0 429078.0 436191.0 436414.0 71652.3 71985.6 72648.0 73206.2 73996.6 1047.6 1047.9 1075.7 1090.2 1109.2 15149.5 15193.5 15206.4 15470.1 15478.1 31249.2 31945.0 32007.7 32398.4 32655.5 47310.3 47678.0 48005.3 48076.5 48498.5 8145.2 8282.7 8311.8 8341.3 8433.5 9740.5 12094.8 12783.6 12787.5 12841.0 10872.2 10991.5 11284.2 11320.7 11434.0 10771.4 10777.5 10936.7 11019.8 11625.1 5488.1 7396.0 9365.7 10775.4 11337.4 8099.7 8199.2 8276.9 8368.9 8604.6 10417.4 11111.3 11169.0 11605.2 11710.9 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#3] mootools.html Cycles:180 Average:5849.00 Median:5196.82 stddev:3108.10 (59.8%) stddev-sans-first:3099.30 17:24:46 INFO - PROCESS | 24340 | Values: 1457.7 1582.2 1589.4 1874.5 2005.7 7787.9 7873.3 7936.8 7950.3 7957.7 8039.0 8272.2 8292.9 8303.5 8320.5 2063.6 2291.2 2329.4 2347.5 2378.8 2308.8 2311.9 2313.4 2317.8 2319.7 2265.2 2357.3 2366.8 2369.9 2374.2 2345.1 2372.9 2415.5 2418.1 2419.9 2351.8 2354.8 2359.2 2373.5 2388.2 8391.1 8428.4 8479.9 8491.7 8510.3 5080.4 5186.3 5196.6 5197.1 5203.6 3176.8 3261.2 3270.2 3280.9 3360.0 917.4 921.7 981.9 987.6 1045.8 11571.6 11577.8 11615.9 11620.2 11621.4 4447.7 4500.7 4533.2 4568.3 4574.3 9933.9 10011.3 10040.3 10046.6 10086.6 4515.1 5135.8 5170.5 5173.4 5175.7 4431.2 4456.1 4465.6 4467.0 4528.0 3877.8 3944.7 3950.5 3978.9 4004.0 1233.7 1275.0 1277.9 1279.4 1290.8 1408.2 1431.1 1435.7 1445.3 1454.7 8132.3 8149.0 8197.7 8199.0 8205.6 487.2 502.2 514.9 516.5 518.4 6221.9 6250.3 6259.2 6310.7 6338.4 9923.6 10279.6 10377.8 10393.4 10399.1 9890.6 10137.7 10184.3 10200.0 10206.6 8030.2 8055.5 8092.7 8113.4 8157.4 7752.2 7810.0 7815.5 7818.6 7901.6 9150.5 9175.7 9230.8 9261.9 9405.6 9104.4 9475.5 9497.2 9524.9 9561.5 6625.8 7034.1 7193.3 7453.7 7578.7 7841.6 7843.2 7876.7 7895.6 7903.0 6969.2 7184.6 7192.4 7275.6 7297.4 7088.0 7101.3 7130.0 7156.4 7174.6 7474.3 7610.7 7622.8 7637.2 7652.8 6713.3 6725.3 6787.5 6836.6 6865.0 7006.9 7061.7 7178.0 7205.6 7213.0 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#4] prototype.html Cycles:180 Average:5274.94 Median:6004.29 stddev:1593.14 (26.5%) stddev-sans-first:1554.03 17:24:46 INFO - PROCESS | 24340 | Values: 344.5 352.4 359.3 360.7 366.9 5867.1 5903.9 5907.4 5943.2 5948.3 5878.4 5885.8 5887.9 5891.5 5895.3 4396.8 4413.4 4590.7 4616.1 4616.9 4556.1 4578.0 4578.0 4580.0 4606.3 4525.0 4546.2 4556.9 4558.1 4571.3 4352.1 4391.6 4484.9 4509.5 4521.7 3965.9 3966.8 3975.9 3979.2 3984.0 5653.0 5664.5 5674.8 5678.2 5680.3 5259.6 5261.7 5273.0 5274.4 5283.6 6215.5 6217.4 6219.1 6228.1 6236.4 4216.9 4324.4 4330.4 4433.7 4443.7 6462.8 6496.1 6512.3 6516.6 6552.1 4403.7 4407.9 4410.7 4413.4 4416.1 4470.4 4470.9 4471.1 4471.4 4474.8 5189.5 5191.4 5193.6 5196.2 5198.9 6042.9 6264.4 6287.3 6294.7 6304.8 1601.7 1604.4 1616.8 1617.7 1618.5 1000.2 1059.7 1069.1 1091.8 1093.5 6053.0 6102.0 6117.4 6132.8 6148.4 6457.8 6471.2 6473.6 6482.1 6494.5 6070.9 6102.5 6106.1 6106.5 6119.6 3449.9 3488.5 3497.3 3501.8 3502.6 6498.2 6664.8 6748.1 6796.2 6803.3 6692.1 6706.0 6708.3 6710.6 6716.2 6767.9 6772.8 6774.1 6778.3 6784.3 6556.4 6605.8 6609.0 6615.6 6622.9 6242.5 6373.9 6393.6 6425.5 6435.9 6709.3 6757.5 6762.7 6810.6 6815.2 4502.5 4537.4 4537.9 4543.9 4544.3 6544.7 6570.0 6575.0 6578.9 6585.1 6102.1 6309.4 6315.4 6321.4 6321.5 6315.6 6361.2 6372.0 6382.8 6391.0 6227.2 6241.3 6278.8 6279.6 6298.9 6357.1 6403.9 6412.5 6427.0 6428.9 5977.8 6030.8 6103.1 6250.3 6253.9 17:24:46 INFO - PROCESS | 24340 | 17:24:46 INFO - PROCESS | 24340 | [#5] yui.html Cycles:180 Average:14435.64 Median:23529.37 stddev:16065.74 (68.3%) stddev-sans-first:16078.41 17:24:46 INFO - PROCESS | 24340 | Values: 849.7 897.3 910.4 915.4 959.4 15156.3 15379.5 15393.6 15418.0 15421.0 13321.4 13422.8 13438.1 13454.2 13472.6 771.4 792.1 794.2 908.8 923.9 778.0 915.9 941.0 941.5 942.5 983.3 985.8 986.6 988.1 988.9 808.1 822.7 979.6 980.3 982.2 706.2 713.5 714.5 715.0 715.9 14441.1 14553.4 14582.0 14628.5 14681.6 13291.8 13953.4 14005.4 14120.2 14224.5 10679.3 10848.3 11086.0 11484.4 11623.7 4003.5 4005.5 4015.0 4122.0 4123.8 52222.0 52743.7 52962.0 53057.2 53210.5 10762.8 10822.4 11066.7 11068.4 11189.7 19119.5 19257.6 19290.1 19327.3 19366.4 8342.8 8588.4 8590.9 8742.7 8903.6 4233.7 4466.5 4506.4 4596.7 4655.6 3260.0 3349.7 3350.9 3357.0 3374.1 602.8 611.2 616.4 621.8 622.3 634.7 646.8 652.0 690.8 724.5 9338.7 9431.8 9505.9 9727.3 9809.9 585.1 655.9 702.4 708.3 738.3 4112.3 4410.3 4451.2 4522.4 4536.9 57361.0 57708.7 58010.1 59210.7 59793.4 48451.8 52084.5 52618.5 53218.0 53976.2 41732.8 42144.2 42294.6 42301.2 42825.0 9395.2 9487.0 9542.1 9542.8 9600.1 33449.7 34289.3 34783.8 35131.8 35824.6 44576.3 44660.8 45242.8 45527.5 45637.5 11565.8 11581.3 11651.9 11834.9 12419.2 12080.4 13206.4 13534.3 13538.6 13599.0 12816.1 12836.2 12843.5 12868.4 13223.1 11807.1 12730.6 12921.5 13224.1 13356.4 12600.3 12723.7 12734.6 12805.6 12880.8 10317.2 10359.3 10367.7 10470.8 10833.9 10163.3 10241.8 10514.1 10610.8 10621.6 17:24:46 INFO - PROCESS | 24340 | -------- Summary: end -------- 17:24:46 INFO - PROCESS | 24340 | 17:24:47 INFO - TEST-INFO | 24340: exit 0 17:24:47 INFO - TEST-OK | dromaeo_css | took 1111324ms 17:24:47 INFO - TEST-START | kraken 17:24:47 INFO - operating with platform_type : linux_ 17:24:47 INFO - Initialising browser for kraken test... 17:24:47 INFO - TEST-INFO | started process 24529 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaZqk5T/profile http://localhost:35521/getInfo.html) 17:24:51 INFO - PROCESS | 24529 | __metrics Screen width/height:1600/1200 17:24:51 INFO - PROCESS | 24529 | colorDepth:24 17:24:51 INFO - PROCESS | 24529 | Browser inner width/height: 1024/697 17:24:51 INFO - PROCESS | 24529 | __metrics 17:24:52 INFO - PROCESS | 24529 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:24:52 INFO - PROCESS | 24529 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:24:53 INFO - TEST-INFO | 24529: exit 0 17:24:53 INFO - Browser initialized. 17:24:53 INFO - Running cycle 1/1 for kraken test... 17:24:53 INFO - TEST-INFO | started process 24620 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaZqk5T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:05 INFO - PROCESS | 24620 | RSS: Main: 143106048 17:25:05 INFO - PROCESS | 24620 | 17:25:07 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35521/tests/kraken/driver.html?testName=audio-beat-detection) 17:25:08 INFO - PROCESS | 24620 | RSS: Main: 178069504 17:25:08 INFO - PROCESS | 24620 | 17:25:10 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35521/tests/kraken/driver.html?testName=audio-dft) 17:25:11 INFO - PROCESS | 24620 | RSS: Main: 176631808 17:25:11 INFO - PROCESS | 24620 | 17:25:14 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35521/tests/kraken/driver.html?testName=audio-fft) 17:25:14 INFO - PROCESS | 24620 | RSS: Main: 173527040 17:25:14 INFO - PROCESS | 24620 | 17:25:16 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35521/tests/kraken/driver.html?testName=audio-oscillator) 17:25:17 INFO - PROCESS | 24620 | RSS: Main: 173678592 17:25:17 INFO - PROCESS | 24620 | 17:25:19 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:25:20 INFO - PROCESS | 24620 | RSS: Main: 170655744 17:25:20 INFO - PROCESS | 24620 | 17:25:23 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35521/tests/kraken/driver.html?testName=imaging-darkroom) 17:25:23 INFO - PROCESS | 24620 | RSS: Main: 172138496 17:25:23 INFO - PROCESS | 24620 | 17:25:27 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35521/tests/kraken/driver.html?testName=imaging-desaturate) 17:25:27 INFO - PROCESS | 24620 | RSS: Main: 173334528 17:25:27 INFO - PROCESS | 24620 | 17:25:30 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35521/tests/kraken/driver.html?testName=json-parse-financial) 17:25:30 INFO - PROCESS | 24620 | RSS: Main: 173764608 17:25:30 INFO - PROCESS | 24620 | 17:25:32 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:25:33 INFO - PROCESS | 24620 | RSS: Main: 177975296 17:25:33 INFO - PROCESS | 24620 | 17:25:34 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:25:35 INFO - PROCESS | 24620 | RSS: Main: 176549888 17:25:35 INFO - PROCESS | 24620 | 17:25:37 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:25:38 INFO - PROCESS | 24620 | RSS: Main: 182472704 17:25:38 INFO - PROCESS | 24620 | 17:25:40 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:25:40 INFO - PROCESS | 24620 | RSS: Main: 190283776 17:25:40 INFO - PROCESS | 24620 | 17:25:43 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:25:44 INFO - PROCESS | 24620 | RSS: Main: 188428288 17:25:44 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | Cycle 1(1): loaded http://localhost:35521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35521/tests/kraken/driver.html?testName=ai-astar) 17:25:45 INFO - PROCESS | 24620 | RSS: Main: 249102336 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | __start_tp_report 17:25:45 INFO - PROCESS | 24620 | _x_x_mozilla_page_load 17:25:45 INFO - PROCESS | 24620 | _x_x_mozilla_page_load_details 17:25:45 INFO - PROCESS | 24620 | |i|pagename|runs| 17:25:45 INFO - PROCESS | 24620 | |0;ai-astar;112;113;110;113;112;111;102;110;112;111 17:25:45 INFO - PROCESS | 24620 | |1;audio-beat-detection;157;125;153;169;131;153;151;126;170;127 17:25:45 INFO - PROCESS | 24620 | |2;audio-dft;163;161;162;161;161;164;159;162;161;161 17:25:45 INFO - PROCESS | 24620 | |3;audio-fft;74;74;75;156;74;76;74;76;157;76 17:25:45 INFO - PROCESS | 24620 | |4;audio-oscillator;100;93;142;92;94;95;139;95;95;135 17:25:45 INFO - PROCESS | 24620 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;117;117 17:25:45 INFO - PROCESS | 24620 | |6;imaging-darkroom;147;146;146;146;146;146;148;146;146;146 17:25:45 INFO - PROCESS | 24620 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;97;96 17:25:45 INFO - PROCESS | 24620 | |8;json-parse-financial;56;56;57;55;54;58;55;63;52;54 17:25:45 INFO - PROCESS | 24620 | |9;json-stringify-tinderbox;68;70;69;69;69;69;68;70;69;69 17:25:45 INFO - PROCESS | 24620 | |10;stanford-crypto-aes;77;77;78;79;78;80;79;86;79;79 17:25:45 INFO - PROCESS | 24620 | |11;stanford-crypto-ccm;115;111;125;110;114;116;110;114;113;113 17:25:45 INFO - PROCESS | 24620 | |12;stanford-crypto-pbkdf2;147;143;155;146;144;132;148;156;135;137 17:25:45 INFO - PROCESS | 24620 | |13;stanford-crypto-sha256-iterative;67;65;66;67;68;67;68;64;67;64 17:25:45 INFO - PROCESS | 24620 | __end_tp_report 17:25:45 INFO - PROCESS | 24620 | __start_cc_report 17:25:45 INFO - PROCESS | 24620 | _x_x_mozilla_cycle_collect,1051 17:25:45 INFO - PROCESS | 24620 | __end_cc_report 17:25:45 INFO - PROCESS | 24620 | __startTimestamp1458174345983__endTimestamp 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | ------- Summary: start ------- 17:25:45 INFO - PROCESS | 24620 | Number of tests: 14 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:3.36 17:25:45 INFO - PROCESS | 24620 | Values: 112.0 113.0 110.0 113.0 112.0 111.0 102.0 110.0 112.0 111.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:153.00 stddev:17.56 (11.5%) stddev-sans-first:18.19 17:25:45 INFO - PROCESS | 24620 | Values: 157.0 125.0 153.0 169.0 131.0 153.0 151.0 126.0 170.0 127.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.32 17:25:45 INFO - PROCESS | 24620 | Values: 163.0 161.0 162.0 161.0 161.0 164.0 159.0 162.0 161.0 161.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.50 stddev:34.43 (46.2%) stddev-sans-first:35.95 17:25:45 INFO - PROCESS | 24620 | Values: 74.0 74.0 75.0 156.0 74.0 76.0 74.0 76.0 157.0 76.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.50 stddev:21.33 (22.8%) stddev-sans-first:22.42 17:25:45 INFO - PROCESS | 24620 | Values: 100.0 93.0 142.0 92.0 94.0 95.0 139.0 95.0 95.0 135.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:25:45 INFO - PROCESS | 24620 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:25:45 INFO - PROCESS | 24620 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 148.0 146.0 146.0 146.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:25:45 INFO - PROCESS | 24620 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 97.0 96.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.98 (5.3%) stddev-sans-first:3.16 17:25:45 INFO - PROCESS | 24620 | Values: 56.0 56.0 57.0 55.0 54.0 58.0 55.0 63.0 52.0 54.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 17:25:45 INFO - PROCESS | 24620 | Values: 68.0 70.0 69.0 69.0 69.0 69.0 68.0 70.0 69.0 69.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.57 (3.3%) stddev-sans-first:2.60 17:25:45 INFO - PROCESS | 24620 | Values: 77.0 77.0 78.0 79.0 78.0 80.0 79.0 86.0 79.0 79.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#11] stanford-crypto-ccm Cycles:10 Average:114.10 Median:114.00 stddev:4.33 (3.8%) stddev-sans-first:4.58 17:25:45 INFO - PROCESS | 24620 | Values: 115.0 111.0 125.0 110.0 114.0 116.0 110.0 114.0 113.0 113.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.50 stddev:7.94 (5.4%) stddev-sans-first:8.37 17:25:45 INFO - PROCESS | 24620 | Values: 147.0 143.0 155.0 146.0 144.0 132.0 148.0 156.0 135.0 137.0 17:25:45 INFO - PROCESS | 24620 | 17:25:45 INFO - PROCESS | 24620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 17:25:45 INFO - PROCESS | 24620 | Values: 67.0 65.0 66.0 67.0 68.0 67.0 68.0 64.0 67.0 64.0 17:25:45 INFO - PROCESS | 24620 | -------- Summary: end -------- 17:25:45 INFO - PROCESS | 24620 | 17:25:46 INFO - TEST-INFO | 24620: exit 0 17:25:46 INFO - TEST-OK | kraken | took 59553ms 17:25:46 INFO - SUITE-END | took 1170s 17:25:47 INFO - Completed test suite (00:19:31) 17:25:47 INFO - javascript benchmark 17:25:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3239.335936133093, 3246.626637936637, 3269.7874638148533, 3272.6727327267263, 3295.1432627516847, 5274.630775845692, 5291.4973077557615, 5298.1258092414755, 5323.973380133094, 5370.624056316059, 5322.148456247001, 5341.4658534146665, 5345.7594408251625, 5348.705821179834, 5350.678959262447, 4828.396450443694, 4886.389201349832, 4886.973735515538, 4926.433460152075, 4942.851714448572, 4871.269309603553, 4875.9756201219125, 4888.804447822101, 4969.9751501242445, 4975.303457515933, 4833.540813622718, 4915.729634870081, 4935.333729946465, 4976.4774698656665, 4980.726060066695, 4873.512648735134, 4979.751012449363, 5002.674826136289, 5003.47463516331, 5005.02402031604, 4734.644901632391, 4783.0, 4834.58905992991, 4846.5153484651255, 4925.162722337212, 5065.772040258197, 5097.898042039138, 5109.3613298337705, 5127.846164615067, 5138.486151384869, 5700.686462244575, 5703.971480142614, 5711.257536520226, 5714.057180565202, 5725.599208055438, 5681.488666020036, 5712.714364281769, 5720.713964301768, 5797.246357973437, 5806.564507661942, 5311.203319502106, 5314.813981510667, 5320.6275560710765, 5334.306540149756, 5334.893302133974, 5683.175939488751, 5719.542436605062, 5782.566307526952, 5789.768409263666, 5795.710214489259, 5690.601657883908, 5743.023685973395, 5763.049096898964, 5786.623869448473, 5793.449622285876, 5695.800646977336, 5700.800471983461, 5713.085906254979, 5719.084946408555, 5739.053056245756, 5518.310211223597, 5653.321601407857, 5686.744096515667, 5692.089265717465, 5692.1461780733225, 5665.716714164275, 5698.0598201296325, 5704.543636509069, 5723.627964182315, 5751.683657398883, 4374.693771436033, 4376.94953211227, 4381.583749543852, 4393.560643935581, 4414.205443020223, 3895.454636350913, 3930.6855451563806, 3945.072907866649, 3963.900902477461, 4017.718759686794, 5234.3718753749035, 5265.736713164327, 5283.709395983258, 5285.286486324374, 5322.33470816148, 5554.527865131428, 5568.192612071308, 5568.470995255444, 5575.665460072328, 5604.915926261109, 5313.548348390353, 5326.44072372403, 5444.346678398618, 5526.834194974157, 5538.9169162462595, 4763.0473905218405, 4763.642726795504, 4768.6661933665, 4795.928061079087, 4810.831620893322, 5726.169705392695, 5731.541476681856, 5733.369329373765, 5739.971300143556, 5763.164341170591, 5541.972290138524, 5569.805056822992, 5627.915581266202, 5653.406392328746, 5669.433056694297, 5722.141678748221, 5761.769529218785, 5765.654060756368, 5774.39368866263, 5780.826575202751, 5474.507294343528, 5478.096114141282, 5505.807296744595, 5513.531349835149, 5548.889022219614, 5650.180723795109, 5717.742701578356, 5748.798792042258, 5765.538756899354, 5793.36273009977, 5637.52081073097, 5638.2670252866865, 5640.915386269127, 5673.234113394639, 5680.71596420169, 5482.451754824486, 5485.149801780731, 5654.7455364509515, 5661.773529058956, 5671.262735844314, 5540.196671482532, 5585.3297604287745, 5588.105903055492, 5589.385167631639, 5625.184348269559, 5635.492805647511, 5684.175794509855, 5686.317641882835, 5692.743826527733, 5694.943050569441, 5422.403535611158, 5455.1544510600925, 5498.092814685532, 5579.079451890392, 5604.663720176803], "unit": "score", "name": "dojo.html", "value": 5258.6144972466145}, {"lowerIsBetter": false, "replicates": [561.6377436553422, 569.7379205565443, 582.1355287398214, 582.7727186397309, 595.4670569839993, 38826.0, 39655.2068958621, 39705.20589588206, 39709.205815883666, 39711.0, 42962.14075718491, 43492.0, 43501.564984350145, 43667.0, 43674.781626091826, 8903.599338029804, 9228.6308547658, 9231.907680923172, 9239.168474837263, 9252.722418327461, 9063.95468022659, 9216.986131525528, 9222.446653200795, 9224.077592240756, 9228.16946474817, 9173.770655733593, 9223.308251881102, 9252.306077044215, 9260.444373337621, 9272.814543709123, 9144.588493517775, 9184.26525877935, 9198.586063627154, 9202.723918282461, 9220.0, 9105.317101217435, 9257.537123143884, 9265.583048762823, 9273.860892086625, 9276.11876871696, 43997.34003989943, 44793.104137917384, 44794.32808507875, 44837.775811121064, 45160.3225951611, 3691.1141326081815, 3792.9810350948346, 4088.5707000764787, 4292.270314046619, 4331.501877284121, 33500.83249583761, 33755.324893502235, 33932.6606733932, 33970.0, 33986.83006584976, 3590.35373632746, 3706.5737440194453, 3720.441933709938, 3759.6240375962457, 3780.243951209769, 286538.0, 287908.0, 288723.9999999979, 289760.0, 290639.0, 64551.35448645453, 66275.0, 66302.66848665726, 66343.33656663468, 66400.33599664038, 74033.62983185158, 74208.0, 74363.62818185982, 74470.62764686142, 74611.62694186495, 15349.386024559117, 15483.148426836407, 15566.066036037648, 15668.608284792743, 15700.842991570167, 12398.13213075094, 12507.749845003049, 12526.060545459128, 12526.749465010831, 12543.12198146121, 21668.674969875465, 21970.231041913456, 22071.227507037176, 22073.448163796034, 23165.0, 8611.827763444697, 8704.173103555153, 8744.310975154893, 8893.377463577617, 8893.732098315018, 1035.028271143473, 1046.6546039806844, 1114.7436089699252, 1122.231271578971, 1165.9098742675626, 30264.54603180954, 30359.089227323217, 30480.69519304823, 30800.845995770327, 30999.0700278992, 1117.8714447838602, 1149.4252873563219, 1159.3913195572393, 1255.3093903922438, 1270.7140893298933, 15799.842001580068, 15923.601909952344, 16064.196790160446, 16135.0, 16425.01449913009, 336411.0, 336511.0, 337687.0, 340556.0, 343650.0, 56046.43953560412, 57101.0, 57114.7144264276, 57809.4219057804, 57940.42059579435, 1297.8247936528448, 1403.8947078969118, 1407.3807524689105, 1498.992505037468, 1534.508957133729, 28153.296167595974, 30564.0, 30815.824531116974, 32507.34985300328, 33208.17355045399, 51477.22784158315, 51846.74076629593, 51864.0, 51952.48047519627, 51969.48030519646, 246803.0, 246837.0, 248452.0, 248893.0, 249093.0, 30489.23776905595, 34462.48306275358, 35006.19950404012, 35657.64342356543, 36196.4570531437, 44394.07946401099, 45061.77469112633, 45180.0, 45440.31839522344, 45630.0, 37095.629043710294, 37894.0, 38232.0, 38988.80505597454, 39099.218015640094, 37166.91156030375, 37768.244635106596, 37985.4302185473, 38002.239955201294, 38263.80868095753, 38164.61835381722, 38409.0, 42555.36166957436, 42889.0, 43427.34858977055, 31607.525887111253, 34041.978740637824, 34328.65671343354, 34570.0, 34591.481127783605, 27043.323916902234, 27568.724312756614, 27681.307967300174, 27763.861180693966, 27832.0], "unit": "score", "name": "ext.html", "value": 19811.91152990102}, {"lowerIsBetter": false, "replicates": [378.50037949906135, 380.5110433093475, 384.609621234447, 386.9129445874677, 389.38671592242224, 17623.471295861113, 18570.721439178422, 18808.2476700932, 18835.811641883578, 18868.150933208006, 17018.149092545384, 17692.557686057855, 17943.461696149105, 17968.820311796877, 17971.730424043617, 5437.483439073281, 5555.055640541118, 5566.053770858964, 5597.132444471114, 5619.353774315965, 4218.240716670998, 5520.254765606652, 5816.738246778905, 6039.4262545058145, 6069.726862291185, 5994.790182343619, 6005.12925625784, 6013.939860601382, 6014.699265036753, 6024.578279520435, 5782.768689252425, 5892.528597712173, 5904.970475147618, 5936.0, 5944.762209511636, 3803.6006219346846, 5101.897962040775, 5212.061828870839, 5285.814996475144, 5294.947050529522, 20343.0, 20672.276470323617, 20754.48113797152, 21119.788802111936, 21266.0, 2407.7471865454227, 2501.6372625969316, 2518.508890766301, 2540.5808041673104, 3093.9845300773577, 12733.108682392236, 13516.864831351659, 14050.156990580597, 14084.92957535216, 14302.355229148678, 1984.930527431533, 2004.6792513197963, 2050.733404657385, 2073.2018173003353, 2083.468715477559, 57748.71125644387, 60033.69814660192, 61392.69303653453, 61768.69115654438, 63175.68412157956, 10764.94617526923, 10848.294860834021, 10980.0, 11040.33757974508, 11118.55525778976, 14383.0, 14471.276436178148, 14479.276036198358, 14480.565583032527, 14509.564713058626, 8009.159038300894, 8149.633266502903, 8236.341092712568, 8301.709440169565, 8309.8338033239, 7939.722109726132, 7948.364130869517, 7960.243776841191, 8020.799480013046, 8068.8386232275025, 4690.249560070372, 4760.738159401266, 4760.785764640599, 4763.69036012658, 4807.975960120177, 1818.1091265279917, 1841.94088399171, 1852.8517718582482, 1889.6882014467733, 1905.3331334032978, 927.2581934452411, 945.5366870233536, 993.7416271769248, 1025.2771795883884, 1039.6257347354947, 17098.82901170997, 17148.314067437164, 17330.74003889943, 17549.649007020045, 17789.0, 980.5832521178471, 1002.7192386131894, 1030.1038096855634, 1045.9529321180564, 1052.768390953989, 9603.9039609603, 9868.506574671237, 10080.811802606117, 10187.643432479828, 10226.744331391776, 425839.0, 428791.0, 429078.0, 436191.0, 436414.0, 71652.28347716456, 71985.64007180036, 72648.0, 73206.16984575322, 73996.63001684957, 1047.5600247895902, 1047.9214058945608, 1075.6772968109535, 1090.2041509697806, 1109.2346281066039, 15149.545513634608, 15193.544193674208, 15206.391744330545, 15470.14914179686, 15478.148701821508, 31249.218769530944, 31945.0, 32007.67992320047, 32398.35203295968, 32655.510167347984, 47310.29034564553, 47678.0, 48005.279920800516, 48076.519234808606, 48498.5150148494, 8145.226203510657, 8282.71010514629, 8311.792205194919, 8341.290990265896, 8433.451825631315, 9740.512974351395, 12094.818577721166, 12783.61649150527, 12787.488500459878, 12840.972722182016, 10872.184586156229, 10991.450427478754, 11284.153688473561, 11320.716982075513, 11434.0, 10771.353718776898, 10777.461126943464, 10936.671899843017, 11019.779604408028, 11625.069994400259, 5488.067028605067, 7396.0, 9365.68880356737, 10775.407352595683, 11337.433128343715, 8099.716509922125, 8199.180081991753, 8276.917230827614, 8368.874466883124, 8604.569771511275, 10417.42704151279, 11111.333320000826, 11169.0, 11605.187636865337, 11710.94144529272], "unit": "score", "name": "jquery.html", "value": 8751.044949320394}, {"lowerIsBetter": false, "replicates": [1457.7376072306993, 1582.2168026826719, 1589.3960295087866, 1874.5032566369905, 2005.6690646043403, 7787.9221207787905, 7873.330766884822, 7936.76189714308, 7950.284474397303, 7957.72147974821, 8038.959805200966, 8272.172782721726, 8292.875606865886, 8303.543305118215, 8320.459170153936, 2063.6491796394575, 2291.2209848651455, 2329.3710698111586, 2347.495288512969, 2378.8096952243864, 2308.7922087012166, 2311.9422014449688, 2313.398516385735, 2317.8029867461287, 2319.698439202901, 2265.2411442166895, 2357.257463898875, 2366.8106551475926, 2369.857808531485, 2374.2283757778705, 2345.144022431817, 2372.893219805113, 2415.4685969086772, 2418.0811291709215, 2419.9274021779374, 2351.7648235176516, 2354.8116150708074, 2359.186080802138, 2373.4541055557147, 2388.235764555343, 8391.076981532027, 8428.367872409532, 8479.872801907977, 8491.74524764258, 8510.276626486757, 5080.364954380702, 5186.325777648919, 5196.558292545101, 5197.090509160919, 5203.5837133029645, 3176.8411579420936, 3261.2173078461237, 3270.16610764256, 3280.901572952815, 3360.0423879194555, 917.4495302818323, 921.7096614566457, 981.9459929703863, 987.6049580167991, 1045.8222102242637, 11571.594994175248, 11577.768444631145, 11615.941920290345, 11620.186586938918, 11621.360825154698, 4447.710898791568, 4500.662450316239, 4533.184026875128, 4568.33759104928, 4574.313852922089, 9933.850992235122, 10011.349262297927, 10040.297179197387, 10046.598136074621, 10086.646967356108, 4515.1195516873895, 5135.820246291362, 5170.508801663911, 5173.379194496684, 5175.741212939338, 4431.158079964796, 4456.108778244364, 4465.642748580106, 4466.955330446719, 4528.026474307973, 3877.806109694504, 3944.723869329177, 3950.545687245946, 3978.9403158952637, 4003.959960400417, 1233.7224124571899, 1275.0, 1277.8530468996184, 1279.3795009420423, 1290.7999260114698, 1408.1551069358304, 1431.0841061720507, 1435.7200345932652, 1445.262915912892, 1454.6872422429228, 8132.308753755879, 8149.022117345838, 8197.672093116327, 8199.0, 8205.58972051395, 487.1596496044366, 502.18645793814255, 514.8658809235698, 516.5247971865892, 518.419370305253, 6221.9377806222265, 6250.312465628777, 6259.186305780219, 6310.652914089677, 6338.366163383625, 9923.60305587783, 10279.640212592523, 10377.792444151075, 10393.428361440043, 10399.1160751337, 9890.604375824887, 10137.695869123938, 10184.338018028953, 10200.0, 10206.591736330463, 8030.156833532512, 8055.476394034369, 8092.71675491355, 8113.350931925432, 8157.428979971463, 7752.18602046777, 7810.0, 7815.491993020435, 7818.6481608328895, 7901.644426000728, 9150.542472876197, 9175.724728258163, 9230.815383692423, 9261.86107208379, 9405.576749046446, 9104.408213466104, 9475.526223688927, 9497.19273861702, 9524.904750952679, 9561.521923903916, 6625.768098116543, 7034.120734908137, 7193.280671932765, 7453.739119130804, 7578.734744283924, 7841.607919604111, 7843.176466471166, 7876.724314649189, 7895.644695988809, 7902.960485197767, 6969.233384327821, 7184.6048467334795, 7192.352688258082, 7275.599842008741, 7297.416206703557, 7087.964560177166, 7101.254368291255, 7130.0, 7156.427485801228, 7174.605396703231, 7474.289942455458, 7610.695572177272, 7622.8094297643, 7637.236276372319, 7652.808679782827, 6713.295104014203, 6725.293844146294, 6787.490938179558, 6836.623985680835, 6865.038894554867, 7006.894896576658, 7061.6822243000215, 7177.964110179416, 7205.603691797001, 7213.0], "unit": "score", "name": "mootools.html", "value": 4691.889807627355}, {"lowerIsBetter": false, "replicates": [344.45747946983505, 352.3850880214027, 359.2760587416355, 360.6591770776617, 366.86976123476165, 5867.1492633568105, 5903.911441328383, 5907.350191478939, 5943.227380440537, 5948.256467941507, 5878.353381128072, 5885.793997210088, 5887.941120588793, 5891.469767720904, 5895.263092113486, 4396.802143903532, 4413.382126502276, 4590.655700822435, 4616.099860527199, 4616.884577885546, 4556.066006468666, 4578.0, 4578.015726618776, 4579.9771001144945, 4606.309053641947, 4525.0, 4546.1589605922845, 4556.9088618227615, 4558.065596552716, 4571.3143028545655, 4352.129574085196, 4391.6267117295065, 4484.865454036384, 4509.503954564995, 4521.728696278234, 3965.8810235692977, 3966.8413263469715, 3975.9006024849323, 3979.2240513099955, 3983.980080099581, 5653.0, 5664.4618761218035, 5674.801381951612, 5678.205051292823, 5680.289963754531, 5259.631825772198, 5261.710605916673, 5273.0, 5274.4198138204765, 5283.599846040802, 6215.533834962396, 6217.440430361289, 6219.067139929001, 6228.128062071313, 6236.407541283571, 4216.915661686749, 4324.372965919955, 4330.350447432878, 4433.667474939392, 4443.7111587746695, 6462.773802916875, 6496.090547323379, 6512.2836487985805, 6516.641584712839, 6552.115464412291, 4403.656884650212, 4407.889802754957, 4410.735355878657, 4413.426254586883, 4416.11677664462, 4470.351798989128, 4470.9105817883465, 4471.128130014616, 4471.441069866267, 4474.7762611869275, 5189.532942035235, 5191.377034755854, 5193.5585475234275, 5196.194589838581, 5198.948010519922, 6042.912275790312, 6264.373562643699, 6287.339829317947, 6294.716737746812, 6304.779332723333, 1601.6876709041626, 1604.3502381535498, 1616.7817344658556, 1617.6522047759788, 1618.5387164658016, 1000.1998401278947, 1059.7191744187642, 1069.1286601419818, 1091.7761858818924, 1093.5243169221415, 6053.031514957585, 6101.969490152521, 6117.388261173847, 6132.754689812357, 6148.415900489446, 6457.773977910751, 6471.191101112361, 6473.643949582724, 6482.12491313676, 6494.545381823227, 6070.908936365958, 6102.4507794298725, 6106.084087386927, 6106.4809491192855, 6119.632822030692, 3449.913752156166, 3488.54648895647, 3497.283056973365, 3501.77238479498, 3502.562179727534, 6498.155239818793, 6664.833379165462, 6748.055272261888, 6796.184457865088, 6803.2856550062525, 6692.130023096966, 6706.0, 6708.3291670833505, 6710.563813352116, 6716.194056713226, 6767.93232067673, 6772.762953296611, 6774.119364482585, 6778.254392016875, 6784.287649796799, 6556.409923106943, 6605.768798092044, 6608.966955165193, 6615.636140012153, 6622.933770662232, 6242.469390101892, 6373.93626063752, 6393.584417012879, 6425.518086143651, 6435.871282574416, 6709.329067093252, 6757.493188011017, 6762.748891455097, 6810.5913645181445, 6815.2162501311, 4502.527234640446, 4537.4328208973875, 4537.909241815211, 4543.886402839956, 4544.250198717307, 6544.6727663617585, 6570.014497825365, 6574.967125164344, 6578.901316480353, 6585.143931289093, 6102.115193296859, 6309.432151106423, 6315.431611155018, 6321.431071203614, 6321.52588555851, 6315.5894866833505, 6361.2048493938255, 6372.044193371032, 6382.776602818879, 6391.041343798467, 6227.221597300338, 6241.31345551998, 6278.780242691484, 6279.623222606659, 6298.937010630018, 6357.078223657636, 6403.871922561616, 6412.487001039813, 6427.035944608346, 6428.935710642833, 5977.790777322773, 6030.7889223876955, 6103.05402662588, 6250.343713909974, 6253.906191407042], "unit": "score", "name": "prototype.html", "value": 4764.409402420628}, {"lowerIsBetter": false, "replicates": [849.7195925344637, 897.3135551303254, 910.4446287764458, 915.4370062411618, 959.3907868503501, 15156.317965691544, 15379.538613841574, 15393.615159621015, 15418.0, 15420.99763515372, 13321.400536975834, 13422.798658020138, 13438.059335846494, 13454.1927484351, 13472.595822125328, 771.4329967473902, 792.1009654042674, 794.1780257433558, 908.8046070094945, 923.8568021956573, 778.0352363069809, 915.9404638698496, 940.9905900940971, 941.4727752458645, 942.4675058591907, 983.2527279267772, 985.8176237396104, 986.595495846703, 988.0810845913297, 988.906053924876, 808.0747544062075, 822.7408366364635, 979.6277414582448, 980.2990861534001, 982.228950274035, 706.1526168597652, 713.4720306972803, 714.4927101757759, 714.9964250178767, 715.899774031636, 14441.133531988009, 14553.417863285562, 14582.0, 14628.488002919847, 14681.559553213421, 13291.800622990662, 13953.441862325495, 14005.439782408794, 14120.15279083248, 14224.502142424966, 10679.317152248444, 10848.294860834021, 11086.0, 11484.368359740294, 11623.709407264801, 4003.459532963071, 4005.4792876926103, 4015.036391266075, 4121.979390103061, 4123.773192474443, 52222.0, 52743.73628131835, 52962.0, 53057.2041419379, 53210.46789532094, 10762.838557421645, 10822.40476773785, 11066.667999960015, 11068.446577671084, 11189.732264437771, 19119.522011949535, 19257.614847703248, 19290.131944062552, 19327.323543676186, 19366.4190074298, 8342.833143337099, 8588.441751286146, 8590.87113693295, 8742.650293988168, 8903.643854245758, 4233.745975241495, 4466.531014243523, 4506.369108324837, 4596.655250856199, 4655.580997710223, 3259.9837000814846, 3349.69852713257, 3350.8827191048194, 3356.9761222826783, 3374.1395944034116, 602.8040886711836, 611.242059845788, 616.3897741236144, 621.832105331558, 622.2626187967273, 634.6826586706646, 646.7865604350553, 651.9869602607921, 690.7927621713466, 724.5326764237037, 9338.719838404859, 9431.76420589477, 9505.904940950502, 9727.270454715925, 9809.901900981042, 585.0872638683667, 655.8950567909112, 702.3959394920364, 708.3235510087957, 738.2691135775543, 4112.3420252759415, 4410.316400957857, 4451.154280686659, 4522.415602632288, 4536.9092618148115, 57361.0, 57708.71145644329, 58010.12984805231, 59210.70394647999, 59793.402065978786, 48451.75774121107, 52084.47915520872, 52618.47381526136, 53218.0, 53976.190357144675, 41732.79133604373, 42144.15711685749, 42294.57705422968, 42301.15397692029, 42825.0, 9395.154436100784, 9486.952565237405, 9542.141207291377, 9542.761430964281, 9600.087991640783, 33449.66550334466, 34289.31421371608, 34783.82608086943, 35131.824340878135, 35824.64175358213, 44576.331355029055, 44660.77669611761, 45242.773786130856, 45527.54472455233, 45637.54362456333, 11565.826512602149, 11581.305121692725, 11651.941740291244, 11834.940825295818, 12419.19275247106, 12080.39598020113, 13206.405711743188, 13534.255615941218, 13538.59384218475, 13599.0, 12816.102872798814, 12836.229826210458, 12843.486260549847, 12868.356582171042, 13223.140495867738, 11807.114466414881, 12730.618081457571, 12921.483140674267, 13224.074314798256, 13356.398962046536, 12600.306983116017, 12723.745525089631, 12734.61796146117, 12805.551805686757, 12880.806787898377, 10317.17462602975, 10359.274850760374, 10367.688969330931, 10470.777607758362, 10833.891661083604, 10163.339382940085, 10241.77098748155, 10514.07814706346, 10610.787784244427, 10621.628243011457], "unit": "score", "name": "yui.html", "value": 6810.127151518551}], "name": "dromaeo_css", "value": 7195.619687838456}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 110.0, 113.0, 112.0, 111.0, 102.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [157.0, 125.0, 153.0, 169.0, 131.0, 153.0, 151.0, 126.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 161.0, 164.0, 159.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 156.0, 74.0, 76.0, 74.0, 76.0, 157.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [100.0, 93.0, 142.0, 92.0, 94.0, 95.0, 139.0, 95.0, 95.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 55.0, 54.0, 58.0, 55.0, 63.0, 52.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 79.0, 78.0, 80.0, 79.0, 86.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [115.0, 111.0, 125.0, 110.0, 114.0, 116.0, 110.0, 114.0, 113.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.1}, {"lowerIsBetter": true, "replicates": [147.0, 143.0, 155.0, 146.0, 144.0, 132.0, 148.0, 156.0, 135.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 67.0, 68.0, 67.0, 68.0, 64.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1505.0999999999997}]} 17:25:47 INFO - Return code: 0 17:25:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:47 INFO - # TBPL SUCCESS # 17:25:47 INFO - Running post-action listener: _resource_record_post_action 17:25:47 INFO - Running post-run listener: _resource_record_post_run 17:25:48 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 498384896; Read time: 28; Write time: 426312 17:25:48 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244686848; Read time: 0; Write time: 313916 17:25:48 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253698048; Read time: 28; Write time: 112396 17:25:48 INFO - Running post-run listener: _upload_blobber_files 17:25:48 INFO - Blob upload gear active. 17:25:48 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:25:48 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 17:25:48 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:25:48 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:25:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:25:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:49 INFO - (blobuploader) - INFO - Done attempting. 17:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:25:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:50 INFO - (blobuploader) - INFO - Done attempting. 17:25:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:50 INFO - Return code: 0 17:25:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:25:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25ba79b18f12e36977ef6728ee035dcd2234b1ba9379c88c4f0ec00031b05ea415b5277ec2676236b41ab26b71e03e9bfaafbde9a0276c009284ccb9d5bfcba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290b9793b725e5105bd9287aa08df778f5120c08c47d9150de0acfa0bfd8657c8d6498bddfa4733e17b61038bac4f1088ffb6b528e69351ea1aac7261b94b3c1"} 17:25:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:25:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:25:50 INFO - Contents: 17:25:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25ba79b18f12e36977ef6728ee035dcd2234b1ba9379c88c4f0ec00031b05ea415b5277ec2676236b41ab26b71e03e9bfaafbde9a0276c009284ccb9d5bfcba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290b9793b725e5105bd9287aa08df778f5120c08c47d9150de0acfa0bfd8657c8d6498bddfa4733e17b61038bac4f1088ffb6b528e69351ea1aac7261b94b3c1"} 17:25:50 INFO - Running post-run listener: copy_logs_to_upload_dir 17:25:50 INFO - Copying logs to upload dir... 17:25:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:25:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.903004 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-16 17:25:50.400294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:25:50.404006) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 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-Aurora/sha512/25ba79b18f12e36977ef6728ee035dcd2234b1ba9379c88c4f0ec00031b05ea415b5277ec2676236b41ab26b71e03e9bfaafbde9a0276c009284ccb9d5bfcba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290b9793b725e5105bd9287aa08df778f5120c08c47d9150de0acfa0bfd8657c8d6498bddfa4733e17b61038bac4f1088ffb6b528e69351ea1aac7261b94b3c1"} build_url:https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/RPdpDmx4QAC7gL9_BkYAMw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25ba79b18f12e36977ef6728ee035dcd2234b1ba9379c88c4f0ec00031b05ea415b5277ec2676236b41ab26b71e03e9bfaafbde9a0276c009284ccb9d5bfcba6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/290b9793b725e5105bd9287aa08df778f5120c08c47d9150de0acfa0bfd8657c8d6498bddfa4733e17b61038bac4f1088ffb6b528e69351ea1aac7261b94b3c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:25:50.428196) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:25:50.428482) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1458172915.817432-1783049964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:25:50.511286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:25:50.511589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:25:50.511889) ========= ========= Total master_lag: 0.35 =========