builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1456531318.73 results: success (0) buildid: 20160226133205 builduid: 66530f2448474d3b84206856b74f72ce revision: 5e0140b6d11821e0c2a2de25bc5431783f03380a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.727460) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.727934) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.728231) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009145 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.754782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.755078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.767902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.768175) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.818265) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.818568) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.818957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.819237) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 16:01:58-- 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% 35.3M=0s 2016-02-26 16:01:58 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.929749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.930070) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.979861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:58.980197) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e0140b6d11821e0c2a2de25bc5431783f03380a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5e0140b6d11821e0c2a2de25bc5431783f03380a --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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 16:01:59,034 truncating revision to first 12 chars 2016-02-26 16:01:59,034 Setting DEBUG logging. 2016-02-26 16:01:59,034 attempt 1/10 2016-02-26 16:01:59,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e0140b6d118?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 16:01:59,330 unpacking tar archive at: mozilla-central-5e0140b6d118/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629510 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:59.624355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:59.624739) ========= echo 5e0140b6d11821e0c2a2de25bc5431783f03380a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e0140b6d11821e0c2a2de25bc5431783f03380a'] 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5e0140b6d11821e0c2a2de25bc5431783f03380a program finished with exit code 0 elapsedTime=0.003620 script_repo_revision: '5e0140b6d11821e0c2a2de25bc5431783f03380a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:59.672805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:59.673166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 16:01:59.685359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-26 16:01:59.685717) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:59 INFO - MultiFileLogger online at 20160226 16:01:59 in /builds/slave/test-pgo 16:01:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:01:59 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:01:59 INFO - {'append_to_log': False, 16:01:59 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:01:59 INFO - 'blob_upload_branch': 'Firefox', 16:01:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:01:59 INFO - 'branch': 'Firefox', 16:01:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:59 INFO - 'config_files': ('talos/linux_config.py',), 16:01:59 INFO - 'default_actions': ('clobber', 16:01:59 INFO - 'read-buildbot-config', 16:01:59 INFO - 'download-and-extract', 16:01:59 INFO - 'populate-webroot', 16:01:59 INFO - 'create-virtualenv', 16:01:59 INFO - 'install', 16:01:59 INFO - 'run-tests'), 16:01:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:59 INFO - 'download_minidump_stackwalk': True, 16:01:59 INFO - 'download_symbols': 'ondemand', 16:01:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:59 INFO - 'installer_path': 'installer.exe', 16:01:59 INFO - 'log_level': 'info', 16:01:59 INFO - 'log_name': 'talos', 16:01:59 INFO - 'log_to_console': True, 16:01:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:59 INFO - 'opt_config_files': (), 16:01:59 INFO - 'pip_index': False, 16:01:59 INFO - 'sps_profile': False, 16:01:59 INFO - 'sps_profile_interval': 0, 16:01:59 INFO - 'suite': 'dromaeojs', 16:01:59 INFO - 'system_bits': '32', 16:01:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:59 INFO - 'title': 'talos-linux64-ix-015', 16:01:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:59 INFO - 'use_talos_json': True, 16:01:59 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:01:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:59 INFO - 'work_dir': 'build'} 16:01:59 INFO - ##### 16:01:59 INFO - ##### Running clobber step. 16:01:59 INFO - ##### 16:01:59 INFO - Running pre-action listener: _resource_record_pre_action 16:01:59 INFO - Running main action method: clobber 16:01:59 INFO - rmtree: /builds/slave/test-pgo/build 16:01:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:02:00 INFO - Running post-action listener: _resource_record_post_action 16:02:00 INFO - ##### 16:02:00 INFO - ##### Running read-buildbot-config step. 16:02:00 INFO - ##### 16:02:00 INFO - Running pre-action listener: _resource_record_pre_action 16:02:00 INFO - Running main action method: read_buildbot_config 16:02:00 INFO - Using buildbot properties: 16:02:00 INFO - { 16:02:00 INFO - "project": "", 16:02:00 INFO - "product": "firefox", 16:02:00 INFO - "script_repo_revision": "production", 16:02:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:02:00 INFO - "repository": "", 16:02:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:02:00 INFO - "buildid": "20160226133205", 16:02:00 INFO - "pgo_build": "True", 16:02:00 INFO - "basedir": "/builds/slave/test-pgo", 16:02:00 INFO - "buildnumber": 361, 16:02:00 INFO - "slavename": "talos-linux64-ix-015", 16:02:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:02:00 INFO - "platform": "ubuntu64_hw", 16:02:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:02:00 INFO - "branch": "mozilla-central", 16:02:00 INFO - "repo_path": "mozilla-central", 16:02:00 INFO - "revision": "5e0140b6d11821e0c2a2de25bc5431783f03380a", 16:02:00 INFO - "stage_platform": "linux64-pgo", 16:02:00 INFO - "builduid": "66530f2448474d3b84206856b74f72ce", 16:02:00 INFO - "slavebuilddir": "test" 16:02:00 INFO - } 16:02:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 16:02:00 INFO - Running post-action listener: _resource_record_post_action 16:02:00 INFO - ##### 16:02:00 INFO - ##### Running download-and-extract step. 16:02:00 INFO - ##### 16:02:00 INFO - Running pre-action listener: _resource_record_pre_action 16:02:00 INFO - Running main action method: download_and_extract 16:02:00 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:00 INFO - https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/test_packages.json 16:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/test_packages.json 16:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:02:04 INFO - Downloaded 1448 bytes. 16:02:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:02:04 INFO - Using the following test package requirements: 16:02:04 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:02:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:02:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:02:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'jsshell-linux-x86_64.zip'], 16:02:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:02:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:02:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:02:04 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:02:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:02:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 16:02:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:04 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:02:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:04 INFO - https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:02:05 INFO - Downloaded 23371535 bytes. 16:02:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:02:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:02:07 INFO - Return code: 0 16:02:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:02:07 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')]} 16:02:07 INFO - https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 16:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:02:22 INFO - Downloaded 23371535 bytes. 16:02:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:02:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 16:02:23 INFO - Return code: 0 16:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:23 INFO - https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:02:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:02:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:02:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 16:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:02:24 INFO - Downloaded 10713410 bytes. 16:02:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 16:02:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 16:02:24 INFO - Return code: 0 16:02:24 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')]} 16:02:24 INFO - https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:02:26 INFO - Downloaded 56625290 bytes. 16:02:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:02:26 INFO - mkdir: /builds/slave/test-pgo/properties 16:02:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:02:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:02:26 INFO - Contents: 16:02:26 INFO - build_url:https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 16:02:27 INFO - Running post-action listener: _resource_record_post_action 16:02:27 INFO - Running post-action listener: set_extra_try_arguments 16:02:27 INFO - ##### 16:02:27 INFO - ##### Running populate-webroot step. 16:02:27 INFO - ##### 16:02:27 INFO - Running pre-action listener: _resource_record_pre_action 16:02:27 INFO - Running main action method: populate_webroot 16:02:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:02:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:02:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:02:27 INFO - '--tppagecycles', 16:02:27 INFO - '7'], 16:02:27 INFO - 'tests': ['tsvgm']}}, 16:02:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:02:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:02:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:02:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:02:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'tests': ['damp', 'tps']}, 16:02:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['damp', 'tps']}, 16:02:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:02:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:02:27 INFO - 'other': {'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'other_l64': {'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'other_nol64': {'tests': ['a11yr', 16:02:27 INFO - 'ts_paint', 16:02:27 INFO - 'tpaint', 16:02:27 INFO - 'sessionrestore', 16:02:27 INFO - 'sessionrestore_no_auto_restore']}, 16:02:27 INFO - 'svgr': {'tests': ['tsvgx', 16:02:27 INFO - 'tsvgr_opacity', 16:02:27 INFO - 'tart', 16:02:27 INFO - 'tscrollx', 16:02:27 INFO - 'cart']}, 16:02:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['tsvgx', 16:02:27 INFO - 'tsvgr_opacity', 16:02:27 INFO - 'tart', 16:02:27 INFO - 'tscrollx', 16:02:27 INFO - 'cart']}, 16:02:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'tests': ['tp5o']}, 16:02:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'talos_options': ['--e10s'], 16:02:27 INFO - 'tests': ['tp5o']}, 16:02:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'talos_options': ['--xperf_path', 16:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:27 INFO - 'tests': ['tp5n']}, 16:02:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:27 INFO - 'talos_options': ['--e10s', 16:02:27 INFO - '--xperf_path', 16:02:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:27 INFO - 'tests': ['tp5n']}}, 16:02:27 INFO - 'talos.zip': {'path': '', 16:02:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:02:27 INFO - Running post-action listener: _resource_record_post_action 16:02:27 INFO - ##### 16:02:27 INFO - ##### Running create-virtualenv step. 16:02:27 INFO - ##### 16:02:27 INFO - Running pre-action listener: _resource_record_pre_action 16:02:27 INFO - Running main action method: create_virtualenv 16:02:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:02:27 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 16:02:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:02:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:02:27 INFO - Using real prefix '/usr' 16:02:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:02:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:02:30 INFO - Installing pip.................done. 16:02:30 INFO - Return code: 0 16:02:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:30 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:30 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 16:02:30 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 16:02:30 INFO - Using env: {'DISPLAY': ':0', 16:02:30 INFO - 'HOME': '/home/cltbld', 16:02:30 INFO - 'LANG': 'en_US.UTF-8', 16:02:30 INFO - 'LANGUAGE': 'en_US:en', 16:02:30 INFO - 'LOGNAME': 'cltbld', 16:02:30 INFO - 'MAIL': '/var/mail/cltbld', 16:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:30 INFO - 'MOZ_NO_REMOTE': '1', 16:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:30 INFO - 'NO_EM_RESTART': '1', 16:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:30 INFO - 'SHELL': '/bin/bash', 16:02:30 INFO - 'SHLVL': '1', 16:02:30 INFO - 'TERM': 'linux', 16:02:30 INFO - 'TMOUT': '86400', 16:02:30 INFO - 'USER': 'cltbld', 16:02:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:30 INFO - '_': '/tools/buildbot/bin/python'} 16:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:30 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 16:02:30 INFO - Cleaning up... 16:02:30 INFO - Return code: 0 16:02:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:30 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:30 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 16:02:30 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 16:02:30 INFO - Using env: {'DISPLAY': ':0', 16:02:30 INFO - 'HOME': '/home/cltbld', 16:02:30 INFO - 'LANG': 'en_US.UTF-8', 16:02:30 INFO - 'LANGUAGE': 'en_US:en', 16:02:30 INFO - 'LOGNAME': 'cltbld', 16:02:30 INFO - 'MAIL': '/var/mail/cltbld', 16:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:30 INFO - 'MOZ_NO_REMOTE': '1', 16:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:30 INFO - 'NO_EM_RESTART': '1', 16:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:30 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:30 INFO - 'SHELL': '/bin/bash', 16:02:30 INFO - 'SHLVL': '1', 16:02:30 INFO - 'TERM': 'linux', 16:02:30 INFO - 'TMOUT': '86400', 16:02:30 INFO - 'USER': 'cltbld', 16:02:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:30 INFO - '_': '/tools/buildbot/bin/python'} 16:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:30 INFO - Downloading/unpacking psutil>=0.7.1 16:02:30 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 16:02:30 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 16:02:30 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 16:02:30 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 16:02:30 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 16:02:30 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 16:02:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:32 INFO - Installing collected packages: psutil 16:02:32 INFO - Running setup.py install for psutil 16:02:32 INFO - building 'psutil._psutil_linux' extension 16:02:32 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 16:02:32 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 16:02:32 INFO - building 'psutil._psutil_posix' extension 16:02:32 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 16:02:32 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 16:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:33 INFO - Successfully installed psutil 16:02:33 INFO - Cleaning up... 16:02:33 INFO - Return code: 0 16:02:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:02:33 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')]} 16:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:33 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')]} 16:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:33 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:33 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 16:02:33 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 16:02:33 INFO - Using env: {'DISPLAY': ':0', 16:02:33 INFO - 'HOME': '/home/cltbld', 16:02:33 INFO - 'LANG': 'en_US.UTF-8', 16:02:33 INFO - 'LANGUAGE': 'en_US:en', 16:02:33 INFO - 'LOGNAME': 'cltbld', 16:02:33 INFO - 'MAIL': '/var/mail/cltbld', 16:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:33 INFO - 'MOZ_NO_REMOTE': '1', 16:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:33 INFO - 'NO_EM_RESTART': '1', 16:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:33 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:33 INFO - 'SHELL': '/bin/bash', 16:02:33 INFO - 'SHLVL': '1', 16:02:33 INFO - 'TERM': 'linux', 16:02:33 INFO - 'TMOUT': '86400', 16:02:33 INFO - 'USER': 'cltbld', 16:02:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:33 INFO - '_': '/tools/buildbot/bin/python'} 16:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:02:33 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 16:02:33 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 16:02:33 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 16:02:33 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 16:02:33 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 16:02:33 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 16:02:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:02:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:02:35 INFO - Installing collected packages: mozsystemmonitor 16:02:35 INFO - Running setup.py install for mozsystemmonitor 16:02:35 INFO - Successfully installed mozsystemmonitor 16:02:35 INFO - Cleaning up... 16:02:35 INFO - Return code: 0 16:02:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:02: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')]} 16:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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', '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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:02: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 blobuploader==1.2.4 16:02:35 INFO - Using env: {'DISPLAY': ':0', 16:02:35 INFO - 'HOME': '/home/cltbld', 16:02:35 INFO - 'LANG': 'en_US.UTF-8', 16:02:35 INFO - 'LANGUAGE': 'en_US:en', 16:02:35 INFO - 'LOGNAME': 'cltbld', 16:02:35 INFO - 'MAIL': '/var/mail/cltbld', 16:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:35 INFO - 'MOZ_NO_REMOTE': '1', 16:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:35 INFO - 'NO_EM_RESTART': '1', 16:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:35 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:35 INFO - 'SHELL': '/bin/bash', 16:02:35 INFO - 'SHLVL': '1', 16:02:35 INFO - 'TERM': 'linux', 16:02:35 INFO - 'TMOUT': '86400', 16:02:35 INFO - 'USER': 'cltbld', 16:02:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:35 INFO - '_': '/tools/buildbot/bin/python'} 16:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:35 INFO - Downloading/unpacking blobuploader==1.2.4 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:02:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:38 INFO - Downloading docopt-0.6.1.tar.gz 16:02:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:38 INFO - Running setup.py install for blobuploader 16:02:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:02:38 INFO - Running setup.py install for requests 16:02:38 INFO - Running setup.py install for docopt 16:02:38 INFO - Successfully installed blobuploader requests docopt 16:02:38 INFO - Cleaning up... 16:02:38 INFO - Return code: 0 16:02:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:02:38 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')]} 16:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:38 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')]} 16:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:38 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:38 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 16:02:38 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 16:02:38 INFO - Using env: {'DISPLAY': ':0', 16:02:38 INFO - 'HOME': '/home/cltbld', 16:02:38 INFO - 'LANG': 'en_US.UTF-8', 16:02:38 INFO - 'LANGUAGE': 'en_US:en', 16:02:38 INFO - 'LOGNAME': 'cltbld', 16:02:38 INFO - 'MAIL': '/var/mail/cltbld', 16:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:38 INFO - 'MOZ_NO_REMOTE': '1', 16:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:38 INFO - 'NO_EM_RESTART': '1', 16:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:38 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:38 INFO - 'SHELL': '/bin/bash', 16:02:38 INFO - 'SHLVL': '1', 16:02:38 INFO - 'TERM': 'linux', 16:02:38 INFO - 'TMOUT': '86400', 16:02:38 INFO - 'USER': 'cltbld', 16:02:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:38 INFO - '_': '/tools/buildbot/bin/python'} 16:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:02:38 INFO - Running setup.py (path:/tmp/pip-JMwmIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:02:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:02:39 INFO - Running setup.py (path:/tmp/pip-09Yrd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:02:39 INFO - Running setup.py (path:/tmp/pip-jqIynR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:02:39 INFO - Running setup.py (path:/tmp/pip-Pan2KJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:02:39 INFO - Running setup.py (path:/tmp/pip-auJC2_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:02:39 INFO - Running setup.py (path:/tmp/pip-KpNNqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:02:39 INFO - Running setup.py (path:/tmp/pip-WGc93Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:02:39 INFO - Running setup.py (path:/tmp/pip-EypaPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:02:39 INFO - Running setup.py (path:/tmp/pip-uZdCW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:02:39 INFO - Running setup.py (path:/tmp/pip-dz3cVq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:02:39 INFO - Running setup.py (path:/tmp/pip-1dr0FN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:02:39 INFO - Running setup.py (path:/tmp/pip-jotYw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:02:39 INFO - Running setup.py (path:/tmp/pip-FWPIti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:02:39 INFO - Running setup.py (path:/tmp/pip-9vfOG5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:02:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:02:39 INFO - Running setup.py (path:/tmp/pip-0NeRrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:02:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:02:40 INFO - Running setup.py (path:/tmp/pip-9yr8tg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:02:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:02:40 INFO - Running setup.py (path:/tmp/pip-CVfTCS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:02:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:40 INFO - Running setup.py install for manifestparser 16:02:40 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Running setup.py install for mozcrash 16:02:40 INFO - Running setup.py install for mozdebug 16:02:40 INFO - Running setup.py install for mozdevice 16:02:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Running setup.py install for mozfile 16:02:40 INFO - Running setup.py install for mozhttpd 16:02:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Running setup.py install for mozinfo 16:02:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Running setup.py install for mozInstall 16:02:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:02:40 INFO - Running setup.py install for mozleak 16:02:41 INFO - Running setup.py install for mozlog 16:02:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Running setup.py install for moznetwork 16:02:41 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Running setup.py install for mozprocess 16:02:41 INFO - Running setup.py install for mozprofile 16:02:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Running setup.py install for mozrunner 16:02:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Running setup.py install for mozscreenshot 16:02:41 INFO - Running setup.py install for moztest 16:02:41 INFO - Running setup.py install for mozversion 16:02:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:02:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:41 INFO - Cleaning up... 16:02:41 INFO - Return code: 0 16:02:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:02: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')]} 16:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:41 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:41 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 16:02:41 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 16:02:41 INFO - Using env: {'DISPLAY': ':0', 16:02:41 INFO - 'HOME': '/home/cltbld', 16:02:41 INFO - 'LANG': 'en_US.UTF-8', 16:02:41 INFO - 'LANGUAGE': 'en_US:en', 16:02:41 INFO - 'LOGNAME': 'cltbld', 16:02:41 INFO - 'MAIL': '/var/mail/cltbld', 16:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:41 INFO - 'MOZ_NO_REMOTE': '1', 16:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:41 INFO - 'NO_EM_RESTART': '1', 16:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:41 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:41 INFO - 'SHELL': '/bin/bash', 16:02:41 INFO - 'SHLVL': '1', 16:02:41 INFO - 'TERM': 'linux', 16:02:41 INFO - 'TMOUT': '86400', 16:02:41 INFO - 'USER': 'cltbld', 16:02:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:41 INFO - '_': '/tools/buildbot/bin/python'} 16:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:02:42 INFO - Running setup.py (path:/tmp/pip-ezrGLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:02:42 INFO - Running setup.py (path:/tmp/pip-5EcUJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:02:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:02:42 INFO - Running setup.py (path:/tmp/pip-4d2OZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:02:42 INFO - Running setup.py (path:/tmp/pip-4R_tCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:02:42 INFO - Running setup.py (path:/tmp/pip-3r2oYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:02:42 INFO - Running setup.py (path:/tmp/pip-PFCR4T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:02:42 INFO - Running setup.py (path:/tmp/pip-hFzZLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:02:42 INFO - Running setup.py (path:/tmp/pip-wFHxxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:02:42 INFO - Running setup.py (path:/tmp/pip-65bBQW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:02:42 INFO - Running setup.py (path:/tmp/pip-UQYIB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:02:42 INFO - Running setup.py (path:/tmp/pip-RDKZ5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:02:42 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)) 16:02:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:02:42 INFO - Running setup.py (path:/tmp/pip-aNuikV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:02:43 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)) 16:02:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:02:43 INFO - Running setup.py (path:/tmp/pip-ynm8kB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:02:43 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)) 16:02:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:02:43 INFO - Running setup.py (path:/tmp/pip-jpHTfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:02:43 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)) 16:02:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:02:43 INFO - Running setup.py (path:/tmp/pip-NX7BWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:02:43 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)) 16:02:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:02:43 INFO - Running setup.py (path:/tmp/pip-PTNw1R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:02:43 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)) 16:02:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:02:43 INFO - Running setup.py (path:/tmp/pip-UPySSh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:02:43 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)) 16:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:02:43 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)) 16:02:43 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)) 16:02:43 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)) 16:02:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:45 INFO - Downloading blessings-1.6.tar.gz 16:02:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:45 INFO - Installing collected packages: blessings 16:02:45 INFO - Running setup.py install for blessings 16:02:45 INFO - Successfully installed blessings 16:02:45 INFO - Cleaning up... 16:02:45 INFO - Return code: 0 16:02:45 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:02:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:02:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:02:45 INFO - Reading from file tmpfile_stdout 16:02:45 INFO - Current package versions: 16:02:45 INFO - argparse == 1.2.1 16:02:45 INFO - blessings == 1.6 16:02:45 INFO - blobuploader == 1.2.4 16:02:45 INFO - docopt == 0.6.1 16:02:45 INFO - manifestparser == 1.1 16:02:45 INFO - mozInstall == 1.12 16:02:45 INFO - mozcrash == 0.16 16:02:45 INFO - mozdebug == 0.1 16:02:45 INFO - mozdevice == 0.48 16:02:45 INFO - mozfile == 1.2 16:02:45 INFO - mozhttpd == 0.7 16:02:45 INFO - mozinfo == 0.9 16:02:45 INFO - mozleak == 0.1 16:02:45 INFO - mozlog == 3.1 16:02:45 INFO - moznetwork == 0.27 16:02:45 INFO - mozprocess == 0.22 16:02:45 INFO - mozprofile == 0.28 16:02:45 INFO - mozrunner == 6.11 16:02:45 INFO - mozscreenshot == 0.1 16:02:45 INFO - mozsystemmonitor == 0.0 16:02:45 INFO - moztest == 0.7 16:02:45 INFO - mozversion == 1.4 16:02:45 INFO - psutil == 3.1.1 16:02:45 INFO - requests == 1.2.3 16:02:45 INFO - wsgiref == 0.1.2 16:02:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:45 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 16:02:45 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 16:02:45 INFO - Using env: {'DISPLAY': ':0', 16:02:45 INFO - 'HOME': '/home/cltbld', 16:02:45 INFO - 'LANG': 'en_US.UTF-8', 16:02:45 INFO - 'LANGUAGE': 'en_US:en', 16:02:45 INFO - 'LOGNAME': 'cltbld', 16:02:45 INFO - 'MAIL': '/var/mail/cltbld', 16:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:45 INFO - 'MOZ_NO_REMOTE': '1', 16:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:45 INFO - 'NO_EM_RESTART': '1', 16:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:45 INFO - 'SHELL': '/bin/bash', 16:02:45 INFO - 'SHLVL': '1', 16:02:45 INFO - 'TERM': 'linux', 16:02:45 INFO - 'TMOUT': '86400', 16:02:45 INFO - 'USER': 'cltbld', 16:02:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:45 INFO - '_': '/tools/buildbot/bin/python'} 16:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:02:45 INFO - Cleaning up... 16:02:45 INFO - Return code: 0 16:02:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 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 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02:45 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 16:02:45 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 16:02:45 INFO - Using env: {'DISPLAY': ':0', 16:02:45 INFO - 'HOME': '/home/cltbld', 16:02:45 INFO - 'LANG': 'en_US.UTF-8', 16:02:45 INFO - 'LANGUAGE': 'en_US:en', 16:02:45 INFO - 'LOGNAME': 'cltbld', 16:02:45 INFO - 'MAIL': '/var/mail/cltbld', 16:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:45 INFO - 'MOZ_NO_REMOTE': '1', 16:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:45 INFO - 'NO_EM_RESTART': '1', 16:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:45 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:45 INFO - 'SHELL': '/bin/bash', 16:02:45 INFO - 'SHLVL': '1', 16:02:45 INFO - 'TERM': 'linux', 16:02:45 INFO - 'TMOUT': '86400', 16:02:45 INFO - 'USER': 'cltbld', 16:02:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:45 INFO - '_': '/tools/buildbot/bin/python'} 16:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:46 INFO - Downloading/unpacking jsonschema 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:47 INFO - Downloading/unpacking functools32 (from jsonschema) 16:02:47 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 16:02:47 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 16:02:47 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 16:02:47 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 16:02:47 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 16:02:47 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 16:02:48 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:48 INFO - warning: no files found matching '*.txt' 16:02:48 INFO - no previously-included directories found matching 'build' 16:02:48 INFO - no previously-included directories found matching 'dist' 16:02:48 INFO - no previously-included directories found matching '.git*' 16:02:48 INFO - Installing collected packages: jsonschema, functools32 16:02:48 INFO - Running setup.py install for functools32 16:02:48 INFO - warning: no files found matching '*.txt' 16:02:48 INFO - no previously-included directories found matching 'build' 16:02:48 INFO - no previously-included directories found matching 'dist' 16:02:48 INFO - no previously-included directories found matching '.git*' 16:02:48 INFO - Successfully installed jsonschema functools32 16:02:48 INFO - Cleaning up... 16:02:48 INFO - Return code: 0 16:02:48 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:02: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')]} 16:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f705a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a71670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', '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 16:02: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', 'flake8'] in /builds/slave/test-pgo/build 16:02: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 flake8 16:02:48 INFO - Using env: {'DISPLAY': ':0', 16:02:48 INFO - 'HOME': '/home/cltbld', 16:02:48 INFO - 'LANG': 'en_US.UTF-8', 16:02:48 INFO - 'LANGUAGE': 'en_US:en', 16:02:48 INFO - 'LOGNAME': 'cltbld', 16:02:48 INFO - 'MAIL': '/var/mail/cltbld', 16:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:48 INFO - 'MOZ_NO_REMOTE': '1', 16:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:48 INFO - 'NO_EM_RESTART': '1', 16:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:02:48 INFO - 'PWD': '/builds/slave/test-pgo', 16:02:48 INFO - 'SHELL': '/bin/bash', 16:02:48 INFO - 'SHLVL': '1', 16:02:48 INFO - 'TERM': 'linux', 16:02:48 INFO - 'TMOUT': '86400', 16:02:48 INFO - 'USER': 'cltbld', 16:02:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:48 INFO - '_': '/tools/buildbot/bin/python'} 16:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:48 INFO - Downloading/unpacking flake8 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:02:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:02:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:51 INFO - no previously-included directories found matching 'docs/_build' 16:02:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:02:51 INFO - Running setup.py install for pep8 16:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:51 INFO - no previously-included directories found matching 'docs/_build' 16:02:51 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:02:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:02:51 INFO - Cleaning up... 16:02:51 INFO - Return code: 0 16:02:51 INFO - Running post-action listener: _resource_record_post_action 16:02:51 INFO - Running post-action listener: _start_resource_monitoring 16:02:51 INFO - Starting resource monitoring. 16:02:51 INFO - ##### 16:02:51 INFO - ##### Running install step. 16:02:51 INFO - ##### 16:02:51 INFO - Running pre-action listener: _resource_record_pre_action 16:02:51 INFO - Running main action method: install 16:02:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:02:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:02:51 INFO - Reading from file tmpfile_stdout 16:02:51 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:02:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:02:51 INFO - Reading from file tmpfile_stdout 16:02:51 INFO - Output received: 16:02:51 INFO - Usage: mozinstall [options] installer 16:02:51 INFO - Options: 16:02:51 INFO - -h, --help show this help message and exit 16:02:51 INFO - -d DEST, --destination=DEST 16:02:51 INFO - Directory to install application into. [default: 16:02:51 INFO - "/builds/slave/test-pgo"] 16:02:51 INFO - --app=APP Application being installed. [default: firefox] 16:02:51 INFO - mkdir: /builds/slave/test-pgo/build/application 16:02:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:02:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:03:07 INFO - Reading from file tmpfile_stdout 16:03:07 INFO - Output received: 16:03:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:03:07 INFO - Running post-action listener: _resource_record_post_action 16:03:07 INFO - ##### 16:03:07 INFO - ##### Running run-tests step. 16:03:07 INFO - ##### 16:03:07 INFO - Running pre-action listener: _resource_record_pre_action 16:03:07 INFO - Running main action method: run_tests 16:03:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:03:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:03:07 INFO - Python 2.7.3 16:03:07 INFO - Return code: 0 16:03:07 INFO - grabbing minidump binary from tooltool 16:03:07 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')]} 16:03:07 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 0x2b008c0>, '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 0x2b017c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b01c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:03:07 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 16:03:07 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 16:03:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:08 INFO - Return code: 0 16:03:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:03:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:03:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:03:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:03:09 INFO - Return code: 0 16:03:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 16:03:09 INFO - Using env: {'DISPLAY': ':0', 16:03:09 INFO - 'HOME': '/home/cltbld', 16:03:09 INFO - 'LANG': 'en_US.UTF-8', 16:03:09 INFO - 'LANGUAGE': 'en_US:en', 16:03:09 INFO - 'LOGNAME': 'cltbld', 16:03:09 INFO - 'MAIL': '/var/mail/cltbld', 16:03:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:03:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:09 INFO - 'MOZ_NO_REMOTE': '1', 16:03:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:09 INFO - 'NO_EM_RESTART': '1', 16:03:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:03:09 INFO - 'PWD': '/builds/slave/test-pgo', 16:03:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:03:09 INFO - 'SHELL': '/bin/bash', 16:03:09 INFO - 'SHLVL': '1', 16:03:09 INFO - 'TERM': 'linux', 16:03:09 INFO - 'TMOUT': '86400', 16:03:09 INFO - 'USER': 'cltbld', 16:03:09 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833', 16:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:09 INFO - '_': '/tools/buildbot/bin/python'} 16:03:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 16:03:09 INFO - mozversion application_buildid: 20160226133205 16:03:09 INFO - mozversion application_changeset: 5e0140b6d11821e0c2a2de25bc5431783f03380a 16:03:09 INFO - mozversion application_display_name: Nightly 16:03:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:09 INFO - mozversion application_name: Firefox 16:03:09 INFO - mozversion application_remotingname: firefox 16:03:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:03:09 INFO - mozversion application_vendor: Mozilla 16:03:09 INFO - mozversion application_version: 47.0a1 16:03:09 INFO - mozversion platform_buildid: 20160226133205 16:03:09 INFO - mozversion platform_changeset: 5e0140b6d11821e0c2a2de25bc5431783f03380a 16:03:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:03:09 INFO - mozversion platform_version: 47.0a1 16:03:09 INFO - using testdate: 1456531389 16:03:09 INFO - actual date: 1456531389 16:03:09 INFO - starting webserver on 'localhost:58910' 16:03:09 INFO - SUITE-START | Running 2 tests 16:03:09 INFO - TEST-START | dromaeo_css 16:03:09 INFO - operating with platform_type : linux_ 16:03:09 INFO - Initialising browser for dromaeo_css test... 16:03:09 INFO - TEST-INFO | started process 17636 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEiIwkf/profile http://localhost:58910/getInfo.html) 16:03:13 INFO - PROCESS | 17636 | __metrics Screen width/height:1600/1200 16:03:13 INFO - PROCESS | 17636 | colorDepth:24 16:03:13 INFO - PROCESS | 17636 | Browser inner width/height: 1024/697 16:03:13 INFO - PROCESS | 17636 | __metrics 16:03:14 INFO - PROCESS | 17636 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:14 INFO - PROCESS | 17636 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:03:15 INFO - TEST-INFO | 17636: exit 0 16:03:15 INFO - Browser initialized. 16:03:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:03:15 INFO - TEST-INFO | started process 17736 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEiIwkf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:26 INFO - PROCESS | 17736 | RSS: Main: 150749184 16:03:26 INFO - PROCESS | 17736 | 16:04:18 INFO - PROCESS | 17736 | 1456531458346 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] 16:06:26 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58910/tests/dromaeo/cssquery-ext.html) 16:06:27 INFO - PROCESS | 17736 | RSS: Main: 250478592 16:06:27 INFO - PROCESS | 17736 | 16:09:29 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-ext.html (next: http://localhost:58910/tests/dromaeo/cssquery-jquery.html) 16:09:30 INFO - PROCESS | 17736 | RSS: Main: 233648128 16:09:30 INFO - PROCESS | 17736 | 16:12:32 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58910/tests/dromaeo/cssquery-mootools.html) 16:12:32 INFO - PROCESS | 17736 | RSS: Main: 240001024 16:12:32 INFO - PROCESS | 17736 | 16:15:34 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58910/tests/dromaeo/cssquery-prototype.html) 16:15:35 INFO - PROCESS | 17736 | RSS: Main: 204378112 16:15:35 INFO - PROCESS | 17736 | 16:18:37 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58910/tests/dromaeo/cssquery-yui.html) 16:18:38 INFO - PROCESS | 17736 | RSS: Main: 215986176 16:18:38 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | Cycle 1(1): loaded http://localhost:58910/tests/dromaeo/cssquery-yui.html (next: http://localhost:58910/tests/dromaeo/cssquery-dojo.html) 16:21:41 INFO - PROCESS | 17736 | RSS: Main: 255766528 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | __start_tp_report 16:21:41 INFO - PROCESS | 17736 | _x_x_mozilla_page_load 16:21:41 INFO - PROCESS | 17736 | _x_x_mozilla_page_load_details 16:21:41 INFO - PROCESS | 17736 | |i|pagename|runs| 16:21:41 INFO - PROCESS | 17736 | |0;dojo.html;3044.558539011845;3121.6878312168774;3127.1244051665535;3137.0745630039137;3156.731677807387;4905.141600219965;5023.6734612250175;5036.068327359437;5081.339425874631;5113.360829896263;4996.325496058031;5020.472850350716;5060.266261392105;5097.974510127444;5112.590992720583;4573.588377046065;4634.814607415699;4663.137319595886;4720.386349774524;4807.206810876201;4723.4568024677255;4728.385309909724;4769.403824521934;4781.091592597413;4806.4472585652575;4563.26987681971;4571.131485017852;4642.558956899089;4648.581627653527;4664.930026049612;4597.563231493003;4602.7008244464005;4604.1252162089095;4611.446626404853;4634.9073018539775;4531.77341132942;4593.127305811919;4593.609543188833;4612.377329060568;4629.23617603095;4841.176999910023;4860.3681521401995;4882.560569548722;4907.509249075099;4920.532549407801;5292.894142117175;5295.761690723926;5297.073012222884;5313.787448502094;5340.25236466895;5201.45384734605;5311.123664595337;5324.813631522917;5357.142857142839;5408.486193811582;5047.47001564834;5065.417476990119;5070.2394640803805;5077.847664570032;5126.231065340192;5471.917921231185;5472.644278121909;5472.699001554953;5478.287822583118;5480.177973304037;5230.660007099526;5288.524032837063;5294.338207724035;5315.760790764425;5336.066188417011;5342.9732851336275;5356.384015838151;5357.491038351351;5360.544353729899;5405.13517837152;5326.493983071602;5326.866828329323;5328.467153284718;5334.279872217201;5379.112446446371;5222.947770522246;5337.0393329201115;5360.8123715670545;5415.729213539386;5447.645903016291;4168.937465938014;4176.7076304658385;4182.665386769051;4186.476690413699;4221.514525829569;3759.9248015039548;3765.6234376562124;3797.2595343907674;3797.9430308545393;3798.7910664913693;4996.175631020841;5025.698458092526;5041.59667226621;5047.091523525727;5098.694078355311;5412.7564259607625;5433.157860531624;5434.429384914606;5454.672719636835;5458.263134476874;5106.897862042739;5129.461406552333;5155.819546315936;5168.586513078944;5201.739913004335;4518.1415531049;4551.590356867898;4578.107269082563;4602.585767280961;4621.260598304255;5520.309961254843;5520.503154716095;5531.170324451365;5534.634995647308;5537.086380747131;5258.789648414174;5262.342207224097;5263.73681315925;5307.256984022163;5339.946600533945;5684.431556844283;5704.515116215002;5727.255456790591;5763.94236057634;5779.653220806596;5319.946800531945;5322.840314790563;5322.973385133049;5325.627206095691;5330.8933821324135;5223.320968274252;5395.4604539545735;5402.51377376038;5428.728563571726;5451.236826844324;5276.815311464234;5319.41486436484;5323.787048518016;5327.866803329948;5369.865753356197;5280.075986702389;5309.522143007148;5320.467953204648;5329.57363410934;5375.435579264121;5075;5164.406093299319;5203.869903252449;5210.921836172536;5212.452692467388;5361.785528578813;5362.865928351823;5369.382521009978;5377.542908852635;5414.729263536886;5244.659097158673;5256.10646190141;5260.132078207206;5262.184361423985;5263.7894484220205 16:21:41 INFO - PROCESS | 17736 | |1;ext.html;520.8932168905375;532.252185679121;555.3724291550548;566.8696199874029;567.2172402085124;28555.714442855566;37001.07497312565;37301.25397492049;37359;37359.43960840586;39641;39835.20329593414;39972.600273997254;39985;40078;7495.66269517873;8337.666493340274;8560.614772335228;8565.271951884066;8566.357523185787;7535.736249231278;7653.885191722128;10166.13587845034;10418.166546676248;10433.113185379214;9979.051990060932;10036.096751292382;10080.747981300452;10084.546195421224;10108.292419530635;10035.247356448259;10065;10107.848382274271;10146.847797283046;10150.238732095086;9882.851757223647;10018.699439016842;10033.147182489498;10044.799104017879;10058.647947321808;35967.4604880927;36392.090197745005;38721.225575488614;38865.611343886485;38874.61125388738;3359.1434184283094;3364.3103163851597;3431.0564594736397;3436.1066122808;3526.8589256429714;26219;26822.865885670446;26851.86574067117;26862.328441788915;26914.058007969626;3249.7237734792334;3340.782849114824;3346.0631023313513;3366.530791015281;3453.533772940646;247151;249546;249784;250627;251185;40075.59924400777;40992.59007409888;58697;58976.41023589795;59448;39772.403413948814;39989.600103998586;39996.60003399987;40041.1991760169;40122.39816402756;14088.788668169986;14266.572002839932;14284.785728214085;14286.428542858377;14288.571342859523;11411.42942852854;11563.30620162793;11573.363465009505;11576.826347604792;11583.826242606368;13804.516841910485;14072.71854562903;14246.43014279438;14264.928675356765;14343.211123388106;5696.971515142481;5743.368229494752;5782.335031471351;5835.416458354131;5866.149408335853;910.7677542226689;977.2719324103589;1019.1337363241333;1030.5568605499557;1108.8946550077892;27816.582751258746;27888.72111278861;28175.43649127006;28331.716682832906;28405.289867753472;1000.5997600959674;1015.8957810445863;1016.5628779624684;1038.2628333883029;1086.0551320351344;14216.715665686628;14686.339114739862;14692.906359986206;14791.852081479263;14903.478378256927;293081;297558;298548;298698;299480;50381;51359.7432012845;51364;51387.22919156215;51422.74288628533;1248.5879659712273;1250.2061191143507;1307.320193499394;1344.5495758920677;1345.3206130904027;20484.487887802923;26740;27195;27345.31636709098;27470.45059098847;48234.758826205645;48823;48847.75576122239;48938.26592601185;48980;275197;275565;276400;276476;277011;31668.683313166573;42949.355759663005;43470.34794478149;43610.563894360654;43997.56002439935;39055;39079.804600976815;39614.40578391384;40171.39742903801;40269.59730402775;33927.830360848035;33942;34128.48807267943;34201;34425;33174;33275.50086748749;33498.497522536694;33792;34112;31106.688933111283;31262.06213813589;33059;38219.2356152881;38422.80788596039;30456.238594035327;31297.687023129478;31358.686413135576;31377.372452550364;32668.67331326656;24868.50262994694;24874.378140546632;24982.500349992533;25339;25339.746602533738 16:21:41 INFO - PROCESS | 17736 | |2;jquery.html;360.30820824017866;361.60584962391;368.530124091783;369.5048634829328;373.2181080636066;16978;17154.91422542887;18335.266589336443;18342;18363.0818459077;16585.41951031714;17258.654826903487;17346.56633584161;17376.652466950654;17391.73912391315;4596.218642830719;4822;4823.324734537167;4825.638077144211;4826.34844296019;3763.379042457991;4753.928691069636;5263.947360526403;5491;5502.889942201174;5466.508014278714;5486.561075114001;5489.478499542537;5503.6147469677135;5504.2018907258425;5202.141646628321;5453.672779633215;5484.7531861066145;5488.451154884519;5494.560435165217;5228.111221092423;5260.736963151865;5263.605229607795;5264.052470555299;5282.920756188661;12267.631971040882;12842.614721558368;12856.421461034182;12871.935640321832;13203.603891883258;2168.620491414012;2187.5187458759046;2362.5274945011065;2651.2974061873424;2886.7834912381445;9150.86273705895;9233.49215793131;9454.149126578572;9549.713508594754;9626.855597165979;1879.9436016919515;1934.8742331748392;2041.3875837248765;2042.6629606115123;2076.9065392057396;62026.379736202514;62361.6881915592;63025.68487157535;63207.683961580355;63385.366146338405;9982.650607228858;10170.796584068277;10285.331453455501;10576.841347379795;10720.678379648623;13927;14010.299485025707;14015;14033.649158771112;14048.71902561943;7438.293362130589;7683.346915512132;7692.576908270099;7747.031621047369;7750.844983100419;7378.188399276075;7404.37062849653;7538.3215510604305;7541.283578060075;7562.016937798161;4458.063806600585;4579.839705610354;4588;4628.097520983376;4656.627469802408;1734.167599552222;1759.3490408548919;1835.4034938644993;1855.3784482198614;1866.8226518480722;896.6054935828215;907.6390473261841;915.3546749541557;948.4593781544453;1032.963846265377;16381.426650067191;16909.976276688725;16928.49214523566;16974.599869487454;17140.828591714173;858.476204736585;920.4799288402031;929.9123467814799;931.8602209668604;968.0464742228899;9589.952050239845;9686.467244301632;9696.660616878375;9769.899471613637;9806;158213;158849;160198;161378;387462.0626896904;69511.65244173848;70678.64660676663;73539;73902.63048684722;73984.2601573988;952.2762700347786;956.6842941829041;967.0088159636429;969.4086607169621;974.8294048541477;14802.259887005392;14857.81137508975;14880;15096.54710358691;15355.539333820003;32658.673413265562;33231.667683322856;33762.49356259707;33841.661583384834;34262.82868585641;44965;47100.29349559691;47209.29186062143;47304;47488.287675685584;7663;7711.730089447067;7795.376369890509;7964.20357964199;7988;12081.154319197572;12361.196522226026;12494.875051249372;12642.494300227889;12714.173578717353;10155.289129760846;10483.947580262049;10731.356118632906;10786.460676965964;11055.557777688802;10491;10656.680299591024;10805.783884322112;10892.074173695324;10934.507947142238;10867.728306792393;10932;11051.889481105407;11255;11278.887211127783;7945.20547945224;7960.164182760958;8064.959675201587;8186.222308880647;8313.792155195926;10149.712245284747;10219.846702299621;10285.845712314172;10309.175265978854;10349.430781307101 16:21:41 INFO - PROCESS | 17736 | |3;mootools.html;1228.0789407944042;1466.105675537922;1482.629342664334;1640.3110693508725;1787.5888545634496;7302.37929775969;7426.44301677375;7446.96276518618;7449.702011919523;7449.962750186248;7388.556686598795;7554;7555.168931417554;7557.886631700529;7559.58422286774;1941.1167918597005;2198.626233540302;2220.322801545528;2244.9102035918545;2248.426651203949;2224.5550889822102;2229.019231538126;2234.7094877665963;2238.2613737466677;2238.876861772602;2143.506993391521;2208.3706143749037;2209.8674079555276;2212.8119109875597;2213.2253711201033;2179.1174574297434;2204;2211.6350802117713;2214.966775498369;2222.5999320122373;2204.7354317481845;2211.2481756202806;2212.214663794346;2223.7776222377634;2245.36007237938;7597.240275972414;7664.463487555873;7665.425093118039;7676.577788221645;7683.769486915401;4562.338460923148;4667.4632417272105;4675.555822196886;4677.087967846272;4678.883027924329;2915.271182204449;2942.6468823741075;2971.7028297170327;2973.55396690496;3064.4024415239037;926.3284119013729;927.2952556057378;928.7213835849218;965.8502932045544;975.5414954971152;10315.226358023103;10347.327423717434;10351.689449316533;10361.948190259076;10397.636082737068;4061.878143655636;4154.937675934863;4176.707630465899;4203.327467605169;4205.222033923734;8896.154865287788;8931.464112153291;8934.597943092576;8935.731928042169;8946.776330591658;4174.3321068628875;4659.464161621457;4686.71879687213;4693.155232058262;4694.366260554782;4138.213739389506;4207.852725154666;4211.052513184571;4232.915341693149;4265.168292183057;3529.417646088418;3591.120175557005;3602.5676918769914;3622.040159357772;3652.634736526326;1125.1336470917347;1148.7013376522164;1149.2587281203578;1156.0693641618577;1160.6866146140494;1022.5296363672645;1039.0285083447002;1048.1981284317503;1140.657802659199;1280.1423046558828;7138.643067846587;7169.713211471587;7210.062691850026;7223.386012188917;7231.3130252625915;501.5335737763842;509.08619028843316;509.08619028843316;512.5694416689998;515.7704821354462;5498.917516237259;5533.418991005967;5538.975289571442;5570.5265052470995;5573.331200255995;8488;8623.137686231326;8635.395522313504;8774.51740154285;8812.8678069829;8591.3556483264;8629.52537610425;8665.133486651284;8666.220040196413;8670.479771213748;7134.215236324;7255.383292420203;7304.086989126359;7310.926890731131;7312.305330993547;7207.603581803051;7214.242504536948;7227.2772722729405;7263.818404539928;7283.162436319891;8215.342772578299;8223.17768223173;8287.046989596274;8312.08567057611;8455.239028487465;7910.2089791020435;8118.512889226666;8124.39067069984;8278.006639203335;8294.543800091053;6417.39034791694;6568.113304703995;6681.5656982296;6687.598744075371;6701.530892837454;7213.422926165789;7226.096737907762;7229;7233.240509746401;7278.344948954407;6321.209848768904;6329.651869147241;6412.422881940648;6511.9348806511325;6535.215774107138;6511.9348806511325;6541;6561.770338038145;6568.573042752206;6581;6870.725170993104;6892.586444813327;6921.169459664671;6923.792286231421;6955.895661565181;6239.875202495834;6295.496360291074;6315.368463153648;6322.905156422566;6421.71102300407;6438.774642887476;6441.098246245436;6452.290248072803;6464.903026454701;6474.643894585843 16:21:41 INFO - PROCESS | 17736 | |4;prototype.html;341.9316136772646;343.4630030613007;347.28979237459396;347.6697137719166;355.2787840683412;5962.165296858438;5966.79116230932;5971.0744834550605;5981.7906373277;5982.760689572412;5866.501347385477;5895.4399332063385;5899.233099697044;5899.793507227248;5916.4970977466855;4378.299472084467;4449.555044495541;4568.451785785694;4607.792649330771;4615.792289346988;4565.931511027321;4590.885227869313;4601.033782905593;4605.585497305242;4624.398828152335;4560.247559152735;4565.7717114144325;4575.176468235716;4585.037142200142;4586.266197408415;4355.782210889459;4471.306947423154;4551.226291530448;4560.543945605446;4599.425071866017;4049.1091959768805;4052.513698356216;4060.634542891154;4068;4086.7752273624938;5622.240997465331;5637.210790489335;5638.718064096779;5645.2096706461125;5656.264685590888;5312.442193569658;5359.330083739533;5360.731963401814;5360.839174824761;5365.7853685852515;6264.404881536247;6279.560430769848;6280.842978925563;6281.120643109968;6286.49708023357;4438.622717069053;4510.774461276923;4542.523035081302;4551.385562948993;4558.77206139695;6486.772962946275;6549.5742776719835;6559;6561.3766692164645;6590.373914478117;4606.976965115153;4641.071785642885;4642.16441040616;4643.791029403685;4646.744429056367;4653.046125544255;4659.207934651117;4688.296755486705;4693.06138772247;4699.483056863811;5351.51836334724;5362.705051222142;5367.141257398797;5367.812126575551;5368.812091576854;6074.878502430015;6295.401936815995;6355.523335749745;6358.078078678565;6362.618242905441;1631.7389217725345;1656.287796247601;1660.900345979245;1662.7672125902384;1662.8170901200858;1055.145332280855;1093.2893619147617;1097.8627671541058;1114.6043154679971;1117.1956191542076;5941.732622032019;6011.09833524966;6013.939860601426;6019.578629495893;6041.305249896231;6390.265119511316;6402.423781859655;6416.871662566722;6419.775307864203;6422.8715425691225;5990.071538911476;5995.010823214121;5998.400159983967;5999.370066143079;6001.189839371629;3436.759426840147;3484.5121682964404;3485.233248685285;3487.773294735885;3488.5290485784094;6637.933620663828;6823.624700641512;6838.897416538756;6948.652567371712;7000.054992576039;6698.196216454056;6729.831754206086;6731.764388246388;6735.831604209934;6753.257141714407;6972.337627925441;6993.580385176906;6993.825154371079;6996.510244282851;6996.720131194797;6555.967220163869;6562.212534495891;6565.474762019123;6569.441597464269;6573.80278591643;6328.335524770017;6496.837579060561;6506.089147519446;6512.511561632802;6525.184351956005;6949.826254343682;6988.965055174692;6992.61540615271;6996.720131194696;7003.159620845531;4454.242778727559;4497.617702495194;4498.2352999990735;4499.977500112478;4507.549245075466;6579.638119903451;6582.473402127914;6587.275399705933;6587.440067594116;6596;6242.344553821783;6391.936080639134;6392.872142557216;6393.680315984275;6395.264544577433;6286.779962701284;6378.425941665087;6380.330065343258;6381.978883378637;6383.0744542042075;6183;6206.379362063757;6209.875802484015;6216.875662486635;6218;6402.167718196604;6404.647744374104;6404.7438102477245;6411.134496842867;6416.935830641633;5985.820425387245;6144.293406258337;6266.436020758154;6266.968665156645;6267.310595834363 16:21:41 INFO - PROCESS | 17736 | |5;yui.html;765.2041876448494;793.0641842625703;799.6921185343642;804.8752443371276;827.383599218582;12841.42213600388;12985.545505907296;12991.090623656348;13001.284929328895;13006.284654344006;11826.172167948247;11849.526018959254;13459.327033648327;13811.37848796804;13814.654633634163;789.0886026639226;820.7660816667221;829.3199576347398;829.3779665251062;831.2352635575285;676.949228807839;811.7199566149699;821.0475848016303;828.0477450931447;828.6809578312333;854.6453221912899;857.764114868413;860.2343913916619;863.3826813828111;866.4541338956449;693.0643631098028;858.9484630922165;859.793649524116;860.8579584368572;862.3187681731424;625.4683519008806;631.0439683878881;634.1217413881807;635.0284065379976;635.4249404289126;12720.554780582635;12782.552610658582;12785.232886026775;12804.295763732991;12827.807582886171;12197.45111469977;12409.441575129142;12550.1842380245;12725.363731813371;12777.488900443972;10415.68752937413;10613.628523001735;10704.571817127384;10773.622923197729;10917.290376125526;3625.8912232633065;3648.3068217038945;3683.1528748387755;3747.775133491999;3754.1928485375774;50655.49344506545;50966.235506467434;51225;51291.48708512905;51617.741911290206;9657.275704322205;9763.804723905481;9886.4562449066;9976.301658883953;10447.111995480318;18084.18621162051;18084.276628934695;18103.18535665898;18107.094645267684;18138.455846324632;7168.319009694071;7434.405247580289;7495.925040749632;7523.285287897641;7660.463767536219;4421.093675796454;4461.308497182942;4480.171168333869;4511.097780443859;4575.359449676981;3041.4981528047624;3061.1734831595345;3062.8162310261455;3066.7546596272246;3068.4783586789854;521.304059081131;522.1254398881857;527.8917821846512;532.4329588987715;550.3808215757273;639.280809089774;642.4667525953447;646.890028695123;676.5805200775452;701.2951983256896;8388.32893368529;8576.099509551532;8715.651373945098;8747.912520874837;8858.29133669305;625.8967270400424;639.7313128486047;654.5900407388318;655.8917778566579;672.143017652497;3844.2888065707934;3878.146807702301;3902.6292502212245;3917.882463526099;4144.937825932613;55413.72293138589;55878.72060639671;56242.43757562372;56420.71789641108;56454;48277.51722482801;48591.27113093306;48812;48884.51115488871;50127.49872501228;44135;44651;44911.77544112324;44959.10081798346;45553;7536.321731044232;7562.924370756442;7814.33578145864;7886.329661978567;8038.276555110068;33467.66532334645;34139.48790768091;34160.48759268663;34546.30907381788;35503.644963551065;41587.7920610395;43615.12769744651;43863.34204986991;44149.33775993427;44522;10144.087032167141;10232.53953572106;10324.174066074545;10563.260571759904;10709.892901070889;10635.574577016832;10697.839532407175;10804;10963.177761667748;11003.284786488852;8591.570421479026;9545.809083818145;11774.3524106175;11975.041996640073;12004.879951200377;11458.4270786462;11673.416329183678;11774.234674746114;11957;11967.042636588878;11561.42192890369;11612.419379031184;11718.179727419;11825.349605771766;12135.75728485443;7994.320482759031;8641;9618.326717129734;9744.366616169926;9882.209423246266;9332.007376053778;9888.406695598287;10040.347377420445;10129.64546240878;10176.694699159038 16:21:41 INFO - PROCESS | 17736 | __end_tp_report 16:21:41 INFO - PROCESS | 17736 | __start_cc_report 16:21:41 INFO - PROCESS | 17736 | _x_x_mozilla_cycle_collect,856 16:21:41 INFO - PROCESS | 17736 | __end_cc_report 16:21:41 INFO - PROCESS | 17736 | __startTimestamp1456532501363__endTimestamp 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | ------- Summary: start ------- 16:21:41 INFO - PROCESS | 17736 | Number of tests: 6 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#0] dojo.html Cycles:165 Average:5023.35 Median:5223.32 stddev:530.84 (10.2%) stddev-sans-first:509.27 16:21:41 INFO - PROCESS | 17736 | Values: 3044.6 3121.7 3127.1 3137.1 3156.7 4905.1 5023.7 5036.1 5081.3 5113.4 4996.3 5020.5 5060.3 5098.0 5112.6 4573.6 4634.8 4663.1 4720.4 4807.2 4723.5 4728.4 4769.4 4781.1 4806.4 4563.3 4571.1 4642.6 4648.6 4664.9 4597.6 4602.7 4604.1 4611.4 4634.9 4531.8 4593.1 4593.6 4612.4 4629.2 4841.2 4860.4 4882.6 4907.5 4920.5 5292.9 5295.8 5297.1 5313.8 5340.3 5201.5 5311.1 5324.8 5357.1 5408.5 5047.5 5065.4 5070.2 5077.8 5126.2 5471.9 5472.6 5472.7 5478.3 5480.2 5230.7 5288.5 5294.3 5315.8 5336.1 5343.0 5356.4 5357.5 5360.5 5405.1 5326.5 5326.9 5328.5 5334.3 5379.1 5222.9 5337.0 5360.8 5415.7 5447.6 4168.9 4176.7 4182.7 4186.5 4221.5 3759.9 3765.6 3797.3 3797.9 3798.8 4996.2 5025.7 5041.6 5047.1 5098.7 5412.8 5433.2 5434.4 5454.7 5458.3 5106.9 5129.5 5155.8 5168.6 5201.7 4518.1 4551.6 4578.1 4602.6 4621.3 5520.3 5520.5 5531.2 5534.6 5537.1 5258.8 5262.3 5263.7 5307.3 5339.9 5684.4 5704.5 5727.3 5763.9 5779.7 5319.9 5322.8 5323.0 5325.6 5330.9 5223.3 5395.5 5402.5 5428.7 5451.2 5276.8 5319.4 5323.8 5327.9 5369.9 5280.1 5309.5 5320.5 5329.6 5375.4 5075.0 5164.4 5203.9 5210.9 5212.5 5361.8 5362.9 5369.4 5377.5 5414.7 5244.7 5256.1 5260.1 5262.2 5263.8 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#1] ext.html Cycles:180 Average:43524.10 Median:31523.03 stddev:71761.63 (227.6%) stddev-sans-first:71890.30 16:21:41 INFO - PROCESS | 17736 | Values: 520.9 532.3 555.4 566.9 567.2 28555.7 37001.1 37301.3 37359.0 37359.4 39641.0 39835.2 39972.6 39985.0 40078.0 7495.7 8337.7 8560.6 8565.3 8566.4 7535.7 7653.9 10166.1 10418.2 10433.1 9979.1 10036.1 10080.7 10084.5 10108.3 10035.2 10065.0 10107.8 10146.8 10150.2 9882.9 10018.7 10033.1 10044.8 10058.6 35967.5 36392.1 38721.2 38865.6 38874.6 3359.1 3364.3 3431.1 3436.1 3526.9 26219.0 26822.9 26851.9 26862.3 26914.1 3249.7 3340.8 3346.1 3366.5 3453.5 247151.0 249546.0 249784.0 250627.0 251185.0 40075.6 40992.6 58697.0 58976.4 59448.0 39772.4 39989.6 39996.6 40041.2 40122.4 14088.8 14266.6 14284.8 14286.4 14288.6 11411.4 11563.3 11573.4 11576.8 11583.8 13804.5 14072.7 14246.4 14264.9 14343.2 5697.0 5743.4 5782.3 5835.4 5866.1 910.8 977.3 1019.1 1030.6 1108.9 27816.6 27888.7 28175.4 28331.7 28405.3 1000.6 1015.9 1016.6 1038.3 1086.1 14216.7 14686.3 14692.9 14791.9 14903.5 293081.0 297558.0 298548.0 298698.0 299480.0 50381.0 51359.7 51364.0 51387.2 51422.7 1248.6 1250.2 1307.3 1344.5 1345.3 20484.5 26740.0 27195.0 27345.3 27470.5 48234.8 48823.0 48847.8 48938.3 48980.0 275197.0 275565.0 276400.0 276476.0 277011.0 31668.7 42949.4 43470.3 43610.6 43997.6 39055.0 39079.8 39614.4 40171.4 40269.6 33927.8 33942.0 34128.5 34201.0 34425.0 33174.0 33275.5 33498.5 33792.0 34112.0 31106.7 31262.1 33059.0 38219.2 38422.8 30456.2 31297.7 31358.7 31377.4 32668.7 24868.5 24874.4 24982.5 25339.0 25339.7 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#2] jquery.html Cycles:180 Average:18613.33 Median:195960.06 stddev:38565.01 (19.7%) stddev-sans-first:38648.85 16:21:41 INFO - PROCESS | 17736 | Values: 360.3 361.6 368.5 369.5 373.2 16978.0 17154.9 18335.3 18342.0 18363.1 16585.4 17258.7 17346.6 17376.7 17391.7 4596.2 4822.0 4823.3 4825.6 4826.3 3763.4 4753.9 5263.9 5491.0 5502.9 5466.5 5486.6 5489.5 5503.6 5504.2 5202.1 5453.7 5484.8 5488.5 5494.6 5228.1 5260.7 5263.6 5264.1 5282.9 12267.6 12842.6 12856.4 12871.9 13203.6 2168.6 2187.5 2362.5 2651.3 2886.8 9150.9 9233.5 9454.1 9549.7 9626.9 1879.9 1934.9 2041.4 2042.7 2076.9 62026.4 62361.7 63025.7 63207.7 63385.4 9982.7 10170.8 10285.3 10576.8 10720.7 13927.0 14010.3 14015.0 14033.6 14048.7 7438.3 7683.3 7692.6 7747.0 7750.8 7378.2 7404.4 7538.3 7541.3 7562.0 4458.1 4579.8 4588.0 4628.1 4656.6 1734.2 1759.3 1835.4 1855.4 1866.8 896.6 907.6 915.4 948.5 1033.0 16381.4 16910.0 16928.5 16974.6 17140.8 858.5 920.5 929.9 931.9 968.0 9590.0 9686.5 9696.7 9769.9 9806.0 158213.0 158849.0 160198.0 161378.0 387462.1 69511.7 70678.6 73539.0 73902.6 73984.3 952.3 956.7 967.0 969.4 974.8 14802.3 14857.8 14880.0 15096.5 15355.5 32658.7 33231.7 33762.5 33841.7 34262.8 44965.0 47100.3 47209.3 47304.0 47488.3 7663.0 7711.7 7795.4 7964.2 7988.0 12081.2 12361.2 12494.9 12642.5 12714.2 10155.3 10483.9 10731.4 10786.5 11055.6 10491.0 10656.7 10805.8 10892.1 10934.5 10867.7 10932.0 11051.9 11255.0 11278.9 7945.2 7960.2 8065.0 8186.2 8313.8 10149.7 10219.8 10285.8 10309.2 10349.4 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#3] mootools.html Cycles:180 Average:5272.73 Median:6371.04 stddev:2739.30 (43.0%) stddev-sans-first:2730.11 16:21:41 INFO - PROCESS | 17736 | Values: 1228.1 1466.1 1482.6 1640.3 1787.6 7302.4 7426.4 7447.0 7449.7 7450.0 7388.6 7554.0 7555.2 7557.9 7559.6 1941.1 2198.6 2220.3 2244.9 2248.4 2224.6 2229.0 2234.7 2238.3 2238.9 2143.5 2208.4 2209.9 2212.8 2213.2 2179.1 2204.0 2211.6 2215.0 2222.6 2204.7 2211.2 2212.2 2223.8 2245.4 7597.2 7664.5 7665.4 7676.6 7683.8 4562.3 4667.5 4675.6 4677.1 4678.9 2915.3 2942.6 2971.7 2973.6 3064.4 926.3 927.3 928.7 965.9 975.5 10315.2 10347.3 10351.7 10361.9 10397.6 4061.9 4154.9 4176.7 4203.3 4205.2 8896.2 8931.5 8934.6 8935.7 8946.8 4174.3 4659.5 4686.7 4693.2 4694.4 4138.2 4207.9 4211.1 4232.9 4265.2 3529.4 3591.1 3602.6 3622.0 3652.6 1125.1 1148.7 1149.3 1156.1 1160.7 1022.5 1039.0 1048.2 1140.7 1280.1 7138.6 7169.7 7210.1 7223.4 7231.3 501.5 509.1 509.1 512.6 515.8 5498.9 5533.4 5539.0 5570.5 5573.3 8488.0 8623.1 8635.4 8774.5 8812.9 8591.4 8629.5 8665.1 8666.2 8670.5 7134.2 7255.4 7304.1 7310.9 7312.3 7207.6 7214.2 7227.3 7263.8 7283.2 8215.3 8223.2 8287.0 8312.1 8455.2 7910.2 8118.5 8124.4 8278.0 8294.5 6417.4 6568.1 6681.6 6687.6 6701.5 7213.4 7226.1 7229.0 7233.2 7278.3 6321.2 6329.7 6412.4 6511.9 6535.2 6511.9 6541.0 6561.8 6568.6 6581.0 6870.7 6892.6 6921.2 6923.8 6955.9 6239.9 6295.5 6315.4 6322.9 6421.7 6438.8 6441.1 6452.3 6464.9 6474.6 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#4] prototype.html Cycles:180 Average:5323.06 Median:5984.29 stddev:1596.63 (26.7%) stddev-sans-first:1556.72 16:21:41 INFO - PROCESS | 17736 | Values: 341.9 343.5 347.3 347.7 355.3 5962.2 5966.8 5971.1 5981.8 5982.8 5866.5 5895.4 5899.2 5899.8 5916.5 4378.3 4449.6 4568.5 4607.8 4615.8 4565.9 4590.9 4601.0 4605.6 4624.4 4560.2 4565.8 4575.2 4585.0 4586.3 4355.8 4471.3 4551.2 4560.5 4599.4 4049.1 4052.5 4060.6 4068.0 4086.8 5622.2 5637.2 5638.7 5645.2 5656.3 5312.4 5359.3 5360.7 5360.8 5365.8 6264.4 6279.6 6280.8 6281.1 6286.5 4438.6 4510.8 4542.5 4551.4 4558.8 6486.8 6549.6 6559.0 6561.4 6590.4 4607.0 4641.1 4642.2 4643.8 4646.7 4653.0 4659.2 4688.3 4693.1 4699.5 5351.5 5362.7 5367.1 5367.8 5368.8 6074.9 6295.4 6355.5 6358.1 6362.6 1631.7 1656.3 1660.9 1662.8 1662.8 1055.1 1093.3 1097.9 1114.6 1117.2 5941.7 6011.1 6013.9 6019.6 6041.3 6390.3 6402.4 6416.9 6419.8 6422.9 5990.1 5995.0 5998.4 5999.4 6001.2 3436.8 3484.5 3485.2 3487.8 3488.5 6637.9 6823.6 6838.9 6948.7 7000.1 6698.2 6729.8 6731.8 6735.8 6753.3 6972.3 6993.6 6993.8 6996.5 6996.7 6556.0 6562.2 6565.5 6569.4 6573.8 6328.3 6496.8 6506.1 6512.5 6525.2 6949.8 6989.0 6992.6 6996.7 7003.2 4454.2 4497.6 4498.2 4500.0 4507.5 6579.6 6582.5 6587.3 6587.4 6596.0 6242.3 6391.9 6392.9 6393.7 6395.3 6286.8 6378.4 6380.3 6382.0 6383.1 6183.0 6206.4 6209.9 6216.9 6218.0 6402.2 6404.6 6404.7 6411.1 6416.9 5985.8 6144.3 6266.4 6267.0 6267.3 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | [#5] yui.html Cycles:180 Average:13587.40 Median:25064.18 stddev:15729.13 (62.8%) stddev-sans-first:15743.78 16:21:41 INFO - PROCESS | 17736 | Values: 765.2 793.1 799.7 804.9 827.4 12841.4 12985.5 12991.1 13001.3 13006.3 11826.2 11849.5 13459.3 13811.4 13814.7 789.1 820.8 829.3 829.4 831.2 676.9 811.7 821.0 828.0 828.7 854.6 857.8 860.2 863.4 866.5 693.1 858.9 859.8 860.9 862.3 625.5 631.0 634.1 635.0 635.4 12720.6 12782.6 12785.2 12804.3 12827.8 12197.5 12409.4 12550.2 12725.4 12777.5 10415.7 10613.6 10704.6 10773.6 10917.3 3625.9 3648.3 3683.2 3747.8 3754.2 50655.5 50966.2 51225.0 51291.5 51617.7 9657.3 9763.8 9886.5 9976.3 10447.1 18084.2 18084.3 18103.2 18107.1 18138.5 7168.3 7434.4 7495.9 7523.3 7660.5 4421.1 4461.3 4480.2 4511.1 4575.4 3041.5 3061.2 3062.8 3066.8 3068.5 521.3 522.1 527.9 532.4 550.4 639.3 642.5 646.9 676.6 701.3 8388.3 8576.1 8715.7 8747.9 8858.3 625.9 639.7 654.6 655.9 672.1 3844.3 3878.1 3902.6 3917.9 4144.9 55413.7 55878.7 56242.4 56420.7 56454.0 48277.5 48591.3 48812.0 48884.5 50127.5 44135.0 44651.0 44911.8 44959.1 45553.0 7536.3 7562.9 7814.3 7886.3 8038.3 33467.7 34139.5 34160.5 34546.3 35503.6 41587.8 43615.1 43863.3 44149.3 44522.0 10144.1 10232.5 10324.2 10563.3 10709.9 10635.6 10697.8 10804.0 10963.2 11003.3 8591.6 9545.8 11774.4 11975.0 12004.9 11458.4 11673.4 11774.2 11957.0 11967.0 11561.4 11612.4 11718.2 11825.3 12135.8 7994.3 8641.0 9618.3 9744.4 9882.2 9332.0 9888.4 10040.3 10129.6 10176.7 16:21:41 INFO - PROCESS | 17736 | -------- Summary: end -------- 16:21:41 INFO - PROCESS | 17736 | 16:21:41 INFO - PROCESS | 17736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:41 INFO - PROCESS | 17736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:41 INFO - PROCESS | 17736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:41 INFO - PROCESS | 17736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:41 INFO - PROCESS | 17736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:42 INFO - TEST-INFO | 17736: exit 0 16:21:42 INFO - TEST-OK | dromaeo_css | took 1112791ms 16:21:42 INFO - TEST-START | kraken 16:21:42 INFO - operating with platform_type : linux_ 16:21:42 INFO - Initialising browser for kraken test... 16:21:42 INFO - TEST-INFO | started process 17927 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXYa6O/profile http://localhost:58910/getInfo.html) 16:21:45 INFO - PROCESS | 17927 | __metrics Screen width/height:1600/1200 16:21:45 INFO - PROCESS | 17927 | colorDepth:24 16:21:45 INFO - PROCESS | 17927 | Browser inner width/height: 1024/697 16:21:45 INFO - PROCESS | 17927 | __metrics 16:21:46 INFO - PROCESS | 17927 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:21:46 INFO - PROCESS | 17927 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:21:47 INFO - TEST-INFO | 17927: exit 0 16:21:47 INFO - Browser initialized. 16:21:47 INFO - Running cycle 1/1 for kraken test... 16:21:47 INFO - TEST-INFO | started process 18011 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbXYa6O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:59 INFO - PROCESS | 18011 | RSS: Main: 150368256 16:21:59 INFO - PROCESS | 18011 | 16:22:01 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58910/tests/kraken/driver.html?testName=audio-beat-detection) 16:22:02 INFO - PROCESS | 18011 | RSS: Main: 195739648 16:22:02 INFO - PROCESS | 18011 | 16:22:04 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58910/tests/kraken/driver.html?testName=audio-dft) 16:22:05 INFO - PROCESS | 18011 | RSS: Main: 185155584 16:22:05 INFO - PROCESS | 18011 | 16:22:08 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58910/tests/kraken/driver.html?testName=audio-fft) 16:22:09 INFO - PROCESS | 18011 | RSS: Main: 168222720 16:22:09 INFO - PROCESS | 18011 | 16:22:11 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58910/tests/kraken/driver.html?testName=audio-oscillator) 16:22:11 INFO - PROCESS | 18011 | RSS: Main: 170844160 16:22:11 INFO - PROCESS | 18011 | 16:22:13 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:22:14 INFO - PROCESS | 18011 | RSS: Main: 172630016 16:22:14 INFO - PROCESS | 18011 | 16:22:17 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58910/tests/kraken/driver.html?testName=imaging-darkroom) 16:22:18 INFO - PROCESS | 18011 | RSS: Main: 173006848 16:22:18 INFO - PROCESS | 18011 | 16:22:21 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58910/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:21 INFO - PROCESS | 18011 | RSS: Main: 172785664 16:22:21 INFO - PROCESS | 18011 | 16:22:24 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58910/tests/kraken/driver.html?testName=json-parse-financial) 16:22:25 INFO - PROCESS | 18011 | RSS: Main: 174252032 16:22:25 INFO - PROCESS | 18011 | 16:22:26 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:27 INFO - PROCESS | 18011 | RSS: Main: 185036800 16:22:27 INFO - PROCESS | 18011 | 16:22:29 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:29 INFO - PROCESS | 18011 | RSS: Main: 183169024 16:22:29 INFO - PROCESS | 18011 | 16:22:31 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:32 INFO - PROCESS | 18011 | RSS: Main: 192073728 16:22:32 INFO - PROCESS | 18011 | 16:22:34 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:35 INFO - PROCESS | 18011 | RSS: Main: 197566464 16:22:35 INFO - PROCESS | 18011 | 16:22:38 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:38 INFO - PROCESS | 18011 | RSS: Main: 199413760 16:22:38 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | Cycle 1(1): loaded http://localhost:58910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58910/tests/kraken/driver.html?testName=ai-astar) 16:22:40 INFO - PROCESS | 18011 | RSS: Main: 258899968 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | __start_tp_report 16:22:40 INFO - PROCESS | 18011 | _x_x_mozilla_page_load 16:22:40 INFO - PROCESS | 18011 | _x_x_mozilla_page_load_details 16:22:40 INFO - PROCESS | 18011 | |i|pagename|runs| 16:22:40 INFO - PROCESS | 18011 | |0;ai-astar;110;112;105;111;112;114;101;111;111;109 16:22:40 INFO - PROCESS | 18011 | |1;audio-beat-detection;150;124;150;166;125;149;152;129;163;125 16:22:40 INFO - PROCESS | 18011 | |2;audio-dft;162;160;162;162;162;163;161;163;162;162 16:22:40 INFO - PROCESS | 18011 | |3;audio-fft;73;74;102;95;73;75;73;118;96;72 16:22:40 INFO - PROCESS | 18011 | |4;audio-oscillator;95;94;151;95;95;95;149;95;95;134 16:22:40 INFO - PROCESS | 18011 | |5;imaging-gaussian-blur;119;114;114;115;115;115;114;114;115;115 16:22:40 INFO - PROCESS | 18011 | |6;imaging-darkroom;148;145;146;145;145;145;145;145;147;145 16:22:40 INFO - PROCESS | 18011 | |7;imaging-desaturate;96;96;97;96;96;96;96;96;96;95 16:22:40 INFO - PROCESS | 18011 | |8;json-parse-financial;56;55;55;55;56;56;57;63;54;53 16:22:40 INFO - PROCESS | 18011 | |9;json-stringify-tinderbox;68;68;69;68;68;68;68;68;68;68 16:22:40 INFO - PROCESS | 18011 | |10;stanford-crypto-aes;81;82;83;82;82;89;82;82;82;82 16:22:40 INFO - PROCESS | 18011 | |11;stanford-crypto-ccm;115;119;119;130;119;118;126;118;132;116 16:22:40 INFO - PROCESS | 18011 | |12;stanford-crypto-pbkdf2;152;138;151;150;143;142;164;144;149;150 16:22:40 INFO - PROCESS | 18011 | |13;stanford-crypto-sha256-iterative;68;70;68;68;69;72;69;69;72;68 16:22:40 INFO - PROCESS | 18011 | __end_tp_report 16:22:40 INFO - PROCESS | 18011 | __start_cc_report 16:22:40 INFO - PROCESS | 18011 | _x_x_mozilla_cycle_collect,1083 16:22:40 INFO - PROCESS | 18011 | __end_cc_report 16:22:40 INFO - PROCESS | 18011 | __startTimestamp1456532560656__endTimestamp 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | ------- Summary: start ------- 16:22:40 INFO - PROCESS | 18011 | Number of tests: 14 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.84 (3.5%) stddev-sans-first:4.07 16:22:40 INFO - PROCESS | 18011 | Values: 110.0 112.0 105.0 111.0 112.0 114.0 101.0 111.0 111.0 109.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:16.15 (10.8%) stddev-sans-first:16.95 16:22:40 INFO - PROCESS | 18011 | Values: 150.0 124.0 150.0 166.0 125.0 149.0 152.0 129.0 163.0 125.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 16:22:40 INFO - PROCESS | 18011 | Values: 162.0 160.0 162.0 162.0 162.0 163.0 161.0 163.0 162.0 162.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#3] audio-fft Cycles:10 Average:85.10 Median:73.50 stddev:16.40 (22.3%) stddev-sans-first:16.80 16:22:40 INFO - PROCESS | 18011 | Values: 73.0 74.0 102.0 95.0 73.0 75.0 73.0 118.0 96.0 72.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:24.46 (25.7%) stddev-sans-first:25.35 16:22:40 INFO - PROCESS | 18011 | Values: 95.0 94.0 151.0 95.0 95.0 95.0 149.0 95.0 95.0 134.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 16:22:40 INFO - PROCESS | 18011 | Values: 119.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 115.0 115.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.00 stddev:1.07 (0.7%) stddev-sans-first:0.71 16:22:40 INFO - PROCESS | 18011 | Values: 148.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 147.0 145.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:22:40 INFO - PROCESS | 18011 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.71 (4.8%) stddev-sans-first:2.87 16:22:40 INFO - PROCESS | 18011 | Values: 56.0 55.0 55.0 55.0 56.0 56.0 57.0 63.0 54.0 53.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 16:22:40 INFO - PROCESS | 18011 | Values: 68.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:2.26 (2.8%) stddev-sans-first:2.32 16:22:40 INFO - PROCESS | 18011 | Values: 81.0 82.0 83.0 82.0 82.0 89.0 82.0 82.0 82.0 82.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:119.00 stddev:5.94 (5.0%) stddev-sans-first:5.86 16:22:40 INFO - PROCESS | 18011 | Values: 115.0 119.0 119.0 130.0 119.0 118.0 126.0 118.0 132.0 116.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:150.00 stddev:7.20 (4.8%) stddev-sans-first:7.51 16:22:40 INFO - PROCESS | 18011 | Values: 152.0 138.0 151.0 150.0 143.0 142.0 164.0 144.0 149.0 150.0 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.59 16:22:40 INFO - PROCESS | 18011 | Values: 68.0 70.0 68.0 68.0 69.0 72.0 69.0 69.0 72.0 68.0 16:22:40 INFO - PROCESS | 18011 | -------- Summary: end -------- 16:22:40 INFO - PROCESS | 18011 | 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:40 INFO - PROCESS | 18011 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:22:41 INFO - TEST-INFO | 18011: exit 0 16:22:41 INFO - TEST-OK | kraken | took 59530ms 16:22:41 INFO - SUITE-END | took 1172s 16:22:41 INFO - Completed test suite (00:19:32) 16:22:41 INFO - Working with test: dromaeo_css 16:22:41 INFO - Generating results file: dromaeo_css 16:22:41 INFO - Working with test: kraken 16:22:41 INFO - Generating results file: kraken 16:22:41 INFO - javascript benchmark 16:22:41 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:22:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 16:22:41 INFO - process_Request line: dromaeo_css 6708.17 graph.html#tests=[[72,1,35]] 16:22:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:22:41 INFO - process_Request line: kraken 1511.90 graph.html#tests=[[232,1,35]] 16:22:41 INFO - RETURN: dromaeo_css: 6708.17 16:22:41 INFO - RETURN: kraken: 1511.90 16:22:41 INFO - javascript benchmark 16:22:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3044.558539011845, 3121.6878312168774, 3127.1244051665535, 3137.0745630039137, 3156.731677807387, 4905.141600219965, 5023.6734612250175, 5036.068327359437, 5081.339425874631, 5113.360829896263, 4996.325496058031, 5020.472850350716, 5060.266261392105, 5097.974510127444, 5112.590992720583, 4573.588377046065, 4634.814607415699, 4663.137319595886, 4720.386349774524, 4807.206810876201, 4723.4568024677255, 4728.385309909724, 4769.403824521934, 4781.091592597413, 4806.4472585652575, 4563.26987681971, 4571.131485017852, 4642.558956899089, 4648.581627653527, 4664.930026049612, 4597.563231493003, 4602.7008244464005, 4604.1252162089095, 4611.446626404853, 4634.9073018539775, 4531.77341132942, 4593.127305811919, 4593.609543188833, 4612.377329060568, 4629.23617603095, 4841.176999910023, 4860.3681521401995, 4882.560569548722, 4907.509249075099, 4920.532549407801, 5292.894142117175, 5295.761690723926, 5297.073012222884, 5313.787448502094, 5340.25236466895, 5201.45384734605, 5311.123664595337, 5324.813631522917, 5357.142857142839, 5408.486193811582, 5047.47001564834, 5065.417476990119, 5070.2394640803805, 5077.847664570032, 5126.231065340192, 5471.917921231185, 5472.644278121909, 5472.699001554953, 5478.287822583118, 5480.177973304037, 5230.660007099526, 5288.524032837063, 5294.338207724035, 5315.760790764425, 5336.066188417011, 5342.9732851336275, 5356.384015838151, 5357.491038351351, 5360.544353729899, 5405.13517837152, 5326.493983071602, 5326.866828329323, 5328.467153284718, 5334.279872217201, 5379.112446446371, 5222.947770522246, 5337.0393329201115, 5360.8123715670545, 5415.729213539386, 5447.645903016291, 4168.937465938014, 4176.7076304658385, 4182.665386769051, 4186.476690413699, 4221.514525829569, 3759.9248015039548, 3765.6234376562124, 3797.2595343907674, 3797.9430308545393, 3798.7910664913693, 4996.175631020841, 5025.698458092526, 5041.59667226621, 5047.091523525727, 5098.694078355311, 5412.7564259607625, 5433.157860531624, 5434.429384914606, 5454.672719636835, 5458.263134476874, 5106.897862042739, 5129.461406552333, 5155.819546315936, 5168.586513078944, 5201.739913004335, 4518.1415531049, 4551.590356867898, 4578.107269082563, 4602.585767280961, 4621.260598304255, 5520.309961254843, 5520.503154716095, 5531.170324451365, 5534.634995647308, 5537.086380747131, 5258.789648414174, 5262.342207224097, 5263.73681315925, 5307.256984022163, 5339.946600533945, 5684.431556844283, 5704.515116215002, 5727.255456790591, 5763.94236057634, 5779.653220806596, 5319.946800531945, 5322.840314790563, 5322.973385133049, 5325.627206095691, 5330.8933821324135, 5223.320968274252, 5395.4604539545735, 5402.51377376038, 5428.728563571726, 5451.236826844324, 5276.815311464234, 5319.41486436484, 5323.787048518016, 5327.866803329948, 5369.865753356197, 5280.075986702389, 5309.522143007148, 5320.467953204648, 5329.57363410934, 5375.435579264121, 5075.0, 5164.406093299319, 5203.869903252449, 5210.921836172536, 5212.452692467388, 5361.785528578813, 5362.865928351823, 5369.382521009978, 5377.542908852635, 5414.729263536886, 5244.659097158673, 5256.10646190141, 5260.132078207206, 5262.184361423985, 5263.7894484220205], "unit": "score", "name": "dojo.html", "value": 4990.853867021354}, {"lowerIsBetter": false, "replicates": [520.8932168905375, 532.252185679121, 555.3724291550548, 566.8696199874029, 567.2172402085124, 28555.714442855566, 37001.07497312565, 37301.25397492049, 37359.0, 37359.43960840586, 39641.0, 39835.20329593414, 39972.600273997254, 39985.0, 40078.0, 7495.66269517873, 8337.666493340274, 8560.614772335228, 8565.271951884066, 8566.357523185787, 7535.736249231278, 7653.885191722128, 10166.13587845034, 10418.166546676248, 10433.113185379214, 9979.051990060932, 10036.096751292382, 10080.747981300452, 10084.546195421224, 10108.292419530635, 10035.247356448259, 10065.0, 10107.848382274271, 10146.847797283046, 10150.238732095086, 9882.851757223647, 10018.699439016842, 10033.147182489498, 10044.799104017879, 10058.647947321808, 35967.4604880927, 36392.090197745005, 38721.225575488614, 38865.611343886485, 38874.61125388738, 3359.1434184283094, 3364.3103163851597, 3431.0564594736397, 3436.1066122808, 3526.8589256429714, 26219.0, 26822.865885670446, 26851.86574067117, 26862.328441788915, 26914.058007969626, 3249.7237734792334, 3340.782849114824, 3346.0631023313513, 3366.530791015281, 3453.533772940646, 247151.0, 249546.0, 249784.0, 250627.0, 251185.0, 40075.59924400777, 40992.59007409888, 58697.0, 58976.41023589795, 59448.0, 39772.403413948814, 39989.600103998586, 39996.60003399987, 40041.1991760169, 40122.39816402756, 14088.788668169986, 14266.572002839932, 14284.785728214085, 14286.428542858377, 14288.571342859523, 11411.42942852854, 11563.30620162793, 11573.363465009505, 11576.826347604792, 11583.826242606368, 13804.516841910485, 14072.71854562903, 14246.43014279438, 14264.928675356765, 14343.211123388106, 5696.971515142481, 5743.368229494752, 5782.335031471351, 5835.416458354131, 5866.149408335853, 910.7677542226689, 977.2719324103589, 1019.1337363241333, 1030.5568605499557, 1108.8946550077892, 27816.582751258746, 27888.72111278861, 28175.43649127006, 28331.716682832906, 28405.289867753472, 1000.5997600959674, 1015.8957810445863, 1016.5628779624684, 1038.2628333883029, 1086.0551320351344, 14216.715665686628, 14686.339114739862, 14692.906359986206, 14791.852081479263, 14903.478378256927, 293081.0, 297558.0, 298548.0, 298698.0, 299480.0, 50381.0, 51359.7432012845, 51364.0, 51387.22919156215, 51422.74288628533, 1248.5879659712273, 1250.2061191143507, 1307.320193499394, 1344.5495758920677, 1345.3206130904027, 20484.487887802923, 26740.0, 27195.0, 27345.31636709098, 27470.45059098847, 48234.758826205645, 48823.0, 48847.75576122239, 48938.26592601185, 48980.0, 275197.0, 275565.0, 276400.0, 276476.0, 277011.0, 31668.683313166573, 42949.355759663005, 43470.34794478149, 43610.563894360654, 43997.56002439935, 39055.0, 39079.804600976815, 39614.40578391384, 40171.39742903801, 40269.59730402775, 33927.830360848035, 33942.0, 34128.48807267943, 34201.0, 34425.0, 33174.0, 33275.50086748749, 33498.497522536694, 33792.0, 34112.0, 31106.688933111283, 31262.06213813589, 33059.0, 38219.2356152881, 38422.80788596039, 30456.238594035327, 31297.687023129478, 31358.686413135576, 31377.372452550364, 32668.67331326656, 24868.50262994694, 24874.378140546632, 24982.500349992533, 25339.0, 25339.746602533738], "unit": "score", "name": "ext.html", "value": 17630.010214433783}, {"lowerIsBetter": false, "replicates": [360.30820824017866, 361.60584962391, 368.530124091783, 369.5048634829328, 373.2181080636066, 16978.0, 17154.91422542887, 18335.266589336443, 18342.0, 18363.0818459077, 16585.41951031714, 17258.654826903487, 17346.56633584161, 17376.652466950654, 17391.73912391315, 4596.218642830719, 4822.0, 4823.324734537167, 4825.638077144211, 4826.34844296019, 3763.379042457991, 4753.928691069636, 5263.947360526403, 5491.0, 5502.889942201174, 5466.508014278714, 5486.561075114001, 5489.478499542537, 5503.6147469677135, 5504.2018907258425, 5202.141646628321, 5453.672779633215, 5484.7531861066145, 5488.451154884519, 5494.560435165217, 5228.111221092423, 5260.736963151865, 5263.605229607795, 5264.052470555299, 5282.920756188661, 12267.631971040882, 12842.614721558368, 12856.421461034182, 12871.935640321832, 13203.603891883258, 2168.620491414012, 2187.5187458759046, 2362.5274945011065, 2651.2974061873424, 2886.7834912381445, 9150.86273705895, 9233.49215793131, 9454.149126578572, 9549.713508594754, 9626.855597165979, 1879.9436016919515, 1934.8742331748392, 2041.3875837248765, 2042.6629606115123, 2076.9065392057396, 62026.379736202514, 62361.6881915592, 63025.68487157535, 63207.683961580355, 63385.366146338405, 9982.650607228858, 10170.796584068277, 10285.331453455501, 10576.841347379795, 10720.678379648623, 13927.0, 14010.299485025707, 14015.0, 14033.649158771112, 14048.71902561943, 7438.293362130589, 7683.346915512132, 7692.576908270099, 7747.031621047369, 7750.844983100419, 7378.188399276075, 7404.37062849653, 7538.3215510604305, 7541.283578060075, 7562.016937798161, 4458.063806600585, 4579.839705610354, 4588.0, 4628.097520983376, 4656.627469802408, 1734.167599552222, 1759.3490408548919, 1835.4034938644993, 1855.3784482198614, 1866.8226518480722, 896.6054935828215, 907.6390473261841, 915.3546749541557, 948.4593781544453, 1032.963846265377, 16381.426650067191, 16909.976276688725, 16928.49214523566, 16974.599869487454, 17140.828591714173, 858.476204736585, 920.4799288402031, 929.9123467814799, 931.8602209668604, 968.0464742228899, 9589.952050239845, 9686.467244301632, 9696.660616878375, 9769.899471613637, 9806.0, 158213.0, 158849.0, 160198.0, 161378.0, 387462.0626896904, 69511.65244173848, 70678.64660676663, 73539.0, 73902.63048684722, 73984.2601573988, 952.2762700347786, 956.6842941829041, 967.0088159636429, 969.4086607169621, 974.8294048541477, 14802.259887005392, 14857.81137508975, 14880.0, 15096.54710358691, 15355.539333820003, 32658.673413265562, 33231.667683322856, 33762.49356259707, 33841.661583384834, 34262.82868585641, 44965.0, 47100.29349559691, 47209.29186062143, 47304.0, 47488.287675685584, 7663.0, 7711.730089447067, 7795.376369890509, 7964.20357964199, 7988.0, 12081.154319197572, 12361.196522226026, 12494.875051249372, 12642.494300227889, 12714.173578717353, 10155.289129760846, 10483.947580262049, 10731.356118632906, 10786.460676965964, 11055.557777688802, 10491.0, 10656.680299591024, 10805.783884322112, 10892.074173695324, 10934.507947142238, 10867.728306792393, 10932.0, 11051.889481105407, 11255.0, 11278.887211127783, 7945.20547945224, 7960.164182760958, 8064.959675201587, 8186.222308880647, 8313.792155195926, 10149.712245284747, 10219.846702299621, 10285.845712314172, 10309.175265978854, 10349.430781307101], "unit": "score", "name": "jquery.html", "value": 8107.83528276454}, {"lowerIsBetter": false, "replicates": [1228.0789407944042, 1466.105675537922, 1482.629342664334, 1640.3110693508725, 1787.5888545634496, 7302.37929775969, 7426.44301677375, 7446.96276518618, 7449.702011919523, 7449.962750186248, 7388.556686598795, 7554.0, 7555.168931417554, 7557.886631700529, 7559.58422286774, 1941.1167918597005, 2198.626233540302, 2220.322801545528, 2244.9102035918545, 2248.426651203949, 2224.5550889822102, 2229.019231538126, 2234.7094877665963, 2238.2613737466677, 2238.876861772602, 2143.506993391521, 2208.3706143749037, 2209.8674079555276, 2212.8119109875597, 2213.2253711201033, 2179.1174574297434, 2204.0, 2211.6350802117713, 2214.966775498369, 2222.5999320122373, 2204.7354317481845, 2211.2481756202806, 2212.214663794346, 2223.7776222377634, 2245.36007237938, 7597.240275972414, 7664.463487555873, 7665.425093118039, 7676.577788221645, 7683.769486915401, 4562.338460923148, 4667.4632417272105, 4675.555822196886, 4677.087967846272, 4678.883027924329, 2915.271182204449, 2942.6468823741075, 2971.7028297170327, 2973.55396690496, 3064.4024415239037, 926.3284119013729, 927.2952556057378, 928.7213835849218, 965.8502932045544, 975.5414954971152, 10315.226358023103, 10347.327423717434, 10351.689449316533, 10361.948190259076, 10397.636082737068, 4061.878143655636, 4154.937675934863, 4176.707630465899, 4203.327467605169, 4205.222033923734, 8896.154865287788, 8931.464112153291, 8934.597943092576, 8935.731928042169, 8946.776330591658, 4174.3321068628875, 4659.464161621457, 4686.71879687213, 4693.155232058262, 4694.366260554782, 4138.213739389506, 4207.852725154666, 4211.052513184571, 4232.915341693149, 4265.168292183057, 3529.417646088418, 3591.120175557005, 3602.5676918769914, 3622.040159357772, 3652.634736526326, 1125.1336470917347, 1148.7013376522164, 1149.2587281203578, 1156.0693641618577, 1160.6866146140494, 1022.5296363672645, 1039.0285083447002, 1048.1981284317503, 1140.657802659199, 1280.1423046558828, 7138.643067846587, 7169.713211471587, 7210.062691850026, 7223.386012188917, 7231.3130252625915, 501.5335737763842, 509.08619028843316, 509.08619028843316, 512.5694416689998, 515.7704821354462, 5498.917516237259, 5533.418991005967, 5538.975289571442, 5570.5265052470995, 5573.331200255995, 8488.0, 8623.137686231326, 8635.395522313504, 8774.51740154285, 8812.8678069829, 8591.3556483264, 8629.52537610425, 8665.133486651284, 8666.220040196413, 8670.479771213748, 7134.215236324, 7255.383292420203, 7304.086989126359, 7310.926890731131, 7312.305330993547, 7207.603581803051, 7214.242504536948, 7227.2772722729405, 7263.818404539928, 7283.162436319891, 8215.342772578299, 8223.17768223173, 8287.046989596274, 8312.08567057611, 8455.239028487465, 7910.2089791020435, 8118.512889226666, 8124.39067069984, 8278.006639203335, 8294.543800091053, 6417.39034791694, 6568.113304703995, 6681.5656982296, 6687.598744075371, 6701.530892837454, 7213.422926165789, 7226.096737907762, 7229.0, 7233.240509746401, 7278.344948954407, 6321.209848768904, 6329.651869147241, 6412.422881940648, 6511.9348806511325, 6535.215774107138, 6511.9348806511325, 6541.0, 6561.770338038145, 6568.573042752206, 6581.0, 6870.725170993104, 6892.586444813327, 6921.169459664671, 6923.792286231421, 6955.895661565181, 6239.875202495834, 6295.496360291074, 6315.368463153648, 6322.905156422566, 6421.71102300407, 6438.774642887476, 6441.098246245436, 6452.290248072803, 6464.903026454701, 6474.643894585843], "unit": "score", "name": "mootools.html", "value": 4261.9000620023435}, {"lowerIsBetter": false, "replicates": [341.9316136772646, 343.4630030613007, 347.28979237459396, 347.6697137719166, 355.2787840683412, 5962.165296858438, 5966.79116230932, 5971.0744834550605, 5981.7906373277, 5982.760689572412, 5866.501347385477, 5895.4399332063385, 5899.233099697044, 5899.793507227248, 5916.4970977466855, 4378.299472084467, 4449.555044495541, 4568.451785785694, 4607.792649330771, 4615.792289346988, 4565.931511027321, 4590.885227869313, 4601.033782905593, 4605.585497305242, 4624.398828152335, 4560.247559152735, 4565.7717114144325, 4575.176468235716, 4585.037142200142, 4586.266197408415, 4355.782210889459, 4471.306947423154, 4551.226291530448, 4560.543945605446, 4599.425071866017, 4049.1091959768805, 4052.513698356216, 4060.634542891154, 4068.0, 4086.7752273624938, 5622.240997465331, 5637.210790489335, 5638.718064096779, 5645.2096706461125, 5656.264685590888, 5312.442193569658, 5359.330083739533, 5360.731963401814, 5360.839174824761, 5365.7853685852515, 6264.404881536247, 6279.560430769848, 6280.842978925563, 6281.120643109968, 6286.49708023357, 4438.622717069053, 4510.774461276923, 4542.523035081302, 4551.385562948993, 4558.77206139695, 6486.772962946275, 6549.5742776719835, 6559.0, 6561.3766692164645, 6590.373914478117, 4606.976965115153, 4641.071785642885, 4642.16441040616, 4643.791029403685, 4646.744429056367, 4653.046125544255, 4659.207934651117, 4688.296755486705, 4693.06138772247, 4699.483056863811, 5351.51836334724, 5362.705051222142, 5367.141257398797, 5367.812126575551, 5368.812091576854, 6074.878502430015, 6295.401936815995, 6355.523335749745, 6358.078078678565, 6362.618242905441, 1631.7389217725345, 1656.287796247601, 1660.900345979245, 1662.7672125902384, 1662.8170901200858, 1055.145332280855, 1093.2893619147617, 1097.8627671541058, 1114.6043154679971, 1117.1956191542076, 5941.732622032019, 6011.09833524966, 6013.939860601426, 6019.578629495893, 6041.305249896231, 6390.265119511316, 6402.423781859655, 6416.871662566722, 6419.775307864203, 6422.8715425691225, 5990.071538911476, 5995.010823214121, 5998.400159983967, 5999.370066143079, 6001.189839371629, 3436.759426840147, 3484.5121682964404, 3485.233248685285, 3487.773294735885, 3488.5290485784094, 6637.933620663828, 6823.624700641512, 6838.897416538756, 6948.652567371712, 7000.054992576039, 6698.196216454056, 6729.831754206086, 6731.764388246388, 6735.831604209934, 6753.257141714407, 6972.337627925441, 6993.580385176906, 6993.825154371079, 6996.510244282851, 6996.720131194797, 6555.967220163869, 6562.212534495891, 6565.474762019123, 6569.441597464269, 6573.80278591643, 6328.335524770017, 6496.837579060561, 6506.089147519446, 6512.511561632802, 6525.184351956005, 6949.826254343682, 6988.965055174692, 6992.61540615271, 6996.720131194696, 7003.159620845531, 4454.242778727559, 4497.617702495194, 4498.2352999990735, 4499.977500112478, 4507.549245075466, 6579.638119903451, 6582.473402127914, 6587.275399705933, 6587.440067594116, 6596.0, 6242.344553821783, 6391.936080639134, 6392.872142557216, 6393.680315984275, 6395.264544577433, 6286.779962701284, 6378.425941665087, 6380.330065343258, 6381.978883378637, 6383.0744542042075, 6183.0, 6206.379362063757, 6209.875802484015, 6216.875662486635, 6218.0, 6402.167718196604, 6404.647744374104, 6404.7438102477245, 6411.134496842867, 6416.935830641633, 5985.820425387245, 6144.293406258337, 6266.436020758154, 6266.968665156645, 6267.310595834363], "unit": "score", "name": "prototype.html", "value": 4809.673349111991}, {"lowerIsBetter": false, "replicates": [765.2041876448494, 793.0641842625703, 799.6921185343642, 804.8752443371276, 827.383599218582, 12841.42213600388, 12985.545505907296, 12991.090623656348, 13001.284929328895, 13006.284654344006, 11826.172167948247, 11849.526018959254, 13459.327033648327, 13811.37848796804, 13814.654633634163, 789.0886026639226, 820.7660816667221, 829.3199576347398, 829.3779665251062, 831.2352635575285, 676.949228807839, 811.7199566149699, 821.0475848016303, 828.0477450931447, 828.6809578312333, 854.6453221912899, 857.764114868413, 860.2343913916619, 863.3826813828111, 866.4541338956449, 693.0643631098028, 858.9484630922165, 859.793649524116, 860.8579584368572, 862.3187681731424, 625.4683519008806, 631.0439683878881, 634.1217413881807, 635.0284065379976, 635.4249404289126, 12720.554780582635, 12782.552610658582, 12785.232886026775, 12804.295763732991, 12827.807582886171, 12197.45111469977, 12409.441575129142, 12550.1842380245, 12725.363731813371, 12777.488900443972, 10415.68752937413, 10613.628523001735, 10704.571817127384, 10773.622923197729, 10917.290376125526, 3625.8912232633065, 3648.3068217038945, 3683.1528748387755, 3747.775133491999, 3754.1928485375774, 50655.49344506545, 50966.235506467434, 51225.0, 51291.48708512905, 51617.741911290206, 9657.275704322205, 9763.804723905481, 9886.4562449066, 9976.301658883953, 10447.111995480318, 18084.18621162051, 18084.276628934695, 18103.18535665898, 18107.094645267684, 18138.455846324632, 7168.319009694071, 7434.405247580289, 7495.925040749632, 7523.285287897641, 7660.463767536219, 4421.093675796454, 4461.308497182942, 4480.171168333869, 4511.097780443859, 4575.359449676981, 3041.4981528047624, 3061.1734831595345, 3062.8162310261455, 3066.7546596272246, 3068.4783586789854, 521.304059081131, 522.1254398881857, 527.8917821846512, 532.4329588987715, 550.3808215757273, 639.280809089774, 642.4667525953447, 646.890028695123, 676.5805200775452, 701.2951983256896, 8388.32893368529, 8576.099509551532, 8715.651373945098, 8747.912520874837, 8858.29133669305, 625.8967270400424, 639.7313128486047, 654.5900407388318, 655.8917778566579, 672.143017652497, 3844.2888065707934, 3878.146807702301, 3902.6292502212245, 3917.882463526099, 4144.937825932613, 55413.72293138589, 55878.72060639671, 56242.43757562372, 56420.71789641108, 56454.0, 48277.51722482801, 48591.27113093306, 48812.0, 48884.51115488871, 50127.49872501228, 44135.0, 44651.0, 44911.77544112324, 44959.10081798346, 45553.0, 7536.321731044232, 7562.924370756442, 7814.33578145864, 7886.329661978567, 8038.276555110068, 33467.66532334645, 34139.48790768091, 34160.48759268663, 34546.30907381788, 35503.644963551065, 41587.7920610395, 43615.12769744651, 43863.34204986991, 44149.33775993427, 44522.0, 10144.087032167141, 10232.53953572106, 10324.174066074545, 10563.260571759904, 10709.892901070889, 10635.574577016832, 10697.839532407175, 10804.0, 10963.177761667748, 11003.284786488852, 8591.570421479026, 9545.809083818145, 11774.3524106175, 11975.041996640073, 12004.879951200377, 11458.4270786462, 11673.416329183678, 11774.234674746114, 11957.0, 11967.042636588878, 11561.42192890369, 11612.419379031184, 11718.179727419, 11825.349605771766, 12135.75728485443, 7994.320482759031, 8641.0, 9618.326717129734, 9744.366616169926, 9882.209423246266, 9332.007376053778, 9888.406695598287, 10040.347377420445, 10129.64546240878, 10176.694699159038], "unit": "score", "name": "yui.html", "value": 6230.6686555329825}], "name": "dromaeo_css", "value": 6708.170345102806}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 112.0, 114.0, 101.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [150.0, 124.0, 150.0, 166.0, 125.0, 149.0, 152.0, 129.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 102.0, 95.0, 73.0, 75.0, 73.0, 118.0, 96.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 151.0, 95.0, 95.0, 95.0, 149.0, 95.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [148.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 56.0, 57.0, 63.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 82.0, 82.0, 89.0, 82.0, 82.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 119.0, 130.0, 119.0, 118.0, 126.0, 118.0, 132.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 151.0, 150.0, 143.0, 142.0, 164.0, 144.0, 149.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 72.0, 69.0, 69.0, 72.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1511.8999999999999}]} 16:22:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6708.17"}}} 16:22:42 INFO - Return code: 0 16:22:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:22:42 INFO - # TBPL SUCCESS # 16:22:42 INFO - Running post-action listener: _resource_record_post_action 16:22:42 INFO - Running post-run listener: _resource_record_post_run 16:22:43 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 24576; Write bytes: 540954624; Read time: 56; Write time: 466112 16:22:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 240988160; Read time: 12; Write time: 278072 16:22:43 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 299966464; Read time: 44; Write time: 188040 16:22:43 INFO - Running post-run listener: _upload_blobber_files 16:22:43 INFO - Blob upload gear active. 16:22:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:22:43 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 16:22:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:22:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:22:43 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 16:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:44 INFO - (blobuploader) - INFO - Done attempting. 16:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:45 INFO - (blobuploader) - INFO - Done attempting. 16:22:45 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:45 INFO - Return code: 0 16:22:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:22:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270851612d421b20c233563beadecf0e5f81798f8d3ebe9d156bc2254db6d42724602a262a3e787716b40d2622410406978c20cd87e9f534117f78423bba40da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a46da4d6553cdd98f17198d8fa568375239475e881766475777eb2817c3da7f97433da8a5218d38c5c9c3b7ce7212e0ebd246d9b690271292d7aa0fa0c661b"} 16:22:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:22:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:22:45 INFO - Contents: 16:22:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270851612d421b20c233563beadecf0e5f81798f8d3ebe9d156bc2254db6d42724602a262a3e787716b40d2622410406978c20cd87e9f534117f78423bba40da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a46da4d6553cdd98f17198d8fa568375239475e881766475777eb2817c3da7f97433da8a5218d38c5c9c3b7ce7212e0ebd246d9b690271292d7aa0fa0c661b"} 16:22:45 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:45 INFO - Copying logs to upload dir... 16:22:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:22:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.962599 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-02-26 16:22:45.669557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:22:45.673106) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270851612d421b20c233563beadecf0e5f81798f8d3ebe9d156bc2254db6d42724602a262a3e787716b40d2622410406978c20cd87e9f534117f78423bba40da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a46da4d6553cdd98f17198d8fa568375239475e881766475777eb2817c3da7f97433da8a5218d38c5c9c3b7ce7212e0ebd246d9b690271292d7aa0fa0c661b"} build_url:https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/eEjHL5l3SGC5819ZqnDJXA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/270851612d421b20c233563beadecf0e5f81798f8d3ebe9d156bc2254db6d42724602a262a3e787716b40d2622410406978c20cd87e9f534117f78423bba40da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6a46da4d6553cdd98f17198d8fa568375239475e881766475777eb2817c3da7f97433da8a5218d38c5c9c3b7ce7212e0ebd246d9b690271292d7aa0fa0c661b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:22:45.697853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:22:45.698184) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456529986.912894-1949610833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:22:45.780426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:22:45.780767) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:22:45.781088) ========= ========= Total master_lag: 0.28 =========