builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1460456170.84 results: success (0) buildid: 20160412004019 builduid: 28004136ea0a409b8d9fc93910bb605a revision: def03a4832426d67b714fb6ccfbde9bf11dc55d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.835696) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.836046) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.836476) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.862923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.863186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.925009) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.925327) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.974619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.974881) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.975231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:10.975500) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 03:16:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-04-12 03:16:11 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118987 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.106351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.106644) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.155853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.156229) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev def03a4832426d67b714fb6ccfbde9bf11dc55d7 --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 def03a4832426d67b714fb6ccfbde9bf11dc55d7 --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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 03:16:11,608 truncating revision to first 12 chars 2016-04-12 03:16:11,608 Setting DEBUG logging. 2016-04-12 03:16:11,608 attempt 1/10 2016-04-12 03:16:11,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/def03a483242?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 03:16:12,042 unpacking tar archive at: mozilla-aurora-def03a483242/testing/mozharness/ program finished with exit code 0 elapsedTime=0.715348 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.886709) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.887365) ========= echo def03a4832426d67b714fb6ccfbde9bf11dc55d7 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'def03a4832426d67b714fb6ccfbde9bf11dc55d7'] 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False def03a4832426d67b714fb6ccfbde9bf11dc55d7 program finished with exit code 0 elapsedTime=0.004720 script_repo_revision: 'def03a4832426d67b714fb6ccfbde9bf11dc55d7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.940969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.941583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 03:16:11.952271) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-12 03:16:11.952547) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:12 INFO - MultiFileLogger online at 20160412 03:16:12 in /builds/slave/test-pgo 03:16:12 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 03:16:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:16:12 INFO - {'append_to_log': False, 03:16:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:16:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:16:12 INFO - 'branch': 'Mozilla-Aurora', 03:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:12 INFO - 'config_files': ('talos/linux_config.py',), 03:16:12 INFO - 'default_actions': ('clobber', 03:16:12 INFO - 'read-buildbot-config', 03:16:12 INFO - 'download-and-extract', 03:16:12 INFO - 'populate-webroot', 03:16:12 INFO - 'create-virtualenv', 03:16:12 INFO - 'install', 03:16:12 INFO - 'run-tests'), 03:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:12 INFO - 'download_minidump_stackwalk': True, 03:16:12 INFO - 'download_symbols': 'ondemand', 03:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:12 INFO - 'installer_path': 'installer.exe', 03:16:12 INFO - 'log_level': 'info', 03:16:12 INFO - 'log_name': 'talos', 03:16:12 INFO - 'log_to_console': True, 03:16:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:12 INFO - 'opt_config_files': (), 03:16:12 INFO - 'pip_index': False, 03:16:12 INFO - 'sps_profile': False, 03:16:12 INFO - 'sps_profile_interval': 0, 03:16:12 INFO - 'suite': 'dromaeojs', 03:16:12 INFO - 'system_bits': '32', 03:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:12 INFO - 'title': 'talos-linux64-ix-019', 03:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:12 INFO - 'use_talos_json': True, 03:16:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:12 INFO - 'work_dir': 'build'} 03:16:12 INFO - ##### 03:16:12 INFO - ##### Running clobber step. 03:16:12 INFO - ##### 03:16:12 INFO - Running pre-action listener: _resource_record_pre_action 03:16:12 INFO - Running main action method: clobber 03:16:12 INFO - rmtree: /builds/slave/test-pgo/build 03:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:16:13 INFO - Running post-action listener: _resource_record_post_action 03:16:13 INFO - ##### 03:16:13 INFO - ##### Running read-buildbot-config step. 03:16:13 INFO - ##### 03:16:13 INFO - Running pre-action listener: _resource_record_pre_action 03:16:13 INFO - Running main action method: read_buildbot_config 03:16:13 INFO - Using buildbot properties: 03:16:13 INFO - { 03:16:13 INFO - "project": "", 03:16:13 INFO - "product": "firefox", 03:16:13 INFO - "script_repo_revision": "production", 03:16:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:13 INFO - "repository": "", 03:16:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:16:13 INFO - "buildid": "20160412004019", 03:16:13 INFO - "stage_platform": "linux64-pgo", 03:16:13 INFO - "basedir": "/builds/slave/test-pgo", 03:16:13 INFO - "nightly_build": "True", 03:16:13 INFO - "buildnumber": 155, 03:16:13 INFO - "slavename": "talos-linux64-ix-019", 03:16:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:16:13 INFO - "platform": "ubuntu64_hw", 03:16:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:13 INFO - "branch": "mozilla-aurora", 03:16:13 INFO - "repo_path": "releases/mozilla-aurora", 03:16:13 INFO - "revision": "def03a4832426d67b714fb6ccfbde9bf11dc55d7", 03:16:13 INFO - "pgo_build": "True", 03:16:13 INFO - "builduid": "28004136ea0a409b8d9fc93910bb605a", 03:16:13 INFO - "slavebuilddir": "test" 03:16:13 INFO - } 03:16:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:16:13 INFO - Running post-action listener: _resource_record_post_action 03:16:13 INFO - ##### 03:16:13 INFO - ##### Running download-and-extract step. 03:16:13 INFO - ##### 03:16:13 INFO - Running pre-action listener: _resource_record_pre_action 03:16:13 INFO - Running main action method: download_and_extract 03:16:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:13 INFO - https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:15 INFO - Downloaded 1448 bytes. 03:16:15 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:16:15 INFO - Using the following test package requirements: 03:16:15 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:15 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:15 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:16:15 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'jsshell-linux-x86_64.zip'], 03:16:15 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:15 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:15 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:15 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:15 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:15 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:15 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:15 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:15 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:15 INFO - https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:21 INFO - Downloaded 23351181 bytes. 03:16: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'] 03:16: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 03:16:22 INFO - Return code: 0 03:16: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 03:16: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')]} 03:16:22 INFO - https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:24 INFO - Downloaded 23351181 bytes. 03:16:24 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'] 03:16:24 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 03:16:26 INFO - Return code: 0 03:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:26 INFO - https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:27 INFO - Downloaded 10845168 bytes. 03:16:27 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'] 03:16:27 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 03:16:27 INFO - Return code: 0 03:16:27 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')]} 03:16:27 INFO - https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HKqjgGl1RMyoT7-BesPzng/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 03:16:29 INFO - Downloaded 60554786 bytes. 03:16:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:16:29 INFO - mkdir: /builds/slave/test-pgo/properties 03:16:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:16:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:16:29 INFO - Contents: 03:16:29 INFO - build_url:https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:16:29 INFO - Running post-action listener: _resource_record_post_action 03:16:29 INFO - Running post-action listener: set_extra_try_arguments 03:16:29 INFO - ##### 03:16:29 INFO - ##### Running populate-webroot step. 03:16:29 INFO - ##### 03:16:29 INFO - Running pre-action listener: _resource_record_pre_action 03:16:29 INFO - Running main action method: populate_webroot 03:16:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:29 INFO - '--tppagecycles', 03:16:29 INFO - '7'], 03:16:29 INFO - 'tests': ['tsvgm']}}, 03:16:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:16:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:16:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'tests': ['damp', 'tps']}, 03:16:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['damp', 'tps']}, 03:16:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:16:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:29 INFO - 'other': {'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'other_l64': {'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'other_nol64': {'tests': ['a11yr', 03:16:29 INFO - 'ts_paint', 03:16:29 INFO - 'tpaint', 03:16:29 INFO - 'sessionrestore', 03:16:29 INFO - 'sessionrestore_no_auto_restore', 03:16:29 INFO - 'tabpaint']}, 03:16:29 INFO - 'svgr': {'tests': ['tsvgx', 03:16:29 INFO - 'tsvgr_opacity', 03:16:29 INFO - 'tart', 03:16:29 INFO - 'tscrollx', 03:16:29 INFO - 'cart']}, 03:16:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['tsvgx', 03:16:29 INFO - 'tsvgr_opacity', 03:16:29 INFO - 'tart', 03:16:29 INFO - 'tscrollx', 03:16:29 INFO - 'cart']}, 03:16:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'tests': ['tp5o']}, 03:16:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'talos_options': ['--e10s'], 03:16:29 INFO - 'tests': ['tp5o']}, 03:16:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'talos_options': ['--xperf_path', 03:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:29 INFO - 'tests': ['tp5n']}, 03:16:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:29 INFO - 'talos_options': ['--e10s', 03:16:29 INFO - '--xperf_path', 03:16:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:29 INFO - 'tests': ['tp5n']}}, 03:16:29 INFO - 'talos.zip': {'path': '', 03:16:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:29 INFO - Running post-action listener: _resource_record_post_action 03:16:29 INFO - ##### 03:16:29 INFO - ##### Running create-virtualenv step. 03:16:29 INFO - ##### 03:16:29 INFO - Running pre-action listener: _resource_record_pre_action 03:16:29 INFO - Running main action method: create_virtualenv 03:16:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:16:29 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 03:16:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:16:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:29 INFO - Using real prefix '/usr' 03:16:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:16:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:32 INFO - Installing pip.................done. 03:16:32 INFO - Return code: 0 03:16:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:32 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 03:16:32 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 03:16:32 INFO - Using env: {'DISPLAY': ':0', 03:16:32 INFO - 'HOME': '/home/cltbld', 03:16:32 INFO - 'LANG': 'en_US.UTF-8', 03:16:32 INFO - 'LANGUAGE': 'en_US:en', 03:16:32 INFO - 'LOGNAME': 'cltbld', 03:16:32 INFO - 'MAIL': '/var/mail/cltbld', 03:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:32 INFO - 'MOZ_NO_REMOTE': '1', 03:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:32 INFO - 'NO_EM_RESTART': '1', 03:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:32 INFO - 'SHELL': '/bin/bash', 03:16:32 INFO - 'SHLVL': '1', 03:16:32 INFO - 'TERM': 'linux', 03:16:32 INFO - 'TMOUT': '86400', 03:16:32 INFO - 'USER': 'cltbld', 03:16:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:32 INFO - '_': '/tools/buildbot/bin/python'} 03:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:32 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 03:16:32 INFO - Cleaning up... 03:16:32 INFO - Return code: 0 03:16:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:32 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:32 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 03:16:32 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 03:16:32 INFO - Using env: {'DISPLAY': ':0', 03:16:32 INFO - 'HOME': '/home/cltbld', 03:16:32 INFO - 'LANG': 'en_US.UTF-8', 03:16:32 INFO - 'LANGUAGE': 'en_US:en', 03:16:32 INFO - 'LOGNAME': 'cltbld', 03:16:32 INFO - 'MAIL': '/var/mail/cltbld', 03:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:32 INFO - 'MOZ_NO_REMOTE': '1', 03:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:32 INFO - 'NO_EM_RESTART': '1', 03:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:32 INFO - 'SHELL': '/bin/bash', 03:16:32 INFO - 'SHLVL': '1', 03:16:32 INFO - 'TERM': 'linux', 03:16:32 INFO - 'TMOUT': '86400', 03:16:32 INFO - 'USER': 'cltbld', 03:16:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:32 INFO - '_': '/tools/buildbot/bin/python'} 03:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:32 INFO - Downloading/unpacking psutil>=0.7.1 03:16:32 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 03:16:32 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 03:16:32 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 03:16:32 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 03:16:32 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 03:16:32 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 03:16:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:34 INFO - Installing collected packages: psutil 03:16:34 INFO - Running setup.py install for psutil 03:16:34 INFO - building 'psutil._psutil_linux' extension 03:16:34 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 03:16:35 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 03:16:35 INFO - building 'psutil._psutil_posix' extension 03:16:35 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 03:16:35 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 03:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:35 INFO - Successfully installed psutil 03:16:35 INFO - Cleaning up... 03:16:35 INFO - Return code: 0 03:16:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:35 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:35 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 03:16:35 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 03:16:35 INFO - Using env: {'DISPLAY': ':0', 03:16:35 INFO - 'HOME': '/home/cltbld', 03:16:35 INFO - 'LANG': 'en_US.UTF-8', 03:16:35 INFO - 'LANGUAGE': 'en_US:en', 03:16:35 INFO - 'LOGNAME': 'cltbld', 03:16:35 INFO - 'MAIL': '/var/mail/cltbld', 03:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:35 INFO - 'MOZ_NO_REMOTE': '1', 03:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:35 INFO - 'NO_EM_RESTART': '1', 03:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:35 INFO - 'SHELL': '/bin/bash', 03:16:35 INFO - 'SHLVL': '1', 03:16:35 INFO - 'TERM': 'linux', 03:16:35 INFO - 'TMOUT': '86400', 03:16:35 INFO - 'USER': 'cltbld', 03:16:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:35 INFO - '_': '/tools/buildbot/bin/python'} 03:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:16:35 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 03:16:35 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 03:16:35 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 03:16:35 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 03:16:35 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 03:16:35 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 03:16:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:16:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:16:37 INFO - Installing collected packages: mozsystemmonitor 03:16:37 INFO - Running setup.py install for mozsystemmonitor 03:16:37 INFO - Successfully installed mozsystemmonitor 03:16:37 INFO - Cleaning up... 03:16:37 INFO - Return code: 0 03:16:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:16: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')]} 03:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:16: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 blobuploader==1.2.4 03:16:37 INFO - Using env: {'DISPLAY': ':0', 03:16:37 INFO - 'HOME': '/home/cltbld', 03:16:37 INFO - 'LANG': 'en_US.UTF-8', 03:16:37 INFO - 'LANGUAGE': 'en_US:en', 03:16:37 INFO - 'LOGNAME': 'cltbld', 03:16:37 INFO - 'MAIL': '/var/mail/cltbld', 03:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:37 INFO - 'MOZ_NO_REMOTE': '1', 03:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:37 INFO - 'NO_EM_RESTART': '1', 03:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:37 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:37 INFO - 'SHELL': '/bin/bash', 03:16:37 INFO - 'SHLVL': '1', 03:16:37 INFO - 'TERM': 'linux', 03:16:37 INFO - 'TMOUT': '86400', 03:16:37 INFO - 'USER': 'cltbld', 03:16:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:37 INFO - '_': '/tools/buildbot/bin/python'} 03:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:39 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 03:16:39 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 03:16:39 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 03:16:39 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 03:16:39 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 03:16:39 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 03:16:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:16:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:40 INFO - Downloading docopt-0.6.1.tar.gz 03:16:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:40 INFO - Running setup.py install for blobuploader 03:16:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:16:40 INFO - Running setup.py install for requests 03:16:40 INFO - Running setup.py install for docopt 03:16:41 INFO - Successfully installed blobuploader requests docopt 03:16:41 INFO - Cleaning up... 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:41 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 03:16:41 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 03:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:41 INFO - Running setup.py (path:/tmp/pip-pItWaW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:41 INFO - Running setup.py (path:/tmp/pip-Cn7QHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:41 INFO - Running setup.py (path:/tmp/pip-dGTA0v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:41 INFO - Running setup.py (path:/tmp/pip-W75ChH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:41 INFO - Running setup.py (path:/tmp/pip-gpqaSF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:41 INFO - Running setup.py (path:/tmp/pip-EVLGnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:41 INFO - Running setup.py (path:/tmp/pip-DUJNjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:41 INFO - Running setup.py (path:/tmp/pip-RrvVee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:41 INFO - Running setup.py (path:/tmp/pip-dA4kUS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:42 INFO - Running setup.py (path:/tmp/pip-LTdT8h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:42 INFO - Running setup.py (path:/tmp/pip-7kZgRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:42 INFO - Running setup.py (path:/tmp/pip-UKy_Ea-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:42 INFO - Running setup.py (path:/tmp/pip-_BE3yX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:42 INFO - Running setup.py (path:/tmp/pip-6AdrvM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:42 INFO - Running setup.py (path:/tmp/pip-YsnxnK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:42 INFO - Running setup.py (path:/tmp/pip-CUy3OX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:42 INFO - Running setup.py (path:/tmp/pip-0wpDzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:42 INFO - Running setup.py install for manifestparser 03:16:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:16:42 INFO - Running setup.py install for mozcrash 03:16:42 INFO - Running setup.py install for mozdebug 03:16:42 INFO - Running setup.py install for mozdevice 03:16:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozfile 03:16:43 INFO - Running setup.py install for mozhttpd 03:16:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozinfo 03:16:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozInstall 03:16:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozleak 03:16:43 INFO - Running setup.py install for mozlog 03:16:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for moznetwork 03:16:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozprocess 03:16:43 INFO - Running setup.py install for mozprofile 03:16:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:16:43 INFO - Running setup.py install for mozrunner 03:16:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:16:44 INFO - Running setup.py install for mozscreenshot 03:16:44 INFO - Running setup.py install for moztest 03:16:44 INFO - Running setup.py install for mozversion 03:16:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:16:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:44 INFO - Cleaning up... 03:16:44 INFO - Return code: 0 03:16:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:44 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')]} 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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')]} 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:44 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 03:16:44 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 03:16:44 INFO - Using env: {'DISPLAY': ':0', 03:16:44 INFO - 'HOME': '/home/cltbld', 03:16:44 INFO - 'LANG': 'en_US.UTF-8', 03:16:44 INFO - 'LANGUAGE': 'en_US:en', 03:16:44 INFO - 'LOGNAME': 'cltbld', 03:16:44 INFO - 'MAIL': '/var/mail/cltbld', 03:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:44 INFO - 'MOZ_NO_REMOTE': '1', 03:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:44 INFO - 'NO_EM_RESTART': '1', 03:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:44 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:44 INFO - 'SHELL': '/bin/bash', 03:16:44 INFO - 'SHLVL': '1', 03:16:44 INFO - 'TERM': 'linux', 03:16:44 INFO - 'TMOUT': '86400', 03:16:44 INFO - 'USER': 'cltbld', 03:16:44 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:44 INFO - '_': '/tools/buildbot/bin/python'} 03:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:44 INFO - Running setup.py (path:/tmp/pip-z4tpJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:16:44 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)) 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:44 INFO - Running setup.py (path:/tmp/pip-M87yLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:16:44 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)) 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:44 INFO - Running setup.py (path:/tmp/pip-L15LOY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:16:44 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)) 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:44 INFO - Running setup.py (path:/tmp/pip-72ub7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:16:44 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)) 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:44 INFO - Running setup.py (path:/tmp/pip-AtrMvz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:16:44 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)) 03:16:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:44 INFO - Running setup.py (path:/tmp/pip-4C3qga-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:45 INFO - Running setup.py (path:/tmp/pip-2DbTJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:45 INFO - Running setup.py (path:/tmp/pip-vFKR4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:45 INFO - Running setup.py (path:/tmp/pip-uCMFUe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:45 INFO - Running setup.py (path:/tmp/pip-dOXaIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:45 INFO - Running setup.py (path:/tmp/pip-iYhcRt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:45 INFO - Running setup.py (path:/tmp/pip-SBVXYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:45 INFO - Running setup.py (path:/tmp/pip-NdWEoB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:45 INFO - Running setup.py (path:/tmp/pip-k4kXzT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:45 INFO - Running setup.py (path:/tmp/pip-vzXxGB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:45 INFO - Running setup.py (path:/tmp/pip-dMZzmK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:16:45 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)) 03:16:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:45 INFO - Running setup.py (path:/tmp/pip-SVZ83n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:16:45 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)) 03:16:45 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)) 03:16:45 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)) 03:16:45 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)) 03:16:45 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)) 03:16:45 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)) 03:16:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:47 INFO - Downloading blessings-1.6.tar.gz 03:16:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:47 INFO - Installing collected packages: blessings 03:16:47 INFO - Running setup.py install for blessings 03:16:47 INFO - Successfully installed blessings 03:16:47 INFO - Cleaning up... 03:16:47 INFO - Return code: 0 03:16:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:16:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:16:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:16:48 INFO - Reading from file tmpfile_stdout 03:16:48 INFO - Current package versions: 03:16:48 INFO - argparse == 1.2.1 03:16:48 INFO - blessings == 1.6 03:16:48 INFO - blobuploader == 1.2.4 03:16:48 INFO - docopt == 0.6.1 03:16:48 INFO - manifestparser == 1.1 03:16:48 INFO - mozInstall == 1.12 03:16:48 INFO - mozcrash == 0.17 03:16:48 INFO - mozdebug == 0.1 03:16:48 INFO - mozdevice == 0.48 03:16:48 INFO - mozfile == 1.2 03:16:48 INFO - mozhttpd == 0.7 03:16:48 INFO - mozinfo == 0.9 03:16:48 INFO - mozleak == 0.1 03:16:48 INFO - mozlog == 3.1 03:16:48 INFO - moznetwork == 0.27 03:16:48 INFO - mozprocess == 0.22 03:16:48 INFO - mozprofile == 0.28 03:16:48 INFO - mozrunner == 6.11 03:16:48 INFO - mozscreenshot == 0.1 03:16:48 INFO - mozsystemmonitor == 0.0 03:16:48 INFO - moztest == 0.7 03:16:48 INFO - mozversion == 1.4 03:16:48 INFO - psutil == 3.1.1 03:16:48 INFO - requests == 1.2.3 03:16:48 INFO - wsgiref == 0.1.2 03:16:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 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 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:48 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 03:16:48 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 03:16:48 INFO - Using env: {'DISPLAY': ':0', 03:16:48 INFO - 'HOME': '/home/cltbld', 03:16:48 INFO - 'LANG': 'en_US.UTF-8', 03:16:48 INFO - 'LANGUAGE': 'en_US:en', 03:16:48 INFO - 'LOGNAME': 'cltbld', 03:16:48 INFO - 'MAIL': '/var/mail/cltbld', 03:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:48 INFO - 'MOZ_NO_REMOTE': '1', 03:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:48 INFO - 'NO_EM_RESTART': '1', 03:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:48 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:48 INFO - 'SHELL': '/bin/bash', 03:16:48 INFO - 'SHLVL': '1', 03:16:48 INFO - 'TERM': 'linux', 03:16:48 INFO - 'TMOUT': '86400', 03:16:48 INFO - 'USER': 'cltbld', 03:16:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:48 INFO - '_': '/tools/buildbot/bin/python'} 03:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 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)) 03:16:48 INFO - Cleaning up... 03:16:48 INFO - Return code: 0 03:16:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:16:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:16:48 INFO - Using env: {'DISPLAY': ':0', 03:16:48 INFO - 'HOME': '/home/cltbld', 03:16:48 INFO - 'LANG': 'en_US.UTF-8', 03:16:48 INFO - 'LANGUAGE': 'en_US:en', 03:16:48 INFO - 'LOGNAME': 'cltbld', 03:16:48 INFO - 'MAIL': '/var/mail/cltbld', 03:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:48 INFO - 'MOZ_NO_REMOTE': '1', 03:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:48 INFO - 'NO_EM_RESTART': '1', 03:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:48 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:48 INFO - 'SHELL': '/bin/bash', 03:16:48 INFO - 'SHLVL': '1', 03:16:48 INFO - 'TERM': 'linux', 03:16:48 INFO - 'TMOUT': '86400', 03:16:48 INFO - 'USER': 'cltbld', 03:16:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:48 INFO - '_': '/tools/buildbot/bin/python'} 03:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:48 INFO - Downloading/unpacking jsonschema 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:50 INFO - Downloading/unpacking functools32 (from jsonschema) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:50 INFO - warning: no files found matching '*.txt' 03:16:50 INFO - no previously-included directories found matching 'build' 03:16:50 INFO - no previously-included directories found matching 'dist' 03:16:50 INFO - no previously-included directories found matching '.git*' 03:16:50 INFO - Installing collected packages: jsonschema, functools32 03:16:50 INFO - Running setup.py install for functools32 03:16:50 INFO - warning: no files found matching '*.txt' 03:16:50 INFO - no previously-included directories found matching 'build' 03:16:50 INFO - no previously-included directories found matching 'dist' 03:16:50 INFO - no previously-included directories found matching '.git*' 03:16:50 INFO - Successfully installed jsonschema functools32 03:16:50 INFO - Cleaning up... 03:16:50 INFO - Return code: 0 03:16:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:16:50 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')]} 03:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:50 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')]} 03:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2206b6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a626d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', '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 03:16:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:16:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:16:51 INFO - Using env: {'DISPLAY': ':0', 03:16:51 INFO - 'HOME': '/home/cltbld', 03:16:51 INFO - 'LANG': 'en_US.UTF-8', 03:16:51 INFO - 'LANGUAGE': 'en_US:en', 03:16:51 INFO - 'LOGNAME': 'cltbld', 03:16:51 INFO - 'MAIL': '/var/mail/cltbld', 03:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:51 INFO - 'MOZ_NO_REMOTE': '1', 03:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:51 INFO - 'NO_EM_RESTART': '1', 03:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:16:51 INFO - 'PWD': '/builds/slave/test-pgo', 03:16:51 INFO - 'SHELL': '/bin/bash', 03:16:51 INFO - 'SHLVL': '1', 03:16:51 INFO - 'TERM': 'linux', 03:16:51 INFO - 'TMOUT': '86400', 03:16:51 INFO - 'USER': 'cltbld', 03:16:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:51 INFO - '_': '/tools/buildbot/bin/python'} 03:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:51 INFO - Downloading/unpacking flake8 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:16:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:16:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:16:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:53 INFO - no previously-included directories found matching 'docs/_build' 03:16:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:16:53 INFO - Running setup.py install for pep8 03:16:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:53 INFO - no previously-included directories found matching 'docs/_build' 03:16:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:16:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:16:53 INFO - Cleaning up... 03:16:54 INFO - Return code: 0 03:16:54 INFO - Running post-action listener: _resource_record_post_action 03:16:54 INFO - Running post-action listener: _start_resource_monitoring 03:16:54 INFO - Starting resource monitoring. 03:16:54 INFO - ##### 03:16:54 INFO - ##### Running install step. 03:16:54 INFO - ##### 03:16:54 INFO - Running pre-action listener: _resource_record_pre_action 03:16:54 INFO - Running main action method: install 03:16:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:16:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:16:54 INFO - Reading from file tmpfile_stdout 03:16:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:16:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:16:54 INFO - Reading from file tmpfile_stdout 03:16:54 INFO - Output received: 03:16:54 INFO - Usage: mozinstall [options] installer 03:16:54 INFO - Options: 03:16:54 INFO - -h, --help show this help message and exit 03:16:54 INFO - -d DEST, --destination=DEST 03:16:54 INFO - Directory to install application into. [default: 03:16:54 INFO - "/builds/slave/test-pgo"] 03:16:54 INFO - --app=APP Application being installed. [default: firefox] 03:16:54 INFO - mkdir: /builds/slave/test-pgo/build/application 03:16:54 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'] 03:16:54 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 03:17:09 INFO - Reading from file tmpfile_stdout 03:17:09 INFO - Output received: 03:17:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:17:09 INFO - Running post-action listener: _resource_record_post_action 03:17:09 INFO - ##### 03:17:09 INFO - ##### Running run-tests step. 03:17:09 INFO - ##### 03:17:09 INFO - Running pre-action listener: _resource_record_pre_action 03:17:09 INFO - Running main action method: run_tests 03:17:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:17:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:17:09 INFO - Python 2.7.3 03:17:09 INFO - Return code: 0 03:17:09 INFO - grabbing minidump binary from tooltool 03:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:09 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 0x1af1920>, '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 0x1af2820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1af2cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:17:09 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 03:17:09 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 03:17:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:09 INFO - Return code: 0 03:17:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:17:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:17:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:17:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:17:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:17:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:17:10 INFO - Return code: 0 03:17:10 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/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:17:10 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/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 03:17:10 INFO - Using env: {'DISPLAY': ':0', 03:17:10 INFO - 'HOME': '/home/cltbld', 03:17:10 INFO - 'LANG': 'en_US.UTF-8', 03:17:10 INFO - 'LANGUAGE': 'en_US:en', 03:17:10 INFO - 'LOGNAME': 'cltbld', 03:17:10 INFO - 'MAIL': '/var/mail/cltbld', 03:17:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:10 INFO - 'MOZ_NO_REMOTE': '1', 03:17:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:17:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:10 INFO - 'NO_EM_RESTART': '1', 03:17:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:17:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:17:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:17:10 INFO - 'SHELL': '/bin/bash', 03:17:10 INFO - 'SHLVL': '1', 03:17:10 INFO - 'TERM': 'linux', 03:17:10 INFO - 'TMOUT': '86400', 03:17:10 INFO - 'USER': 'cltbld', 03:17:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852', 03:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:10 INFO - '_': '/tools/buildbot/bin/python'} 03:17:10 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/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 03:17:10 INFO - mozversion application_buildid: 20160412004019 03:17:10 INFO - mozversion application_changeset: def03a4832426d67b714fb6ccfbde9bf11dc55d7 03:17:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:10 INFO - mozversion application_name: Firefox 03:17:10 INFO - mozversion application_remotingname: firefox-dev 03:17:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:10 INFO - mozversion application_vendor: Mozilla 03:17:10 INFO - mozversion application_version: 47.0a2 03:17:10 INFO - mozversion platform_buildid: 20160412004019 03:17:10 INFO - mozversion platform_changeset: def03a4832426d67b714fb6ccfbde9bf11dc55d7 03:17:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:10 INFO - mozversion platform_version: 47.0a2 03:17:10 INFO - using testdate: 1460456230 03:17:10 INFO - actual date: 1460456230 03:17:10 INFO - starting webserver on 'localhost:60650' 03:17:10 INFO - SUITE-START | Running 2 tests 03:17:10 INFO - TEST-START | dromaeo_css 03:17:10 INFO - operating with platform_type : linux_ 03:17:10 INFO - Initialising browser for dromaeo_css test... 03:17:10 INFO - TEST-INFO | started process 18969 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTqEOCV/profile http://localhost:60650/getInfo.html) 03:17:15 INFO - PROCESS | 18969 | __metrics Screen width/height:1600/1200 03:17:15 INFO - PROCESS | 18969 | colorDepth:24 03:17:15 INFO - PROCESS | 18969 | Browser inner width/height: 1024/697 03:17:15 INFO - PROCESS | 18969 | __metrics 03:17:16 INFO - PROCESS | 18969 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:17 INFO - TEST-INFO | 18969: exit 0 03:17:17 INFO - Browser initialized. 03:17:17 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:17 INFO - TEST-INFO | started process 19059 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTqEOCV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:29 INFO - PROCESS | 19059 | RSS: Main: 142249984 03:17:29 INFO - PROCESS | 19059 | 03:18:20 INFO - PROCESS | 19059 | 1460456300596 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] 03:20:28 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60650/tests/dromaeo/cssquery-ext.html) 03:20:29 INFO - PROCESS | 19059 | RSS: Main: 258588672 03:20:29 INFO - PROCESS | 19059 | 03:23:31 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-ext.html (next: http://localhost:60650/tests/dromaeo/cssquery-jquery.html) 03:23:31 INFO - PROCESS | 19059 | RSS: Main: 225906688 03:23:31 INFO - PROCESS | 19059 | 03:26:33 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60650/tests/dromaeo/cssquery-mootools.html) 03:26:34 INFO - PROCESS | 19059 | RSS: Main: 215314432 03:26:34 INFO - PROCESS | 19059 | 03:29:36 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60650/tests/dromaeo/cssquery-prototype.html) 03:29:36 INFO - PROCESS | 19059 | RSS: Main: 206979072 03:29:36 INFO - PROCESS | 19059 | 03:32:39 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60650/tests/dromaeo/cssquery-yui.html) 03:32:39 INFO - PROCESS | 19059 | RSS: Main: 205471744 03:32:39 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | Cycle 1(1): loaded http://localhost:60650/tests/dromaeo/cssquery-yui.html (next: http://localhost:60650/tests/dromaeo/cssquery-dojo.html) 03:35:42 INFO - PROCESS | 19059 | RSS: Main: 251199488 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | __start_tp_report 03:35:42 INFO - PROCESS | 19059 | _x_x_mozilla_page_load 03:35:42 INFO - PROCESS | 19059 | _x_x_mozilla_page_load_details 03:35:42 INFO - PROCESS | 19059 | |i|pagename|runs| 03:35:42 INFO - PROCESS | 19059 | |0;dojo.html;3222.274988127671;3303.702666759991;3317.900462986111;3318.3197444523876;3355.580552430946;5387.4343193964605;5397.2443857859935;5415.10650742627;5424.8372548823545;5456.972715136429;5367.141257398817;5422.593305502083;5439.428859969706;5440.537554307879;5442.6462279951775;4833.444153922291;4935.111679897617;4980.651354405193;5010.549050585447;5049.3435853339015;4888.9511104889025;4990.800367985276;5003.074431230216;5006;5007.649464537484;4950.282209079682;5008.549230569248;5009.148444764399;5011.072951503965;5013.298138260647;4894.975525122351;4907.846656035828;4912.926306105412;4918.827841025547;4931.112399768041;4772.80908763649;4856.611471082305;4937.80248790048;4953;4964.751762411901;5195.7142357170715;5201.219817027439;5204.947950520522;5214.947850521484;5226.608004399647;5686.715664216814;5783.88432231353;5859.091840764689;5859.1797148399255;5861.618994765369;5898.616589921684;5902.232709747748;5912.438318359749;5924.881502369928;5951.256092988377;5517.420670829545;5526.751296191641;5527.281453411071;5533.3083364579425;5536.280283563111;5777.768889244468;5933.821985340447;5972.820815375546;6013.579049466495;6014.368491308437;5700.828975130753;5702.714864256771;5707.828765137053;5708.429157084342;5711.771529138788;5788.739506722208;5832.125181222766;5833.7374818133285;5840.970795145997;5846.035404158351;5717.8570535736935;5837.7956771513645;5900.114982752536;5915.792947246826;5923.614965027259;5692.402297758758;5696.8006119785605;5699.715014249271;5703.144528320702;5704.429557044263;4364.694471387036;4438.378626992224;4446.177457170369;4446.577575130357;4471.552844715502;4023.436718859362;4050.5746896576024;4058.6144316289906;4061.6547593454297;4105.055837157471;5577.860553486195;5601.047821870292;5601.747921343549;5608.130739735348;5608.46719561641;5746.913796293059;5810.796622118206;5817.127430885316;5899.528037756969;5905.675187864623;5478.479544443271;5481.123020316731;5490.423505531861;5502.0371434998715;5529.087700529448;4939;4941.530554597308;4942.283368911488;4943.332650092263;4969.652124351261;5951.613145145551;5979.043353063489;5990.400959903975;6058.697065146725;6128.1975860127295;5838.503727183237;5858.7070646468355;5865.090910908816;5869.589128760946;5872.354041055566;6050.818475445743;6072.574919755575;6076.361981991828;6077.361877002851;6079.787207447718;5653.971730141323;5733.512651424676;5763.682997435014;5821.825345239649;5845.09401042839;5837.912431313449;5848.912266316093;5866.208061911588;5868.471837534642;5869.090291004901;5704.714764261853;5720.399358067343;5722.62802917809;5725.742341594721;5730.054541000855;5531.502164805187;5661.858453538694;5701.230333904869;5709.771609135588;5746.195532625352;5588.273524441796;5599.776008959596;5607.943920560742;5629.6903670298525;5634.661920284796;5578.665280083208;5663.66018038919;5709.743061562157;5726.398728133486;5738.024535829002;5467.261919640798;5566.916496252478;5602.411746766531;5649.435056494318;5686.289213848269 03:35:42 INFO - PROCESS | 19059 | |1;ext.html;570.3640440908389;571.6741457369301;573.9799107031255;644.085398733798;646.6055706019328;38488.61511384886;38819.22361552767;38844.61155388445;38846.41730374047;38981.610183898156;41514.58485415145;41992.16015679685;42012.159756804926;42088.15823683532;42090.15819683605;8699.391042627003;8849.026607073216;8900.73297801067;8913.153250441197;8915.598798054103;8712.215900568948;8834.028256891737;8851.468911865277;8851.77870553238;8853.867191992125;9033.728988130366;9117.316201284897;9135.588898499584;9142.542872856364;9144.131307525775;8970.910290897105;8972.416792908505;8977.955110224473;8983.10168983103;8984.371094023389;9019.368644194908;9168.174864262248;9230.169284764337;9231.953840230823;9256.39833410833;44340.3348949766;44953;44964.550354496365;44966;44995.325070123974;2845.3029007893197;3908.6286802753693;3943.3296339622334;3944.349182384903;4009.578994205625;31076.533851992237;31503.36993260122;31673;31819.522707159413;31951.6804831951;3881.3013657541633;3953.3081710700512;4031.2743706132883;4044.090079732066;4047.433359329696;248502;248759;248947.9999999982;248970;249621;62214.37785622176;62381.68809155925;62688;62810;62847.6857615709;63320.36679633237;72188.63905680439;73237;73339.63330183421;73357;16819;16927.15364231808;17044.914775426045;17065.488035358958;17070;12298.20061695987;12310.569130080405;12410.875891241152;12466.563670271496;12984.15602985803;20588.485287867625;20781.792182077985;20935;21008.159673612885;21667;6797.456203503708;7408.666610002563;7439.330460258603;7782.338501227346;7817.140114587391;919.8850143732034;979.299800642544;1000.7448100734266;1009.3792317724547;1101.3942331717524;30769;30865;31069.223269418446;31274.68725312763;31386.52920206199;1101.4437708956925;1107;1107.9058280046124;1118.7930232906938;1120.7310245541012;15832.208389580705;16371.754423683655;16484.258208380652;16502.83497165013;16632.58418539522;332708;334027;335092;336294;340248;58120;58727;59261.11108333379;59347.40652593419;59414.70292648509;1391.7146984868077;1422.3101795629111;1436.4756863744867;1454.2074569359725;1471.5585324402637;27295.863520683062;29043.27391815137;29646;30205.244868878453;30551.388972219986;46134;46502.30246546372;46560.767196163804;46588.30117548172;46592.301115482616;202107;205511;206207;451792;460339;34902.476462853585;35584.93245202648;36452.45321320235;37724.81137594295;38404.23191536209;45173.54826451693;45527;45980.31029534493;46069.30896036629;46120;37378.8131059343;38066.429003564415;38276.80861595785;38404.039899002746;38950.4157437633;36410.27179456343;36923;37184.07039823918;37496.62503374931;37556.436653450764;39309.41035884407;39585.20829583335;39822.800885995384;39950.2009959805;40233.79883100566;31095.222619434695;31125.844370778002;32958.50562241521;34697.826510867286;34763.30473390569;26584.468310633292;26718.866405667846;26903.923843046843;26911.596326054732;27150.45699085968 03:35:42 INFO - PROCESS | 19059 | |2;jquery.html;361.11706876686503;367.3497908701597;372.3056499628194;384.60193699521;386.34900193174485;17591.648167036667;18370.632587348246;19164.712529312055;19484.512887177792;19549.413517594494;17243.655126897454;18085.1861666225;18911.24355025801;18927.242910283607;18934.147963341682;5595.860103497404;5759.856003599902;5788.710564471759;5794.188813566083;5798.9130163047375;4349.369341445488;5663.745131469073;5991.550633702468;6197.721102550374;6247.406496382836;6169.845753856167;6183.628982261056;6185.783497577586;6194;6219.378062193789;5885.764569417261;6099.420555047285;6150.2927163376335;6155.415235552638;6158.261008678965;3890.1830615570766;5157.793688252503;5408;5476.91784623231;5480.314960629921;21104.788952110437;21457.570848582942;21812.45468863291;21962.560748784934;21974.560508789735;2429.356220601542;2433.549793288247;2446.1805295226122;2752.9174124776287;2813.5779633055;13907.652308692364;14019.369128389248;14109.435622575085;14153.150810951272;14556.927215363856;1918.2710569983456;1925.643755905148;1943.805619438059;1949.2397964793743;1999.5001249687577;69538.65230673815;69974.30025699729;71174;71629.2837071633;72267.63866180688;9394.67118650844;9396.95301523488;9938.950305248427;10016.399016058915;10235.692929212135;13718.38267277975;14148.787768183485;14176.85823141776;14192.787108193384;14200.431982720782;8069.314108300743;8209.753707388787;8211.34309255258;8262.17378262169;8277.255047045795;8246.422750407533;8251.504909705436;8508.404411691246;8595.112348041612;8665.870011949826;6106.6336019838955;6132.110843927606;6165.383461653889;6188.535859810532;6225.62646241227;1696.4316953820608;1738.1135620833213;1744.3545888021513;1763.6208215233787;1825.4158669225985;1000.444753162002;1005.6731562242301;1006.8036732837173;1080.3247970018738;1082.118073769875;17663.20515576802;18098;18493.167807448695;18697.345592904185;19289.228430862888;1002.6691191906654;1007.1942446043137;1035.337384074193;1075.5805235957982;1080.8162612355918;10674.306170098918;11104.389258590694;11114.055305298978;11162.274452160584;11174.553017879194;456686;466833;467121;476431;478207;78905.21094789094;79697;81996.59001704953;82050.58974705088;82366;1088.0968795899385;1088.6189833558192;1108.2076315434342;1111.1721767283425;1115.0243536905207;16933.068681222157;17101;17158.31366745366;17162.22769975329;17260.482185534453;33982;34416.82791586026;35285.29429411346;35317.646823532465;36013;48535.271970919755;48978.75510622424;49022;49367.506324936294;49763.75118124531;8074.515529068275;8278.254957053894;8285.585720714062;8343.99872015362;8411;9665;13724.794128088286;13887.027908046744;13975.161490310615;14131.293435328398;11294.491747871201;12007.879921201025;12060.939695301468;12315.19951203169;12465.875341246472;11953.462094205956;12140.715132555793;12267.938660306641;12282.570110046105;12379.566715164927;10820.134389248684;11082.667519974413;11091.667249982513;11159.10727141843;11451.141164412536;8692.478451292942;8698.826023479622;8735.082816304197;8770.342224333073;8889.599968001585;10288.434136122585;11261.887381126411;11529.538818447169;11809.940950295193;11986.101042422028 03:35:42 INFO - PROCESS | 19059 | |3;mootools.html;1435.260840667056;1593.7928069350983;1616.1757503673127;1868.7103498957658;1959.3827944197585;8062.71780487683;8207.794805129875;8209.50742955423;8212.671493140275;8234.711785087531;8152.5516096614665;8309.376796740238;8316.37627177961;8317.958410207955;8319.750407487785;2120.120150137691;2169.858959167657;2424.5514579802707;2439.4755127647554;2442.426029882976;2438.4757277185404;2485.3538080099124;2486.018022880961;2487.7139129000216;2487.751224877516;2405.8315917885757;2415.6014257647466;2434.1237154624323;2460.938476538083;2465.1372019793107;2454.619533972237;2463.0147940823636;2469.839460435066;2473.4311108444977;2488.8631125288102;2458.397692565315;2466.2231397109854;2475.900963961439;2502.436951685874;2507.3731567108225;8106.594670266522;8161.102278749333;8166.632501537445;8171.877421838677;8175.427720059598;5175.404828444702;5302.390225124122;5331.466853314676;5340.172273297645;5342.305500284938;3162.778605497616;3180.093673303121;3246.3119178027296;3276.3283526876935;3284.770066095374;982.8132654795565;983.9065288797552;996.5764550066266;999.7050869993369;1013.3565186106802;11487.42562871853;11647.825282620852;11659.650210493613;11668.1832271741;11679.357635330054;4581.931271030937;4662.953370466252;4745.95254047462;4750.643701722384;4777.4983626718695;9959.153471954965;9965.950170249247;9982.850257246148;10003.199744020607;10010.149137323264;5302.973485132627;5309.309789727388;5329.946700532945;5341.626086174008;5351.331083614548;4204.726692764961;4538.568835960578;4613.746243956614;4633.837815676435;4848.975755121272;3897.785621790829;3998.2403343364667;4014.41790940312;4020.1557672888434;4073.837046518106;1280.713925642742;1286.7812471879804;1304.791233402651;1309.5416604188458;1321.0092430676991;1142.731458107344;1148.655403378983;1379.5999160243416;1410.8236470441195;1436.727021865842;7719.65261563231;7746.49647772893;7754.069511658637;7769.106552746393;7792.220777922275;534.7593582887716;542.5795008868158;544.083219774673;548.410458756838;554.7281831902338;5912.142739302777;5916.408359164136;5932.5550583705535;5945;5992.670403127782;10022.54898529568;10242.231832612584;10375.221858360654;10375.740606484898;10382.273240873066;9926.900730992598;10044.598216071421;10240.283180177465;10245.231607629457;10272.691819245434;8018.599070046591;8028.277455028959;8054.355651547862;8125.878111828328;8127.756167314872;7439.144498382755;7477;7482.1021477423055;7484.700611975678;7546.584937828472;8897.332700047393;9103.954480227556;9338.206252468617;9383.718488445358;9392.718218453458;9291.67479138227;9318.301127415607;9496.14534691881;9725.6596019139;9725.708228752866;6608.867822643424;7110.146782386147;7252.419806415369;7559.5464272143845;7667.424943129399;7867.134615192439;7871.0554733432355;7880.881786773089;7886.250806173404;7923.762287131395;6936.618485983117;7149.499535032706;7185.856282874418;7218.494705370574;7362.77911662651;6946.37482626566;6994.755183568551;7017.649117544204;7077.5753454792875;7097.574145551283;7447.180810110992;7518.060242469692;7593.924060759322;7673;7679.385649147943;6988.266232045562;6992.056072430157;7006.194287656985;7007.964960175166;7023.22744498115;6833.180018397824;6854.5201835873;6858.451323894176;6873.725050997904;6885.690143943434 03:35:42 INFO - PROCESS | 19059 | |4;prototype.html;339.85216430852597;347.258602882845;356.99107522311954;364.2859994410955;366.61139192456;6057.515398768099;6091.482224010959;6096.1160631708435;6102.87794244116;6139.72371243294;5998.970005149979;6003.939960600393;6007.15899774032;6007.519398448125;6011.128386383983;4549;4587.701799383046;4660.883477913046;4729.881752956169;4731.976340118312;4693.48371679115;4708.058388322349;4711.599514041311;4718.315844202589;4718.7168769873915;4659.697119687209;4685.742284174369;4692.108499385123;4693.88265293367;4703.176944034797;4511.390962220107;4581.40441742573;4619.330197121432;4629.120467111272;4632.374629425019;4113.218488487178;4114.403411505345;4128.339465685476;4157.729747566398;4192.958070419288;5617.747201375948;5662.49037586615;5665.5467562594895;5667.716614169275;5668.57485688575;5443.782248710047;5452.236686863842;5452.345718513764;5464.863378415532;5467.480589344006;6297.2128483939505;6330.715117819709;6332.335104813974;6339.049142628596;6340.556161068727;4321.697481176319;4491.910161796778;4501.987052913101;4506.977465112686;4577.359169716243;6591.209054913441;6618.536702430783;6640.900386494206;6653.999999999952;6656.633885136315;4595.2188128018315;4596.977015114903;4597.609203217764;4598.402207713043;4603.769811509478;4647.535246475325;4648.953510464852;4651.883702907455;4656.534346565317;4671.906561868812;5337.973310133424;5339.733013349317;5340;5344.358676958712;5375.81184658535;6234.501239900797;6335.461485773761;6348.016057511093;6371.235451745728;6404.391582799627;1628.080134723877;1639.6884591927496;1648.9257983390776;1649.62883351245;1652.5538104711661;1038.3510306058713;1075.9139268858473;1081.8214994525972;1107.916906232036;1112.777444511101;6114.174586430864;6133.723982420713;6222.844428889223;6241.625502469867;6242.563020588515;6542.869142617121;6552.8361790955605;6553.672316384162;6555.180602424697;6563.737450501926;6181.381861813783;6198.318184999646;6201.348858369896;6213.347598502092;6219.253689557282;3435.639257877937;3492.947605785915;3526.7178625710394;3536.469529570585;3549.254656522159;6494.545381823227;6621.9006714899315;6649.700763465656;6736.090627765189;6778.593284402951;6644.96677516619;6649.268580456146;6664.766733164316;6715.630640314732;6810.38706516406;6858;6871.622060786704;6871.793846184622;6877.89683154753;6885.2770459101075;6525.575837570543;6649.434798042221;6651.301613330531;6663.067170596218;6664.400203981665;6542.34576542342;6552.737890484518;6553.279139294769;6554.868902621825;6559.14731084975;6857.931420685729;6862.656867156722;6886.380225779503;6886.48351373659;6903.1716194055025;4589.541045895384;4598.195315819785;4604.217283061955;4606.654500912512;4613.653975951885;6637.369449902251;6642.136522252076;6642.634655094016;6642.867142657024;6644.335566443317;6105.297890742621;6276.843078923063;6284.528660350584;6347.523935704933;6463;6349.523785716182;6357.268914074941;6449.806505804833;6452.12896258999;6452.9677351612945;6336.144620476177;6341.397567231105;6346.397092276226;6355.078513615407;6355.491560675043;6470;6473.482121430368;6483.870322593428;6484.059811327237;6487.124238227779;6120.44915957566;6306.369363063657;6308.463780578702;6308.589941653778;6310.905336420049 03:35:42 INFO - PROCESS | 19059 | |5;yui.html;772.9304362607364;898.6809682562689;902.3895512788798;902.5852620720777;927.2535608834885;14852.33164507597;14944.925275373635;15017.699646007073;15036.473723419682;15086.245687715626;13904.374303156357;13941.790873136912;14021.228832414214;14094.154350738938;14170.29148542574;773.4701729315409;914.7072936660271;915.8076803871195;926.2589928057561;933.1368484152132;921.0283151275402;928.5542939389097;934.1919239857542;934.6775362499926;935.2377812083164;952.5142177489461;960.875086238788;961.9759506012371;965.9130678238957;966.3573723473882;800.5636927874293;813.1746277528314;813.5647428625657;941.3786900645575;947.7914858731068;711.0649495912858;712.248577750473;712.5261700968849;712.7612249896291;713.561159886666;14884.479043233436;14976.026558273677;15002.62493437662;15013.624659383602;15036.548903532912;14439.494617688331;14592.854071459256;14652.560423187322;14907.850921490755;15048.097114173075;11632.651020469399;11891.881081189164;11939.641810745692;11953.940230298793;12222.449989750483;3890.280298144824;3909.0954200367137;3929.5088113985753;3957.742746721454;4019;51619.48380516222;52724.73637631826;52916.206256906175;52932.47067529352;52964.47035529634;11588.594399195988;11696.356700381391;11700.414979251003;11713.824292635447;11861.525538978516;20436;20441.080151392925;20530.794692053187;20620.69068963967;20666;8301.211384918422;8312.501249925024;8344.499330040217;8386.748397548083;8706.695265665798;4456.997175635521;4817.9036419271415;4822.324874517571;4826.420829500483;4934.259861020875;3231.579894613732;3260.1523603863166;3271.1004473769904;3286.605607327136;3287.8849240276477;613.355976224962;613.4172536090642;621.7481919822479;622.4273668225153;652.7813182583888;523.581055523484;552.4972275229521;586.9618474799124;595.9761609535657;613.7176898626592;8412.284955778827;8618.913810861937;8775.605097770616;9156.725298241063;9401.858972115424;608.656109298245;608.8174587068328;623.3268070483866;627.0562802981575;635.5271559169778;4111.650509706648;4141.343462614978;4219.578042195756;4308.763018034038;4334.284843000933;59933;59993;60631.696841516394;61031;61116.38883611107;52695;53808;53811.73094134504;56197.43802562004;57387.426125739046;47201.5279847204;48594;49446.752766236656;52246.47753522416;52734;8474.74575762728;8546.78633034179;8789;8853.557322133996;9214.216791572791;37063.8146809275;37352.62647373491;38178.80910595429;38337.616623833404;38424.2315153701;43998.560014399445;44006.779966099966;48297.517024830704;48518.272225915935;48804.26793598028;12029.278243305429;12377.938110309391;12534;12605.810912836498;12660.683482912633;11770.941145294219;12562.560310389092;12896.742065158456;12972.221666700028;13661.79507307411;11860.76278474443;12077.879221208026;12117.69705757363;12298.323592202514;12588.685282868002;12223.816642750187;12228.327441990776;12795.296258705861;12815.679608009874;12884.742305154032;10862.34825910448;11362.431878406212;11376.94311528437;12024.75950480968;12150.939245304071;10222.693319200138;10414.895851041696;10519.211059170746;10520.894791051991;10977.670669879917;10228.181745460197;10377.645084338754;10483.0041146091;10513.474326283807;10582.735431614272 03:35:42 INFO - PROCESS | 19059 | __end_tp_report 03:35:42 INFO - PROCESS | 19059 | __start_cc_report 03:35:42 INFO - PROCESS | 19059 | _x_x_mozilla_cycle_collect,931 03:35:42 INFO - PROCESS | 19059 | __end_cc_report 03:35:42 INFO - PROCESS | 19059 | __startTimestamp1460457342513__endTimestamp 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | ------- Summary: start ------- 03:35:42 INFO - PROCESS | 19059 | Number of tests: 6 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#0] dojo.html Cycles:165 Average:5412.75 Median:5608.47 stddev:598.35 (10.7%) stddev-sans-first:574.98 03:35:42 INFO - PROCESS | 19059 | Values: 3222.3 3303.7 3317.9 3318.3 3355.6 5387.4 5397.2 5415.1 5424.8 5457.0 5367.1 5422.6 5439.4 5440.5 5442.6 4833.4 4935.1 4980.7 5010.5 5049.3 4889.0 4990.8 5003.1 5006.0 5007.6 4950.3 5008.5 5009.1 5011.1 5013.3 4895.0 4907.8 4912.9 4918.8 4931.1 4772.8 4856.6 4937.8 4953.0 4964.8 5195.7 5201.2 5204.9 5214.9 5226.6 5686.7 5783.9 5859.1 5859.2 5861.6 5898.6 5902.2 5912.4 5924.9 5951.3 5517.4 5526.8 5527.3 5533.3 5536.3 5777.8 5933.8 5972.8 6013.6 6014.4 5700.8 5702.7 5707.8 5708.4 5711.8 5788.7 5832.1 5833.7 5841.0 5846.0 5717.9 5837.8 5900.1 5915.8 5923.6 5692.4 5696.8 5699.7 5703.1 5704.4 4364.7 4438.4 4446.2 4446.6 4471.6 4023.4 4050.6 4058.6 4061.7 4105.1 5577.9 5601.0 5601.7 5608.1 5608.5 5746.9 5810.8 5817.1 5899.5 5905.7 5478.5 5481.1 5490.4 5502.0 5529.1 4939.0 4941.5 4942.3 4943.3 4969.7 5951.6 5979.0 5990.4 6058.7 6128.2 5838.5 5858.7 5865.1 5869.6 5872.4 6050.8 6072.6 6076.4 6077.4 6079.8 5654.0 5733.5 5763.7 5821.8 5845.1 5837.9 5848.9 5866.2 5868.5 5869.1 5704.7 5720.4 5722.6 5725.7 5730.1 5531.5 5661.9 5701.2 5709.8 5746.2 5588.3 5599.8 5607.9 5629.7 5634.7 5578.7 5663.7 5709.7 5726.4 5738.0 5467.3 5566.9 5602.4 5649.4 5686.3 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#1] ext.html Cycles:180 Average:48192.97 Median:38898.42 stddev:80747.24 (207.6%) stddev-sans-first:80894.58 03:35:42 INFO - PROCESS | 19059 | Values: 570.4 571.7 574.0 644.1 646.6 38488.6 38819.2 38844.6 38846.4 38981.6 41514.6 41992.2 42012.2 42088.2 42090.2 8699.4 8849.0 8900.7 8913.2 8915.6 8712.2 8834.0 8851.5 8851.8 8853.9 9033.7 9117.3 9135.6 9142.5 9144.1 8970.9 8972.4 8978.0 8983.1 8984.4 9019.4 9168.2 9230.2 9232.0 9256.4 44340.3 44953.0 44964.6 44966.0 44995.3 2845.3 3908.6 3943.3 3944.3 4009.6 31076.5 31503.4 31673.0 31819.5 31951.7 3881.3 3953.3 4031.3 4044.1 4047.4 248502.0 248759.0 248948.0 248970.0 249621.0 62214.4 62381.7 62688.0 62810.0 62847.7 63320.4 72188.6 73237.0 73339.6 73357.0 16819.0 16927.2 17044.9 17065.5 17070.0 12298.2 12310.6 12410.9 12466.6 12984.2 20588.5 20781.8 20935.0 21008.2 21667.0 6797.5 7408.7 7439.3 7782.3 7817.1 919.9 979.3 1000.7 1009.4 1101.4 30769.0 30865.0 31069.2 31274.7 31386.5 1101.4 1107.0 1107.9 1118.8 1120.7 15832.2 16371.8 16484.3 16502.8 16632.6 332708.0 334027.0 335092.0 336294.0 340248.0 58120.0 58727.0 59261.1 59347.4 59414.7 1391.7 1422.3 1436.5 1454.2 1471.6 27295.9 29043.3 29646.0 30205.2 30551.4 46134.0 46502.3 46560.8 46588.3 46592.3 202107.0 205511.0 206207.0 451792.0 460339.0 34902.5 35584.9 36452.5 37724.8 38404.2 45173.5 45527.0 45980.3 46069.3 46120.0 37378.8 38066.4 38276.8 38404.0 38950.4 36410.3 36923.0 37184.1 37496.6 37556.4 39309.4 39585.2 39822.8 39950.2 40233.8 31095.2 31125.8 32958.5 34697.8 34763.3 26584.5 26718.9 26903.9 26911.6 27150.5 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#2] jquery.html Cycles:180 Average:27415.86 Median:12201.96 stddev:76933.39 (630.5%) stddev-sans-first:77122.39 03:35:42 INFO - PROCESS | 19059 | Values: 361.1 367.3 372.3 384.6 386.3 17591.6 18370.6 19164.7 19484.5 19549.4 17243.7 18085.2 18911.2 18927.2 18934.1 5595.9 5759.9 5788.7 5794.2 5798.9 4349.4 5663.7 5991.6 6197.7 6247.4 6169.8 6183.6 6185.8 6194.0 6219.4 5885.8 6099.4 6150.3 6155.4 6158.3 3890.2 5157.8 5408.0 5476.9 5480.3 21104.8 21457.6 21812.5 21962.6 21974.6 2429.4 2433.5 2446.2 2752.9 2813.6 13907.7 14019.4 14109.4 14153.2 14556.9 1918.3 1925.6 1943.8 1949.2 1999.5 69538.7 69974.3 71174.0 71629.3 72267.6 9394.7 9397.0 9939.0 10016.4 10235.7 13718.4 14148.8 14176.9 14192.8 14200.4 8069.3 8209.8 8211.3 8262.2 8277.3 8246.4 8251.5 8508.4 8595.1 8665.9 6106.6 6132.1 6165.4 6188.5 6225.6 1696.4 1738.1 1744.4 1763.6 1825.4 1000.4 1005.7 1006.8 1080.3 1082.1 17663.2 18098.0 18493.2 18697.3 19289.2 1002.7 1007.2 1035.3 1075.6 1080.8 10674.3 11104.4 11114.1 11162.3 11174.6 456686.0 466833.0 467121.0 476431.0 478207.0 78905.2 79697.0 81996.6 82050.6 82366.0 1088.1 1088.6 1108.2 1111.2 1115.0 16933.1 17101.0 17158.3 17162.2 17260.5 33982.0 34416.8 35285.3 35317.6 36013.0 48535.3 48978.8 49022.0 49367.5 49763.8 8074.5 8278.3 8285.6 8344.0 8411.0 9665.0 13724.8 13887.0 13975.2 14131.3 11294.5 12007.9 12060.9 12315.2 12465.9 11953.5 12140.7 12267.9 12282.6 12379.6 10820.1 11082.7 11091.7 11159.1 11451.1 8692.5 8698.8 8735.1 8770.3 8889.6 10288.4 11261.9 11529.5 11809.9 11986.1 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#3] mootools.html Cycles:180 Average:5849.24 Median:551.57 stddev:3075.91 (557.7%) stddev-sans-first:3066.64 03:35:42 INFO - PROCESS | 19059 | Values: 1435.3 1593.8 1616.2 1868.7 1959.4 8062.7 8207.8 8209.5 8212.7 8234.7 8152.6 8309.4 8316.4 8318.0 8319.8 2120.1 2169.9 2424.6 2439.5 2442.4 2438.5 2485.4 2486.0 2487.7 2487.8 2405.8 2415.6 2434.1 2460.9 2465.1 2454.6 2463.0 2469.8 2473.4 2488.9 2458.4 2466.2 2475.9 2502.4 2507.4 8106.6 8161.1 8166.6 8171.9 8175.4 5175.4 5302.4 5331.5 5340.2 5342.3 3162.8 3180.1 3246.3 3276.3 3284.8 982.8 983.9 996.6 999.7 1013.4 11487.4 11647.8 11659.7 11668.2 11679.4 4581.9 4663.0 4746.0 4750.6 4777.5 9959.2 9966.0 9982.9 10003.2 10010.1 5303.0 5309.3 5329.9 5341.6 5351.3 4204.7 4538.6 4613.7 4633.8 4849.0 3897.8 3998.2 4014.4 4020.2 4073.8 1280.7 1286.8 1304.8 1309.5 1321.0 1142.7 1148.7 1379.6 1410.8 1436.7 7719.7 7746.5 7754.1 7769.1 7792.2 534.8 542.6 544.1 548.4 554.7 5912.1 5916.4 5932.6 5945.0 5992.7 10022.5 10242.2 10375.2 10375.7 10382.3 9926.9 10044.6 10240.3 10245.2 10272.7 8018.6 8028.3 8054.4 8125.9 8127.8 7439.1 7477.0 7482.1 7484.7 7546.6 8897.3 9104.0 9338.2 9383.7 9392.7 9291.7 9318.3 9496.1 9725.7 9725.7 6608.9 7110.1 7252.4 7559.5 7667.4 7867.1 7871.1 7880.9 7886.3 7923.8 6936.6 7149.5 7185.9 7218.5 7362.8 6946.4 6994.8 7017.6 7077.6 7097.6 7447.2 7518.1 7593.9 7673.0 7679.4 6988.3 6992.1 7006.2 7008.0 7023.2 6833.2 6854.5 6858.5 6873.7 6885.7 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#4] prototype.html Cycles:180 Average:5368.25 Median:6117.31 stddev:1600.43 (26.2%) stddev-sans-first:1559.78 03:35:42 INFO - PROCESS | 19059 | Values: 339.9 347.3 357.0 364.3 366.6 6057.5 6091.5 6096.1 6102.9 6139.7 5999.0 6003.9 6007.2 6007.5 6011.1 4549.0 4587.7 4660.9 4729.9 4732.0 4693.5 4708.1 4711.6 4718.3 4718.7 4659.7 4685.7 4692.1 4693.9 4703.2 4511.4 4581.4 4619.3 4629.1 4632.4 4113.2 4114.4 4128.3 4157.7 4193.0 5617.7 5662.5 5665.5 5667.7 5668.6 5443.8 5452.2 5452.3 5464.9 5467.5 6297.2 6330.7 6332.3 6339.0 6340.6 4321.7 4491.9 4502.0 4507.0 4577.4 6591.2 6618.5 6640.9 6654.0 6656.6 4595.2 4597.0 4597.6 4598.4 4603.8 4647.5 4649.0 4651.9 4656.5 4671.9 5338.0 5339.7 5340.0 5344.4 5375.8 6234.5 6335.5 6348.0 6371.2 6404.4 1628.1 1639.7 1648.9 1649.6 1652.6 1038.4 1075.9 1081.8 1107.9 1112.8 6114.2 6133.7 6222.8 6241.6 6242.6 6542.9 6552.8 6553.7 6555.2 6563.7 6181.4 6198.3 6201.3 6213.3 6219.3 3435.6 3492.9 3526.7 3536.5 3549.3 6494.5 6621.9 6649.7 6736.1 6778.6 6645.0 6649.3 6664.8 6715.6 6810.4 6858.0 6871.6 6871.8 6877.9 6885.3 6525.6 6649.4 6651.3 6663.1 6664.4 6542.3 6552.7 6553.3 6554.9 6559.1 6857.9 6862.7 6886.4 6886.5 6903.2 4589.5 4598.2 4604.2 4606.7 4613.7 6637.4 6642.1 6642.6 6642.9 6644.3 6105.3 6276.8 6284.5 6347.5 6463.0 6349.5 6357.3 6449.8 6452.1 6453.0 6336.1 6341.4 6346.4 6355.1 6355.5 6470.0 6473.5 6483.9 6484.1 6487.1 6120.4 6306.4 6308.5 6308.6 6310.9 03:35:42 INFO - PROCESS | 19059 | 03:35:42 INFO - PROCESS | 19059 | [#5] yui.html Cycles:180 Average:14926.04 Median:44002.67 stddev:17039.04 (38.7%) stddev-sans-first:17053.69 03:35:42 INFO - PROCESS | 19059 | Values: 772.9 898.7 902.4 902.6 927.3 14852.3 14944.9 15017.7 15036.5 15086.2 13904.4 13941.8 14021.2 14094.2 14170.3 773.5 914.7 915.8 926.3 933.1 921.0 928.6 934.2 934.7 935.2 952.5 960.9 962.0 965.9 966.4 800.6 813.2 813.6 941.4 947.8 711.1 712.2 712.5 712.8 713.6 14884.5 14976.0 15002.6 15013.6 15036.5 14439.5 14592.9 14652.6 14907.9 15048.1 11632.7 11891.9 11939.6 11953.9 12222.4 3890.3 3909.1 3929.5 3957.7 4019.0 51619.5 52724.7 52916.2 52932.5 52964.5 11588.6 11696.4 11700.4 11713.8 11861.5 20436.0 20441.1 20530.8 20620.7 20666.0 8301.2 8312.5 8344.5 8386.7 8706.7 4457.0 4817.9 4822.3 4826.4 4934.3 3231.6 3260.2 3271.1 3286.6 3287.9 613.4 613.4 621.7 622.4 652.8 523.6 552.5 587.0 596.0 613.7 8412.3 8618.9 8775.6 9156.7 9401.9 608.7 608.8 623.3 627.1 635.5 4111.7 4141.3 4219.6 4308.8 4334.3 59933.0 59993.0 60631.7 61031.0 61116.4 52695.0 53808.0 53811.7 56197.4 57387.4 47201.5 48594.0 49446.8 52246.5 52734.0 8474.7 8546.8 8789.0 8853.6 9214.2 37063.8 37352.6 38178.8 38337.6 38424.2 43998.6 44006.8 48297.5 48518.3 48804.3 12029.3 12377.9 12534.0 12605.8 12660.7 11770.9 12562.6 12896.7 12972.2 13661.8 11860.8 12077.9 12117.7 12298.3 12588.7 12223.8 12228.3 12795.3 12815.7 12884.7 10862.3 11362.4 11376.9 12024.8 12150.9 10222.7 10414.9 10519.2 10520.9 10977.7 10228.2 10377.6 10483.0 10513.5 10582.7 03:35:42 INFO - PROCESS | 19059 | -------- Summary: end -------- 03:35:42 INFO - PROCESS | 19059 | 03:35:43 INFO - TEST-INFO | 19059: exit 0 03:35:43 INFO - TEST-OK | dromaeo_css | took 1112377ms 03:35:43 INFO - TEST-START | kraken 03:35:43 INFO - operating with platform_type : linux_ 03:35:43 INFO - Initialising browser for kraken test... 03:35:43 INFO - TEST-INFO | started process 19249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLQqkhI/profile http://localhost:60650/getInfo.html) 03:35:47 INFO - PROCESS | 19249 | __metrics Screen width/height:1600/1200 03:35:47 INFO - PROCESS | 19249 | colorDepth:24 03:35:47 INFO - PROCESS | 19249 | Browser inner width/height: 1024/697 03:35:47 INFO - PROCESS | 19249 | __metrics 03:35:48 INFO - PROCESS | 19249 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:49 INFO - TEST-INFO | 19249: exit 0 03:35:49 INFO - Browser initialized. 03:35:49 INFO - Running cycle 1/1 for kraken test... 03:35:49 INFO - TEST-INFO | started process 19342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLQqkhI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:01 INFO - PROCESS | 19342 | RSS: Main: 141733888 03:36:01 INFO - PROCESS | 19342 | 03:36:03 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60650/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:04 INFO - PROCESS | 19342 | RSS: Main: 177909760 03:36:04 INFO - PROCESS | 19342 | 03:36:06 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60650/tests/kraken/driver.html?testName=audio-dft) 03:36:07 INFO - PROCESS | 19342 | RSS: Main: 175091712 03:36:07 INFO - PROCESS | 19342 | 03:36:10 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60650/tests/kraken/driver.html?testName=audio-fft) 03:36:10 INFO - PROCESS | 19342 | RSS: Main: 173551616 03:36:10 INFO - PROCESS | 19342 | 03:36:12 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60650/tests/kraken/driver.html?testName=audio-oscillator) 03:36:13 INFO - PROCESS | 19342 | RSS: Main: 174505984 03:36:13 INFO - PROCESS | 19342 | 03:36:15 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:16 INFO - PROCESS | 19342 | RSS: Main: 172421120 03:36:16 INFO - PROCESS | 19342 | 03:36:19 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60650/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:19 INFO - PROCESS | 19342 | RSS: Main: 172392448 03:36:19 INFO - PROCESS | 19342 | 03:36:23 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60650/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:23 INFO - PROCESS | 19342 | RSS: Main: 173076480 03:36:23 INFO - PROCESS | 19342 | 03:36:26 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60650/tests/kraken/driver.html?testName=json-parse-financial) 03:36:27 INFO - PROCESS | 19342 | RSS: Main: 172888064 03:36:27 INFO - PROCESS | 19342 | 03:36:28 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:29 INFO - PROCESS | 19342 | RSS: Main: 176943104 03:36:29 INFO - PROCESS | 19342 | 03:36:31 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:31 INFO - PROCESS | 19342 | RSS: Main: 175198208 03:36:31 INFO - PROCESS | 19342 | 03:36:33 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:34 INFO - PROCESS | 19342 | RSS: Main: 180514816 03:36:34 INFO - PROCESS | 19342 | 03:36:36 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:37 INFO - PROCESS | 19342 | RSS: Main: 187621376 03:36:37 INFO - PROCESS | 19342 | 03:36:39 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:40 INFO - PROCESS | 19342 | RSS: Main: 186163200 03:36:40 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | Cycle 1(1): loaded http://localhost:60650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60650/tests/kraken/driver.html?testName=ai-astar) 03:36:42 INFO - PROCESS | 19342 | RSS: Main: 247902208 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | __start_tp_report 03:36:42 INFO - PROCESS | 19342 | _x_x_mozilla_page_load 03:36:42 INFO - PROCESS | 19342 | _x_x_mozilla_page_load_details 03:36:42 INFO - PROCESS | 19342 | |i|pagename|runs| 03:36:42 INFO - PROCESS | 19342 | |0;ai-astar;110;111;106;110;113;111;102;109;110;109 03:36:42 INFO - PROCESS | 19342 | |1;audio-beat-detection;154;127;157;186;133;153;149;129;170;135 03:36:42 INFO - PROCESS | 19342 | |2;audio-dft;160;162;161;162;161;162;160;166;161;160 03:36:42 INFO - PROCESS | 19342 | |3;audio-fft;76;76;76;161;75;77;76;76;161;76 03:36:42 INFO - PROCESS | 19342 | |4;audio-oscillator;92;100;144;93;93;93;143;93;93;148 03:36:42 INFO - PROCESS | 19342 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 03:36:42 INFO - PROCESS | 19342 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;146;145 03:36:42 INFO - PROCESS | 19342 | |7;imaging-desaturate;96;95;95;96;95;96;96;95;96;95 03:36:42 INFO - PROCESS | 19342 | |8;json-parse-financial;57;61;58;57;58;58;58;65;56;56 03:36:42 INFO - PROCESS | 19342 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;64;65;64 03:36:42 INFO - PROCESS | 19342 | |10;stanford-crypto-aes;78;78;79;79;79;79;78;77;85;78 03:36:42 INFO - PROCESS | 19342 | |11;stanford-crypto-ccm;111;112;111;117;118;112;118;112;113;109 03:36:42 INFO - PROCESS | 19342 | |12;stanford-crypto-pbkdf2;144;133;142;143;144;137;147;147;148;149 03:36:42 INFO - PROCESS | 19342 | |13;stanford-crypto-sha256-iterative;69;68;66;68;65;69;65;66;68;66 03:36:42 INFO - PROCESS | 19342 | __end_tp_report 03:36:42 INFO - PROCESS | 19342 | __start_cc_report 03:36:42 INFO - PROCESS | 19342 | _x_x_mozilla_cycle_collect,1033 03:36:42 INFO - PROCESS | 19342 | __end_cc_report 03:36:42 INFO - PROCESS | 19342 | __startTimestamp1460457402266__endTimestamp 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | ------- Summary: start ------- 03:36:42 INFO - PROCESS | 19342 | Number of tests: 14 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.07 (2.8%) stddev-sans-first:3.24 03:36:42 INFO - PROCESS | 19342 | Values: 110.0 111.0 106.0 110.0 113.0 111.0 102.0 109.0 110.0 109.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.50 stddev:19.00 (12.4%) stddev-sans-first:20.08 03:36:42 INFO - PROCESS | 19342 | Values: 154.0 127.0 157.0 186.0 133.0 153.0 149.0 129.0 170.0 135.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.78 (1.1%) stddev-sans-first:1.80 03:36:42 INFO - PROCESS | 19342 | Values: 160.0 162.0 161.0 162.0 161.0 162.0 160.0 166.0 161.0 160.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:35.84 (47.2%) stddev-sans-first:37.48 03:36:42 INFO - PROCESS | 19342 | Values: 76.0 76.0 76.0 161.0 75.0 77.0 76.0 76.0 161.0 76.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:24.84 (26.7%) stddev-sans-first:25.55 03:36:42 INFO - PROCESS | 19342 | Values: 92.0 100.0 144.0 93.0 93.0 93.0 143.0 93.0 93.0 148.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:36:42 INFO - PROCESS | 19342 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 03:36:42 INFO - PROCESS | 19342 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:36:42 INFO - PROCESS | 19342 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:2.72 (4.7%) stddev-sans-first:2.83 03:36:42 INFO - PROCESS | 19342 | Values: 57.0 61.0 58.0 57.0 58.0 58.0 58.0 65.0 56.0 56.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:36:42 INFO - PROCESS | 19342 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.21 (2.8%) stddev-sans-first:2.32 03:36:42 INFO - PROCESS | 19342 | Values: 78.0 78.0 79.0 79.0 79.0 79.0 78.0 77.0 85.0 78.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#11] stanford-crypto-ccm Cycles:10 Average:113.30 Median:112.50 stddev:3.20 (2.8%) stddev-sans-first:3.28 03:36:42 INFO - PROCESS | 19342 | Values: 111.0 112.0 111.0 117.0 118.0 112.0 118.0 112.0 113.0 109.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:145.50 stddev:5.06 (3.5%) stddev-sans-first:5.36 03:36:42 INFO - PROCESS | 19342 | Values: 144.0 133.0 142.0 143.0 144.0 137.0 147.0 147.0 148.0 149.0 03:36:42 INFO - PROCESS | 19342 | 03:36:42 INFO - PROCESS | 19342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.48 03:36:42 INFO - PROCESS | 19342 | Values: 69.0 68.0 66.0 68.0 65.0 69.0 65.0 66.0 68.0 66.0 03:36:42 INFO - PROCESS | 19342 | -------- Summary: end -------- 03:36:42 INFO - PROCESS | 19342 | 03:36:43 INFO - TEST-INFO | 19342: exit 0 03:36:43 INFO - TEST-OK | kraken | took 60081ms 03:36:43 INFO - SUITE-END | took 1172s 03:36:43 INFO - Completed test suite (00:19:32) 03:36:43 INFO - javascript benchmark 03:36:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3222.274988127671, 3303.702666759991, 3317.900462986111, 3318.3197444523876, 3355.580552430946, 5387.4343193964605, 5397.2443857859935, 5415.10650742627, 5424.8372548823545, 5456.972715136429, 5367.141257398817, 5422.593305502083, 5439.428859969706, 5440.537554307879, 5442.6462279951775, 4833.444153922291, 4935.111679897617, 4980.651354405193, 5010.549050585447, 5049.3435853339015, 4888.9511104889025, 4990.800367985276, 5003.074431230216, 5006.0, 5007.649464537484, 4950.282209079682, 5008.549230569248, 5009.148444764399, 5011.072951503965, 5013.298138260647, 4894.975525122351, 4907.846656035828, 4912.926306105412, 4918.827841025547, 4931.112399768041, 4772.80908763649, 4856.611471082305, 4937.80248790048, 4953.0, 4964.751762411901, 5195.7142357170715, 5201.219817027439, 5204.947950520522, 5214.947850521484, 5226.608004399647, 5686.715664216814, 5783.88432231353, 5859.091840764689, 5859.1797148399255, 5861.618994765369, 5898.616589921684, 5902.232709747748, 5912.438318359749, 5924.881502369928, 5951.256092988377, 5517.420670829545, 5526.751296191641, 5527.281453411071, 5533.3083364579425, 5536.280283563111, 5777.768889244468, 5933.821985340447, 5972.820815375546, 6013.579049466495, 6014.368491308437, 5700.828975130753, 5702.714864256771, 5707.828765137053, 5708.429157084342, 5711.771529138788, 5788.739506722208, 5832.125181222766, 5833.7374818133285, 5840.970795145997, 5846.035404158351, 5717.8570535736935, 5837.7956771513645, 5900.114982752536, 5915.792947246826, 5923.614965027259, 5692.402297758758, 5696.8006119785605, 5699.715014249271, 5703.144528320702, 5704.429557044263, 4364.694471387036, 4438.378626992224, 4446.177457170369, 4446.577575130357, 4471.552844715502, 4023.436718859362, 4050.5746896576024, 4058.6144316289906, 4061.6547593454297, 4105.055837157471, 5577.860553486195, 5601.047821870292, 5601.747921343549, 5608.130739735348, 5608.46719561641, 5746.913796293059, 5810.796622118206, 5817.127430885316, 5899.528037756969, 5905.675187864623, 5478.479544443271, 5481.123020316731, 5490.423505531861, 5502.0371434998715, 5529.087700529448, 4939.0, 4941.530554597308, 4942.283368911488, 4943.332650092263, 4969.652124351261, 5951.613145145551, 5979.043353063489, 5990.400959903975, 6058.697065146725, 6128.1975860127295, 5838.503727183237, 5858.7070646468355, 5865.090910908816, 5869.589128760946, 5872.354041055566, 6050.818475445743, 6072.574919755575, 6076.361981991828, 6077.361877002851, 6079.787207447718, 5653.971730141323, 5733.512651424676, 5763.682997435014, 5821.825345239649, 5845.09401042839, 5837.912431313449, 5848.912266316093, 5866.208061911588, 5868.471837534642, 5869.090291004901, 5704.714764261853, 5720.399358067343, 5722.62802917809, 5725.742341594721, 5730.054541000855, 5531.502164805187, 5661.858453538694, 5701.230333904869, 5709.771609135588, 5746.195532625352, 5588.273524441796, 5599.776008959596, 5607.943920560742, 5629.6903670298525, 5634.661920284796, 5578.665280083208, 5663.66018038919, 5709.743061562157, 5726.398728133486, 5738.024535829002, 5467.261919640798, 5566.916496252478, 5602.411746766531, 5649.435056494318, 5686.289213848269], "unit": "score", "name": "dojo.html", "value": 5374.400571612911}, {"lowerIsBetter": false, "replicates": [570.3640440908389, 571.6741457369301, 573.9799107031255, 644.085398733798, 646.6055706019328, 38488.61511384886, 38819.22361552767, 38844.61155388445, 38846.41730374047, 38981.610183898156, 41514.58485415145, 41992.16015679685, 42012.159756804926, 42088.15823683532, 42090.15819683605, 8699.391042627003, 8849.026607073216, 8900.73297801067, 8913.153250441197, 8915.598798054103, 8712.215900568948, 8834.028256891737, 8851.468911865277, 8851.77870553238, 8853.867191992125, 9033.728988130366, 9117.316201284897, 9135.588898499584, 9142.542872856364, 9144.131307525775, 8970.910290897105, 8972.416792908505, 8977.955110224473, 8983.10168983103, 8984.371094023389, 9019.368644194908, 9168.174864262248, 9230.169284764337, 9231.953840230823, 9256.39833410833, 44340.3348949766, 44953.0, 44964.550354496365, 44966.0, 44995.325070123974, 2845.3029007893197, 3908.6286802753693, 3943.3296339622334, 3944.349182384903, 4009.578994205625, 31076.533851992237, 31503.36993260122, 31673.0, 31819.522707159413, 31951.6804831951, 3881.3013657541633, 3953.3081710700512, 4031.2743706132883, 4044.090079732066, 4047.433359329696, 248502.0, 248759.0, 248947.9999999982, 248970.0, 249621.0, 62214.37785622176, 62381.68809155925, 62688.0, 62810.0, 62847.6857615709, 63320.36679633237, 72188.63905680439, 73237.0, 73339.63330183421, 73357.0, 16819.0, 16927.15364231808, 17044.914775426045, 17065.488035358958, 17070.0, 12298.20061695987, 12310.569130080405, 12410.875891241152, 12466.563670271496, 12984.15602985803, 20588.485287867625, 20781.792182077985, 20935.0, 21008.159673612885, 21667.0, 6797.456203503708, 7408.666610002563, 7439.330460258603, 7782.338501227346, 7817.140114587391, 919.8850143732034, 979.299800642544, 1000.7448100734266, 1009.3792317724547, 1101.3942331717524, 30769.0, 30865.0, 31069.223269418446, 31274.68725312763, 31386.52920206199, 1101.4437708956925, 1107.0, 1107.9058280046124, 1118.7930232906938, 1120.7310245541012, 15832.208389580705, 16371.754423683655, 16484.258208380652, 16502.83497165013, 16632.58418539522, 332708.0, 334027.0, 335092.0, 336294.0, 340248.0, 58120.0, 58727.0, 59261.11108333379, 59347.40652593419, 59414.70292648509, 1391.7146984868077, 1422.3101795629111, 1436.4756863744867, 1454.2074569359725, 1471.5585324402637, 27295.863520683062, 29043.27391815137, 29646.0, 30205.244868878453, 30551.388972219986, 46134.0, 46502.30246546372, 46560.767196163804, 46588.30117548172, 46592.301115482616, 202107.0, 205511.0, 206207.0, 451792.0, 460339.0, 34902.476462853585, 35584.93245202648, 36452.45321320235, 37724.81137594295, 38404.23191536209, 45173.54826451693, 45527.0, 45980.31029534493, 46069.30896036629, 46120.0, 37378.8131059343, 38066.429003564415, 38276.80861595785, 38404.039899002746, 38950.4157437633, 36410.27179456343, 36923.0, 37184.07039823918, 37496.62503374931, 37556.436653450764, 39309.41035884407, 39585.20829583335, 39822.800885995384, 39950.2009959805, 40233.79883100566, 31095.222619434695, 31125.844370778002, 32958.50562241521, 34697.826510867286, 34763.30473390569, 26584.468310633292, 26718.866405667846, 26903.923843046843, 26911.596326054732, 27150.45699085968], "unit": "score", "name": "ext.html", "value": 19447.207401680585}, {"lowerIsBetter": false, "replicates": [361.11706876686503, 367.3497908701597, 372.3056499628194, 384.60193699521, 386.34900193174485, 17591.648167036667, 18370.632587348246, 19164.712529312055, 19484.512887177792, 19549.413517594494, 17243.655126897454, 18085.1861666225, 18911.24355025801, 18927.242910283607, 18934.147963341682, 5595.860103497404, 5759.856003599902, 5788.710564471759, 5794.188813566083, 5798.9130163047375, 4349.369341445488, 5663.745131469073, 5991.550633702468, 6197.721102550374, 6247.406496382836, 6169.845753856167, 6183.628982261056, 6185.783497577586, 6194.0, 6219.378062193789, 5885.764569417261, 6099.420555047285, 6150.2927163376335, 6155.415235552638, 6158.261008678965, 3890.1830615570766, 5157.793688252503, 5408.0, 5476.91784623231, 5480.314960629921, 21104.788952110437, 21457.570848582942, 21812.45468863291, 21962.560748784934, 21974.560508789735, 2429.356220601542, 2433.549793288247, 2446.1805295226122, 2752.9174124776287, 2813.5779633055, 13907.652308692364, 14019.369128389248, 14109.435622575085, 14153.150810951272, 14556.927215363856, 1918.2710569983456, 1925.643755905148, 1943.805619438059, 1949.2397964793743, 1999.5001249687577, 69538.65230673815, 69974.30025699729, 71174.0, 71629.2837071633, 72267.63866180688, 9394.67118650844, 9396.95301523488, 9938.950305248427, 10016.399016058915, 10235.692929212135, 13718.38267277975, 14148.787768183485, 14176.85823141776, 14192.787108193384, 14200.431982720782, 8069.314108300743, 8209.753707388787, 8211.34309255258, 8262.17378262169, 8277.255047045795, 8246.422750407533, 8251.504909705436, 8508.404411691246, 8595.112348041612, 8665.870011949826, 6106.6336019838955, 6132.110843927606, 6165.383461653889, 6188.535859810532, 6225.62646241227, 1696.4316953820608, 1738.1135620833213, 1744.3545888021513, 1763.6208215233787, 1825.4158669225985, 1000.444753162002, 1005.6731562242301, 1006.8036732837173, 1080.3247970018738, 1082.118073769875, 17663.20515576802, 18098.0, 18493.167807448695, 18697.345592904185, 19289.228430862888, 1002.6691191906654, 1007.1942446043137, 1035.337384074193, 1075.5805235957982, 1080.8162612355918, 10674.306170098918, 11104.389258590694, 11114.055305298978, 11162.274452160584, 11174.553017879194, 456686.0, 466833.0, 467121.0, 476431.0, 478207.0, 78905.21094789094, 79697.0, 81996.59001704953, 82050.58974705088, 82366.0, 1088.0968795899385, 1088.6189833558192, 1108.2076315434342, 1111.1721767283425, 1115.0243536905207, 16933.068681222157, 17101.0, 17158.31366745366, 17162.22769975329, 17260.482185534453, 33982.0, 34416.82791586026, 35285.29429411346, 35317.646823532465, 36013.0, 48535.271970919755, 48978.75510622424, 49022.0, 49367.506324936294, 49763.75118124531, 8074.515529068275, 8278.254957053894, 8285.585720714062, 8343.99872015362, 8411.0, 9665.0, 13724.794128088286, 13887.027908046744, 13975.161490310615, 14131.293435328398, 11294.491747871201, 12007.879921201025, 12060.939695301468, 12315.19951203169, 12465.875341246472, 11953.462094205956, 12140.715132555793, 12267.938660306641, 12282.570110046105, 12379.566715164927, 10820.134389248684, 11082.667519974413, 11091.667249982513, 11159.10727141843, 11451.141164412536, 8692.478451292942, 8698.826023479622, 8735.082816304197, 8770.342224333073, 8889.599968001585, 10288.434136122585, 11261.887381126411, 11529.538818447169, 11809.940950295193, 11986.101042422028], "unit": "score", "name": "jquery.html", "value": 9168.78430493252}, {"lowerIsBetter": false, "replicates": [1435.260840667056, 1593.7928069350983, 1616.1757503673127, 1868.7103498957658, 1959.3827944197585, 8062.71780487683, 8207.794805129875, 8209.50742955423, 8212.671493140275, 8234.711785087531, 8152.5516096614665, 8309.376796740238, 8316.37627177961, 8317.958410207955, 8319.750407487785, 2120.120150137691, 2169.858959167657, 2424.5514579802707, 2439.4755127647554, 2442.426029882976, 2438.4757277185404, 2485.3538080099124, 2486.018022880961, 2487.7139129000216, 2487.751224877516, 2405.8315917885757, 2415.6014257647466, 2434.1237154624323, 2460.938476538083, 2465.1372019793107, 2454.619533972237, 2463.0147940823636, 2469.839460435066, 2473.4311108444977, 2488.8631125288102, 2458.397692565315, 2466.2231397109854, 2475.900963961439, 2502.436951685874, 2507.3731567108225, 8106.594670266522, 8161.102278749333, 8166.632501537445, 8171.877421838677, 8175.427720059598, 5175.404828444702, 5302.390225124122, 5331.466853314676, 5340.172273297645, 5342.305500284938, 3162.778605497616, 3180.093673303121, 3246.3119178027296, 3276.3283526876935, 3284.770066095374, 982.8132654795565, 983.9065288797552, 996.5764550066266, 999.7050869993369, 1013.3565186106802, 11487.42562871853, 11647.825282620852, 11659.650210493613, 11668.1832271741, 11679.357635330054, 4581.931271030937, 4662.953370466252, 4745.95254047462, 4750.643701722384, 4777.4983626718695, 9959.153471954965, 9965.950170249247, 9982.850257246148, 10003.199744020607, 10010.149137323264, 5302.973485132627, 5309.309789727388, 5329.946700532945, 5341.626086174008, 5351.331083614548, 4204.726692764961, 4538.568835960578, 4613.746243956614, 4633.837815676435, 4848.975755121272, 3897.785621790829, 3998.2403343364667, 4014.41790940312, 4020.1557672888434, 4073.837046518106, 1280.713925642742, 1286.7812471879804, 1304.791233402651, 1309.5416604188458, 1321.0092430676991, 1142.731458107344, 1148.655403378983, 1379.5999160243416, 1410.8236470441195, 1436.727021865842, 7719.65261563231, 7746.49647772893, 7754.069511658637, 7769.106552746393, 7792.220777922275, 534.7593582887716, 542.5795008868158, 544.083219774673, 548.410458756838, 554.7281831902338, 5912.142739302777, 5916.408359164136, 5932.5550583705535, 5945.0, 5992.670403127782, 10022.54898529568, 10242.231832612584, 10375.221858360654, 10375.740606484898, 10382.273240873066, 9926.900730992598, 10044.598216071421, 10240.283180177465, 10245.231607629457, 10272.691819245434, 8018.599070046591, 8028.277455028959, 8054.355651547862, 8125.878111828328, 8127.756167314872, 7439.144498382755, 7477.0, 7482.1021477423055, 7484.700611975678, 7546.584937828472, 8897.332700047393, 9103.954480227556, 9338.206252468617, 9383.718488445358, 9392.718218453458, 9291.67479138227, 9318.301127415607, 9496.14534691881, 9725.6596019139, 9725.708228752866, 6608.867822643424, 7110.146782386147, 7252.419806415369, 7559.5464272143845, 7667.424943129399, 7867.134615192439, 7871.0554733432355, 7880.881786773089, 7886.250806173404, 7923.762287131395, 6936.618485983117, 7149.499535032706, 7185.856282874418, 7218.494705370574, 7362.77911662651, 6946.37482626566, 6994.755183568551, 7017.649117544204, 7077.5753454792875, 7097.574145551283, 7447.180810110992, 7518.060242469692, 7593.924060759322, 7673.0, 7679.385649147943, 6988.266232045562, 6992.056072430157, 7006.194287656985, 7007.964960175166, 7023.22744498115, 6833.180018397824, 6854.5201835873, 6858.451323894176, 6873.725050997904, 6885.690143943434], "unit": "score", "name": "mootools.html", "value": 4718.133459968531}, {"lowerIsBetter": false, "replicates": [339.85216430852597, 347.258602882845, 356.99107522311954, 364.2859994410955, 366.61139192456, 6057.515398768099, 6091.482224010959, 6096.1160631708435, 6102.87794244116, 6139.72371243294, 5998.970005149979, 6003.939960600393, 6007.15899774032, 6007.519398448125, 6011.128386383983, 4549.0, 4587.701799383046, 4660.883477913046, 4729.881752956169, 4731.976340118312, 4693.48371679115, 4708.058388322349, 4711.599514041311, 4718.315844202589, 4718.7168769873915, 4659.697119687209, 4685.742284174369, 4692.108499385123, 4693.88265293367, 4703.176944034797, 4511.390962220107, 4581.40441742573, 4619.330197121432, 4629.120467111272, 4632.374629425019, 4113.218488487178, 4114.403411505345, 4128.339465685476, 4157.729747566398, 4192.958070419288, 5617.747201375948, 5662.49037586615, 5665.5467562594895, 5667.716614169275, 5668.57485688575, 5443.782248710047, 5452.236686863842, 5452.345718513764, 5464.863378415532, 5467.480589344006, 6297.2128483939505, 6330.715117819709, 6332.335104813974, 6339.049142628596, 6340.556161068727, 4321.697481176319, 4491.910161796778, 4501.987052913101, 4506.977465112686, 4577.359169716243, 6591.209054913441, 6618.536702430783, 6640.900386494206, 6653.999999999952, 6656.633885136315, 4595.2188128018315, 4596.977015114903, 4597.609203217764, 4598.402207713043, 4603.769811509478, 4647.535246475325, 4648.953510464852, 4651.883702907455, 4656.534346565317, 4671.906561868812, 5337.973310133424, 5339.733013349317, 5340.0, 5344.358676958712, 5375.81184658535, 6234.501239900797, 6335.461485773761, 6348.016057511093, 6371.235451745728, 6404.391582799627, 1628.080134723877, 1639.6884591927496, 1648.9257983390776, 1649.62883351245, 1652.5538104711661, 1038.3510306058713, 1075.9139268858473, 1081.8214994525972, 1107.916906232036, 1112.777444511101, 6114.174586430864, 6133.723982420713, 6222.844428889223, 6241.625502469867, 6242.563020588515, 6542.869142617121, 6552.8361790955605, 6553.672316384162, 6555.180602424697, 6563.737450501926, 6181.381861813783, 6198.318184999646, 6201.348858369896, 6213.347598502092, 6219.253689557282, 3435.639257877937, 3492.947605785915, 3526.7178625710394, 3536.469529570585, 3549.254656522159, 6494.545381823227, 6621.9006714899315, 6649.700763465656, 6736.090627765189, 6778.593284402951, 6644.96677516619, 6649.268580456146, 6664.766733164316, 6715.630640314732, 6810.38706516406, 6858.0, 6871.622060786704, 6871.793846184622, 6877.89683154753, 6885.2770459101075, 6525.575837570543, 6649.434798042221, 6651.301613330531, 6663.067170596218, 6664.400203981665, 6542.34576542342, 6552.737890484518, 6553.279139294769, 6554.868902621825, 6559.14731084975, 6857.931420685729, 6862.656867156722, 6886.380225779503, 6886.48351373659, 6903.1716194055025, 4589.541045895384, 4598.195315819785, 4604.217283061955, 4606.654500912512, 4613.653975951885, 6637.369449902251, 6642.136522252076, 6642.634655094016, 6642.867142657024, 6644.335566443317, 6105.297890742621, 6276.843078923063, 6284.528660350584, 6347.523935704933, 6463.0, 6349.523785716182, 6357.268914074941, 6449.806505804833, 6452.12896258999, 6452.9677351612945, 6336.144620476177, 6341.397567231105, 6346.397092276226, 6355.078513615407, 6355.491560675043, 6470.0, 6473.482121430368, 6483.870322593428, 6484.059811327237, 6487.124238227779, 6120.44915957566, 6306.369363063657, 6308.463780578702, 6308.589941653778, 6310.905336420049], "unit": "score", "name": "prototype.html", "value": 4851.496552168789}, {"lowerIsBetter": false, "replicates": [772.9304362607364, 898.6809682562689, 902.3895512788798, 902.5852620720777, 927.2535608834885, 14852.33164507597, 14944.925275373635, 15017.699646007073, 15036.473723419682, 15086.245687715626, 13904.374303156357, 13941.790873136912, 14021.228832414214, 14094.154350738938, 14170.29148542574, 773.4701729315409, 914.7072936660271, 915.8076803871195, 926.2589928057561, 933.1368484152132, 921.0283151275402, 928.5542939389097, 934.1919239857542, 934.6775362499926, 935.2377812083164, 952.5142177489461, 960.875086238788, 961.9759506012371, 965.9130678238957, 966.3573723473882, 800.5636927874293, 813.1746277528314, 813.5647428625657, 941.3786900645575, 947.7914858731068, 711.0649495912858, 712.248577750473, 712.5261700968849, 712.7612249896291, 713.561159886666, 14884.479043233436, 14976.026558273677, 15002.62493437662, 15013.624659383602, 15036.548903532912, 14439.494617688331, 14592.854071459256, 14652.560423187322, 14907.850921490755, 15048.097114173075, 11632.651020469399, 11891.881081189164, 11939.641810745692, 11953.940230298793, 12222.449989750483, 3890.280298144824, 3909.0954200367137, 3929.5088113985753, 3957.742746721454, 4019.0, 51619.48380516222, 52724.73637631826, 52916.206256906175, 52932.47067529352, 52964.47035529634, 11588.594399195988, 11696.356700381391, 11700.414979251003, 11713.824292635447, 11861.525538978516, 20436.0, 20441.080151392925, 20530.794692053187, 20620.69068963967, 20666.0, 8301.211384918422, 8312.501249925024, 8344.499330040217, 8386.748397548083, 8706.695265665798, 4456.997175635521, 4817.9036419271415, 4822.324874517571, 4826.420829500483, 4934.259861020875, 3231.579894613732, 3260.1523603863166, 3271.1004473769904, 3286.605607327136, 3287.8849240276477, 613.355976224962, 613.4172536090642, 621.7481919822479, 622.4273668225153, 652.7813182583888, 523.581055523484, 552.4972275229521, 586.9618474799124, 595.9761609535657, 613.7176898626592, 8412.284955778827, 8618.913810861937, 8775.605097770616, 9156.725298241063, 9401.858972115424, 608.656109298245, 608.8174587068328, 623.3268070483866, 627.0562802981575, 635.5271559169778, 4111.650509706648, 4141.343462614978, 4219.578042195756, 4308.763018034038, 4334.284843000933, 59933.0, 59993.0, 60631.696841516394, 61031.0, 61116.38883611107, 52695.0, 53808.0, 53811.73094134504, 56197.43802562004, 57387.426125739046, 47201.5279847204, 48594.0, 49446.752766236656, 52246.47753522416, 52734.0, 8474.74575762728, 8546.78633034179, 8789.0, 8853.557322133996, 9214.216791572791, 37063.8146809275, 37352.62647373491, 38178.80910595429, 38337.616623833404, 38424.2315153701, 43998.560014399445, 44006.779966099966, 48297.517024830704, 48518.272225915935, 48804.26793598028, 12029.278243305429, 12377.938110309391, 12534.0, 12605.810912836498, 12660.683482912633, 11770.941145294219, 12562.560310389092, 12896.742065158456, 12972.221666700028, 13661.79507307411, 11860.76278474443, 12077.879221208026, 12117.69705757363, 12298.323592202514, 12588.685282868002, 12223.816642750187, 12228.327441990776, 12795.296258705861, 12815.679608009874, 12884.742305154032, 10862.34825910448, 11362.431878406212, 11376.94311528437, 12024.75950480968, 12150.939245304071, 10222.693319200138, 10414.895851041696, 10519.211059170746, 10520.894791051991, 10977.670669879917, 10228.181745460197, 10377.645084338754, 10483.0041146091, 10513.474326283807, 10582.735431614272], "unit": "score", "name": "yui.html", "value": 6822.826074458764}], "name": "dromaeo_css", "value": 7286.593880005464}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 106.0, 110.0, 113.0, 111.0, 102.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [154.0, 127.0, 157.0, 186.0, 133.0, 153.0, 149.0, 129.0, 170.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 162.0, 161.0, 162.0, 160.0, 166.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 161.0, 75.0, 77.0, 76.0, 76.0, 161.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.0}, {"lowerIsBetter": true, "replicates": [92.0, 100.0, 144.0, 93.0, 93.0, 93.0, 143.0, 93.0, 93.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 58.0, 57.0, 58.0, 58.0, 58.0, 65.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 79.0, 79.0, 79.0, 78.0, 77.0, 85.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 111.0, 117.0, 118.0, 112.0, 118.0, 112.0, 113.0, 109.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.3}, {"lowerIsBetter": true, "replicates": [144.0, 133.0, 142.0, 143.0, 144.0, 137.0, 147.0, 147.0, 148.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 66.0, 68.0, 65.0, 69.0, 65.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1505.5000000000002}]} 03:36:43 INFO - Return code: 0 03:36:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:36:43 INFO - # TBPL SUCCESS # 03:36:43 INFO - Running post-action listener: _resource_record_post_action 03:36:43 INFO - Running post-run listener: _resource_record_post_run 03:36:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 278528; Write bytes: 498737152; Read time: 44; Write time: 571444 03:36:44 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 251392000; Read time: 0; Write time: 344080 03:36:44 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 278528; Write bytes: 246747136; Read time: 44; Write time: 227364 03:36:44 INFO - Running post-run listener: _upload_blobber_files 03:36:44 INFO - Blob upload gear active. 03:36:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:36:44 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 03:36:44 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'] 03:36:44 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 03:36:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:45 INFO - (blobuploader) - INFO - Done attempting. 03:36:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:46 INFO - (blobuploader) - INFO - Done attempting. 03:36:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:46 INFO - Return code: 0 03:36:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:36:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf5c814ba0b19ad25fb0b390adcd62ed2cab45513a6d4f4bb805a393451754e0ea2cf15a2143e2fd86785acb9157cf97e0db53bbeec970847512de0cb44aeb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989806f78a60fbd5392b857fa5ce125a858d708818fd29d9f5510bbd82783b79e94153e117bd71818b0c0f9512d87c5608d1eaf05c8561a4c17f7edcaa26eef2"} 03:36:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:36:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:36:46 INFO - Contents: 03:36:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/faf5c814ba0b19ad25fb0b390adcd62ed2cab45513a6d4f4bb805a393451754e0ea2cf15a2143e2fd86785acb9157cf97e0db53bbeec970847512de0cb44aeb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989806f78a60fbd5392b857fa5ce125a858d708818fd29d9f5510bbd82783b79e94153e117bd71818b0c0f9512d87c5608d1eaf05c8561a4c17f7edcaa26eef2"} 03:36:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:46 INFO - Copying logs to upload dir... 03:36:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:36:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.259638 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-12 03:36:46.354750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 03:36:46.359675) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 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/faf5c814ba0b19ad25fb0b390adcd62ed2cab45513a6d4f4bb805a393451754e0ea2cf15a2143e2fd86785acb9157cf97e0db53bbeec970847512de0cb44aeb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989806f78a60fbd5392b857fa5ce125a858d708818fd29d9f5510bbd82783b79e94153e117bd71818b0c0f9512d87c5608d1eaf05c8561a4c17f7edcaa26eef2"} build_url:https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/HKqjgGl1RMyoT7-BesPzng/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/faf5c814ba0b19ad25fb0b390adcd62ed2cab45513a6d4f4bb805a393451754e0ea2cf15a2143e2fd86785acb9157cf97e0db53bbeec970847512de0cb44aeb4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/989806f78a60fbd5392b857fa5ce125a858d708818fd29d9f5510bbd82783b79e94153e117bd71818b0c0f9512d87c5608d1eaf05c8561a4c17f7edcaa26eef2"}' ========= master_lag: 0.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 03:36:46.618725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:36:46.619103) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460456154.333071-351486852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 03:36:46.634980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 03:36:46.635272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 03:36:46.635532) ========= ========= Total master_lag: 0.57 =========