builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1458469495.79 results: success (0) buildid: 20160320004007 builduid: 58389860b1424bd9850f72ebaccddae0 revision: 303576fae3933ed817545e5beb3d92128fe6caea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.794136) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.794484) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.794752) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.824703) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.824987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.868155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.868402) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.919320) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.920017) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.920810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:55.921526) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-20 03:24:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2016-03-20 03:24:56 (42.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:56.087893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:56.088173) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021304 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:56.139384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-20 03:24:56.139771) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 303576fae3933ed817545e5beb3d92128fe6caea --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 303576fae3933ed817545e5beb3d92128fe6caea --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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-20 03:24:56,440 truncating revision to first 12 chars 2016-03-20 03:24:56,440 Setting DEBUG logging. 2016-03-20 03:24:56,440 attempt 1/10 2016-03-20 03:24:56,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/303576fae393?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-20 03:24:57,566 unpacking tar archive at: mozilla-aurora-303576fae393/testing/mozharness/ program finished with exit code 0 elapsedTime=1.426178 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-20 03:24:57.578219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:57.578509) ========= echo 303576fae3933ed817545e5beb3d92128fe6caea in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'303576fae3933ed817545e5beb3d92128fe6caea'] 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 303576fae3933ed817545e5beb3d92128fe6caea program finished with exit code 0 elapsedTime=0.003654 script_repo_revision: '303576fae3933ed817545e5beb3d92128fe6caea' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:57.626064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:57.626326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-20 03:24:57.636479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-20 03:24:57.636863) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:58 INFO - MultiFileLogger online at 20160320 03:24:58 in /builds/slave/test-pgo 03:24:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:24:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:24:58 INFO - {'append_to_log': False, 03:24:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:24:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:24:58 INFO - 'branch': 'Mozilla-Aurora', 03:24:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:58 INFO - 'config_files': ('talos/linux_config.py',), 03:24:58 INFO - 'default_actions': ('clobber', 03:24:58 INFO - 'read-buildbot-config', 03:24:58 INFO - 'download-and-extract', 03:24:58 INFO - 'populate-webroot', 03:24:58 INFO - 'create-virtualenv', 03:24:58 INFO - 'install', 03:24:58 INFO - 'run-tests'), 03:24:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:58 INFO - 'download_minidump_stackwalk': True, 03:24:58 INFO - 'download_symbols': 'ondemand', 03:24:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:58 INFO - 'installer_path': 'installer.exe', 03:24:58 INFO - 'log_level': 'info', 03:24:58 INFO - 'log_name': 'talos', 03:24:58 INFO - 'log_to_console': True, 03:24:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:58 INFO - 'opt_config_files': (), 03:24:58 INFO - 'pip_index': False, 03:24:58 INFO - 'sps_profile': False, 03:24:58 INFO - 'sps_profile_interval': 0, 03:24:58 INFO - 'suite': 'dromaeojs-e10s', 03:24:58 INFO - 'system_bits': '32', 03:24:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:58 INFO - 'title': 'talos-linux64-ix-047', 03:24:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:58 INFO - 'use_talos_json': True, 03:24:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:24:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:58 INFO - 'work_dir': 'build'} 03:24:58 INFO - ##### 03:24:58 INFO - ##### Running clobber step. 03:24:58 INFO - ##### 03:24:58 INFO - Running pre-action listener: _resource_record_pre_action 03:24:58 INFO - Running main action method: clobber 03:24:58 INFO - rmtree: /builds/slave/test-pgo/build 03:24:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:24:58 INFO - Running post-action listener: _resource_record_post_action 03:24:58 INFO - ##### 03:24:58 INFO - ##### Running read-buildbot-config step. 03:24:58 INFO - ##### 03:24:58 INFO - Running pre-action listener: _resource_record_pre_action 03:24:58 INFO - Running main action method: read_buildbot_config 03:24:58 INFO - Using buildbot properties: 03:24:58 INFO - { 03:24:58 INFO - "project": "", 03:24:58 INFO - "product": "firefox", 03:24:58 INFO - "script_repo_revision": "production", 03:24:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:24:58 INFO - "repository": "", 03:24:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:24:58 INFO - "buildid": "20160320004007", 03:24:58 INFO - "stage_platform": "linux64-pgo", 03:24:58 INFO - "basedir": "/builds/slave/test-pgo", 03:24:58 INFO - "nightly_build": "True", 03:24:58 INFO - "buildnumber": 204, 03:24:58 INFO - "slavename": "talos-linux64-ix-047", 03:24:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:24:58 INFO - "platform": "ubuntu64_hw", 03:24:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:24:58 INFO - "branch": "mozilla-aurora", 03:24:58 INFO - "repo_path": "releases/mozilla-aurora", 03:24:58 INFO - "revision": "303576fae3933ed817545e5beb3d92128fe6caea", 03:24:58 INFO - "pgo_build": "True", 03:24:58 INFO - "builduid": "58389860b1424bd9850f72ebaccddae0", 03:24:59 INFO - "slavebuilddir": "test" 03:24:59 INFO - } 03:24:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 03:24:59 INFO - Running post-action listener: _resource_record_post_action 03:24:59 INFO - ##### 03:24:59 INFO - ##### Running download-and-extract step. 03:24:59 INFO - ##### 03:24:59 INFO - Running pre-action listener: _resource_record_pre_action 03:24:59 INFO - Running main action method: download_and_extract 03:24:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:24:59 INFO - https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:02 INFO - Downloaded 1448 bytes. 03:25:02 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 03:25:02 INFO - Using the following test package requirements: 03:25:02 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:02 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:02 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:02 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'jsshell-linux-x86_64.zip'], 03:25:02 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:02 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:02 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:02 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:02 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:02 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:02 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:02 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:02 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:02 INFO - https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:05 INFO - Downloaded 23310469 bytes. 03:25:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:25:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:25:06 INFO - Return code: 0 03:25:06 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:06 INFO - https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 03:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:08 INFO - Downloaded 23310469 bytes. 03:25:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:25:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:25:09 INFO - Return code: 0 03:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:09 INFO - https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:11 INFO - Downloaded 10845161 bytes. 03:25:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:25:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:25:11 INFO - Return code: 0 03:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:11 INFO - https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:13 INFO - Downloaded 60436488 bytes. 03:25:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:13 INFO - mkdir: /builds/slave/test-pgo/properties 03:25:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:25:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:25:13 INFO - Contents: 03:25:13 INFO - build_url:https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 03:25:14 INFO - Running post-action listener: _resource_record_post_action 03:25:14 INFO - Running post-action listener: set_extra_try_arguments 03:25:14 INFO - ##### 03:25:14 INFO - ##### Running populate-webroot step. 03:25:14 INFO - ##### 03:25:14 INFO - Running pre-action listener: _resource_record_pre_action 03:25:14 INFO - Running main action method: populate_webroot 03:25:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:14 INFO - '--tppagecycles', 03:25:14 INFO - '7'], 03:25:14 INFO - 'tests': ['tsvgm']}}, 03:25:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:25:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:25:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'tests': ['damp', 'tps']}, 03:25:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['damp', 'tps']}, 03:25:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:25:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:14 INFO - 'other': {'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'other_l64': {'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'other_nol64': {'tests': ['a11yr', 03:25:14 INFO - 'ts_paint', 03:25:14 INFO - 'tpaint', 03:25:14 INFO - 'sessionrestore', 03:25:14 INFO - 'sessionrestore_no_auto_restore', 03:25:14 INFO - 'tabpaint']}, 03:25:14 INFO - 'svgr': {'tests': ['tsvgx', 03:25:14 INFO - 'tsvgr_opacity', 03:25:14 INFO - 'tart', 03:25:14 INFO - 'tscrollx', 03:25:14 INFO - 'cart']}, 03:25:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['tsvgx', 03:25:14 INFO - 'tsvgr_opacity', 03:25:14 INFO - 'tart', 03:25:14 INFO - 'tscrollx', 03:25:14 INFO - 'cart']}, 03:25:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'tests': ['tp5o']}, 03:25:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'talos_options': ['--e10s'], 03:25:14 INFO - 'tests': ['tp5o']}, 03:25:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'talos_options': ['--xperf_path', 03:25:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:14 INFO - 'tests': ['tp5n']}, 03:25:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:14 INFO - 'talos_options': ['--e10s', 03:25:14 INFO - '--xperf_path', 03:25:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:14 INFO - 'tests': ['tp5n']}}, 03:25:14 INFO - 'talos.zip': {'path': '', 03:25:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:14 INFO - Running post-action listener: _resource_record_post_action 03:25:14 INFO - ##### 03:25:14 INFO - ##### Running create-virtualenv step. 03:25:14 INFO - ##### 03:25:14 INFO - Running pre-action listener: _resource_record_pre_action 03:25:14 INFO - Running main action method: create_virtualenv 03:25:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:25:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:25:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:25:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:14 INFO - Using real prefix '/usr' 03:25:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:25:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:16 INFO - Installing pip.................done. 03:25:16 INFO - Return code: 0 03:25:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:16 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:25:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:16 INFO - Using env: {'DISPLAY': ':0', 03:25:16 INFO - 'HOME': '/home/cltbld', 03:25:16 INFO - 'LANG': 'en_US.UTF-8', 03:25:16 INFO - 'LANGUAGE': 'en_US:en', 03:25:16 INFO - 'LOGNAME': 'cltbld', 03:25:16 INFO - 'MAIL': '/var/mail/cltbld', 03:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:16 INFO - 'MOZ_NO_REMOTE': '1', 03:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:16 INFO - 'NO_EM_RESTART': '1', 03:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:16 INFO - 'SHELL': '/bin/bash', 03:25:16 INFO - 'SHLVL': '1', 03:25:16 INFO - 'TERM': 'linux', 03:25:16 INFO - 'TMOUT': '86400', 03:25:16 INFO - 'USER': 'cltbld', 03:25:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:16 INFO - '_': '/tools/buildbot/bin/python'} 03:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:16 INFO - Cleaning up... 03:25:16 INFO - Return code: 0 03:25:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:16 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:25:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:25:16 INFO - Using env: {'DISPLAY': ':0', 03:25:16 INFO - 'HOME': '/home/cltbld', 03:25:16 INFO - 'LANG': 'en_US.UTF-8', 03:25:16 INFO - 'LANGUAGE': 'en_US:en', 03:25:16 INFO - 'LOGNAME': 'cltbld', 03:25:16 INFO - 'MAIL': '/var/mail/cltbld', 03:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:16 INFO - 'MOZ_NO_REMOTE': '1', 03:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:16 INFO - 'NO_EM_RESTART': '1', 03:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:16 INFO - 'SHELL': '/bin/bash', 03:25:16 INFO - 'SHLVL': '1', 03:25:16 INFO - 'TERM': 'linux', 03:25:16 INFO - 'TMOUT': '86400', 03:25:16 INFO - 'USER': 'cltbld', 03:25:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:16 INFO - '_': '/tools/buildbot/bin/python'} 03:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:17 INFO - Downloading/unpacking psutil>=0.7.1 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:19 INFO - Installing collected packages: psutil 03:25:19 INFO - Running setup.py install for psutil 03:25:19 INFO - building 'psutil._psutil_linux' extension 03:25:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:19 INFO - building 'psutil._psutil_posix' extension 03:25:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:19 INFO - Successfully installed psutil 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:19 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:25:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:25:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:25:21 INFO - Installing collected packages: mozsystemmonitor 03:25:21 INFO - Running setup.py install for mozsystemmonitor 03:25:21 INFO - Successfully installed mozsystemmonitor 03:25:21 INFO - Cleaning up... 03:25:21 INFO - Return code: 0 03:25:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:21 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:25:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:25:21 INFO - Using env: {'DISPLAY': ':0', 03:25:21 INFO - 'HOME': '/home/cltbld', 03:25:21 INFO - 'LANG': 'en_US.UTF-8', 03:25:21 INFO - 'LANGUAGE': 'en_US:en', 03:25:21 INFO - 'LOGNAME': 'cltbld', 03:25:21 INFO - 'MAIL': '/var/mail/cltbld', 03:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:21 INFO - 'MOZ_NO_REMOTE': '1', 03:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:21 INFO - 'NO_EM_RESTART': '1', 03:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:21 INFO - 'SHELL': '/bin/bash', 03:25:21 INFO - 'SHLVL': '1', 03:25:21 INFO - 'TERM': 'linux', 03:25:21 INFO - 'TMOUT': '86400', 03:25:21 INFO - 'USER': 'cltbld', 03:25:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:21 INFO - '_': '/tools/buildbot/bin/python'} 03:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:22 INFO - Downloading/unpacking blobuploader==1.2.4 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:25:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading docopt-0.6.1.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:24 INFO - Running setup.py install for blobuploader 03:25:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:25:24 INFO - Running setup.py install for requests 03:25:25 INFO - Running setup.py install for docopt 03:25:25 INFO - Successfully installed blobuploader requests docopt 03:25:25 INFO - Cleaning up... 03:25:25 INFO - Return code: 0 03:25:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:25 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:25:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:25 INFO - Using env: {'DISPLAY': ':0', 03:25:25 INFO - 'HOME': '/home/cltbld', 03:25:25 INFO - 'LANG': 'en_US.UTF-8', 03:25:25 INFO - 'LANGUAGE': 'en_US:en', 03:25:25 INFO - 'LOGNAME': 'cltbld', 03:25:25 INFO - 'MAIL': '/var/mail/cltbld', 03:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:25 INFO - 'MOZ_NO_REMOTE': '1', 03:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:25 INFO - 'NO_EM_RESTART': '1', 03:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:25 INFO - 'SHELL': '/bin/bash', 03:25:25 INFO - 'SHLVL': '1', 03:25:25 INFO - 'TERM': 'linux', 03:25:25 INFO - 'TMOUT': '86400', 03:25:25 INFO - 'USER': 'cltbld', 03:25:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:25 INFO - '_': '/tools/buildbot/bin/python'} 03:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:25:25 INFO - Running setup.py (path:/tmp/pip-zuD3Fr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:25:25 INFO - Running setup.py (path:/tmp/pip-YCcynJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:25:25 INFO - Running setup.py (path:/tmp/pip-gkanAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:25:25 INFO - Running setup.py (path:/tmp/pip-iuTP2i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:25:25 INFO - Running setup.py (path:/tmp/pip-c_cZ7s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:25:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:25:25 INFO - Running setup.py (path:/tmp/pip-5ZoEgn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:25:26 INFO - Running setup.py (path:/tmp/pip-ccJ68K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:25:26 INFO - Running setup.py (path:/tmp/pip-9wxqdU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:25:26 INFO - Running setup.py (path:/tmp/pip-qvzG5T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:25:26 INFO - Running setup.py (path:/tmp/pip-_aLPqM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:25:26 INFO - Running setup.py (path:/tmp/pip-Qm2QmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:25:26 INFO - Running setup.py (path:/tmp/pip-wQXucH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:25:26 INFO - Running setup.py (path:/tmp/pip-fU911x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:25:26 INFO - Running setup.py (path:/tmp/pip-U8STGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:25:26 INFO - Running setup.py (path:/tmp/pip-Gjd9X3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:25:26 INFO - Running setup.py (path:/tmp/pip-8vI8Xo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:25:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:25:26 INFO - Running setup.py (path:/tmp/pip-xvDr9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:25:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:26 INFO - Running setup.py install for manifestparser 03:25:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:25:26 INFO - Running setup.py install for mozcrash 03:25:27 INFO - Running setup.py install for mozdebug 03:25:27 INFO - Running setup.py install for mozdevice 03:25:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for mozfile 03:25:27 INFO - Running setup.py install for mozhttpd 03:25:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for mozinfo 03:25:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for mozInstall 03:25:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for mozleak 03:25:27 INFO - Running setup.py install for mozlog 03:25:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for moznetwork 03:25:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:25:27 INFO - Running setup.py install for mozprocess 03:25:28 INFO - Running setup.py install for mozprofile 03:25:28 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:25:28 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:25:28 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:25:28 INFO - Running setup.py install for mozrunner 03:25:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:25:28 INFO - Running setup.py install for mozscreenshot 03:25:28 INFO - Running setup.py install for moztest 03:25:28 INFO - Running setup.py install for mozversion 03:25:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:25:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:28 INFO - Cleaning up... 03:25:28 INFO - Return code: 0 03:25:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:28 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:25:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:28 INFO - Using env: {'DISPLAY': ':0', 03:25:28 INFO - 'HOME': '/home/cltbld', 03:25:28 INFO - 'LANG': 'en_US.UTF-8', 03:25:28 INFO - 'LANGUAGE': 'en_US:en', 03:25:28 INFO - 'LOGNAME': 'cltbld', 03:25:28 INFO - 'MAIL': '/var/mail/cltbld', 03:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:28 INFO - 'MOZ_NO_REMOTE': '1', 03:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:28 INFO - 'NO_EM_RESTART': '1', 03:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:28 INFO - 'SHELL': '/bin/bash', 03:25:28 INFO - 'SHLVL': '1', 03:25:28 INFO - 'TERM': 'linux', 03:25:28 INFO - 'TMOUT': '86400', 03:25:28 INFO - 'USER': 'cltbld', 03:25:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:28 INFO - '_': '/tools/buildbot/bin/python'} 03:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:25:28 INFO - Running setup.py (path:/tmp/pip-2MBcJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:25:28 INFO - Running setup.py (path:/tmp/pip-793Dbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:25:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:25:28 INFO - Running setup.py (path:/tmp/pip-ZSQPGI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:25:29 INFO - Running setup.py (path:/tmp/pip-rseKOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:25:29 INFO - Running setup.py (path:/tmp/pip-WNCY_T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:25:29 INFO - Running setup.py (path:/tmp/pip-pFXbyI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:25:29 INFO - Running setup.py (path:/tmp/pip-rY7kZm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:25:29 INFO - Running setup.py (path:/tmp/pip-kvTti7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:25:29 INFO - Running setup.py (path:/tmp/pip-l3xg7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:25:29 INFO - Running setup.py (path:/tmp/pip-mDewuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:25:29 INFO - Running setup.py (path:/tmp/pip-SpjrXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:25:29 INFO - Running setup.py (path:/tmp/pip-tnoWH0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:25:29 INFO - Running setup.py (path:/tmp/pip-528gqe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:25:29 INFO - Running setup.py (path:/tmp/pip-I6x9T1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:25:29 INFO - Running setup.py (path:/tmp/pip-xxRbKX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:25:29 INFO - Running setup.py (path:/tmp/pip-x2vGRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:25:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:25:29 INFO - Running setup.py (path:/tmp/pip-97webV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25: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 03:25:31 INFO - Downloading blessings-1.6.tar.gz 03:25:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:31 INFO - Installing collected packages: blessings 03:25:31 INFO - Running setup.py install for blessings 03:25:32 INFO - Successfully installed blessings 03:25:32 INFO - Cleaning up... 03:25:32 INFO - Return code: 0 03:25:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:25:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:25:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:25:32 INFO - Reading from file tmpfile_stdout 03:25:32 INFO - Current package versions: 03:25:32 INFO - argparse == 1.2.1 03:25:32 INFO - blessings == 1.6 03:25:32 INFO - blobuploader == 1.2.4 03:25:32 INFO - docopt == 0.6.1 03:25:32 INFO - manifestparser == 1.1 03:25:32 INFO - mozInstall == 1.12 03:25:32 INFO - mozcrash == 0.17 03:25:32 INFO - mozdebug == 0.1 03:25:32 INFO - mozdevice == 0.48 03:25:32 INFO - mozfile == 1.2 03:25:32 INFO - mozhttpd == 0.7 03:25:32 INFO - mozinfo == 0.9 03:25:32 INFO - mozleak == 0.1 03:25:32 INFO - mozlog == 3.1 03:25:32 INFO - moznetwork == 0.27 03:25:32 INFO - mozprocess == 0.22 03:25:32 INFO - mozprofile == 0.28 03:25:32 INFO - mozrunner == 6.11 03:25:32 INFO - mozscreenshot == 0.1 03:25:32 INFO - mozsystemmonitor == 0.0 03:25:32 INFO - moztest == 0.7 03:25:32 INFO - mozversion == 1.4 03:25:32 INFO - psutil == 3.1.1 03:25:32 INFO - requests == 1.2.3 03:25:32 INFO - wsgiref == 0.1.2 03:25:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:32 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 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:25:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:25:32 INFO - Using env: {'DISPLAY': ':0', 03:25:32 INFO - 'HOME': '/home/cltbld', 03:25:32 INFO - 'LANG': 'en_US.UTF-8', 03:25:32 INFO - 'LANGUAGE': 'en_US:en', 03:25:32 INFO - 'LOGNAME': 'cltbld', 03:25:32 INFO - 'MAIL': '/var/mail/cltbld', 03:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:32 INFO - 'MOZ_NO_REMOTE': '1', 03:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:32 INFO - 'NO_EM_RESTART': '1', 03:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:32 INFO - 'SHELL': '/bin/bash', 03:25:32 INFO - 'SHLVL': '1', 03:25:32 INFO - 'TERM': 'linux', 03:25:32 INFO - 'TMOUT': '86400', 03:25:32 INFO - 'USER': 'cltbld', 03:25:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:32 INFO - '_': '/tools/buildbot/bin/python'} 03:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:25:32 INFO - Cleaning up... 03:25:32 INFO - Return code: 0 03:25:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:25:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:25:32 INFO - Using env: {'DISPLAY': ':0', 03:25:32 INFO - 'HOME': '/home/cltbld', 03:25:32 INFO - 'LANG': 'en_US.UTF-8', 03:25:32 INFO - 'LANGUAGE': 'en_US:en', 03:25:32 INFO - 'LOGNAME': 'cltbld', 03:25:32 INFO - 'MAIL': '/var/mail/cltbld', 03:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:32 INFO - 'MOZ_NO_REMOTE': '1', 03:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:32 INFO - 'NO_EM_RESTART': '1', 03:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:32 INFO - 'SHELL': '/bin/bash', 03:25:32 INFO - 'SHLVL': '1', 03:25:32 INFO - 'TERM': 'linux', 03:25:32 INFO - 'TMOUT': '86400', 03:25:32 INFO - 'USER': 'cltbld', 03:25:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:32 INFO - '_': '/tools/buildbot/bin/python'} 03:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:32 INFO - Downloading/unpacking jsonschema 03:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:34 INFO - Downloading/unpacking functools32 (from jsonschema) 03:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:34 INFO - warning: no files found matching '*.txt' 03:25:34 INFO - no previously-included directories found matching 'build' 03:25:34 INFO - no previously-included directories found matching 'dist' 03:25:34 INFO - no previously-included directories found matching '.git*' 03:25:34 INFO - Installing collected packages: jsonschema, functools32 03:25:34 INFO - Running setup.py install for functools32 03:25:34 INFO - warning: no files found matching '*.txt' 03:25:34 INFO - no previously-included directories found matching 'build' 03:25:34 INFO - no previously-included directories found matching 'dist' 03:25:34 INFO - no previously-included directories found matching '.git*' 03:25:35 INFO - Successfully installed jsonschema functools32 03:25:35 INFO - Cleaning up... 03:25:35 INFO - Return code: 0 03:25:35 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd219a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b6f6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, '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': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25: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', 'flake8'] in /builds/slave/test-pgo/build 03:25: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 flake8 03:25:35 INFO - Using env: {'DISPLAY': ':0', 03:25:35 INFO - 'HOME': '/home/cltbld', 03:25:35 INFO - 'LANG': 'en_US.UTF-8', 03:25:35 INFO - 'LANGUAGE': 'en_US:en', 03:25:35 INFO - 'LOGNAME': 'cltbld', 03:25:35 INFO - 'MAIL': '/var/mail/cltbld', 03:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:35 INFO - 'MOZ_NO_REMOTE': '1', 03:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:35 INFO - 'NO_EM_RESTART': '1', 03:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:35 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:35 INFO - 'SHELL': '/bin/bash', 03:25:35 INFO - 'SHLVL': '1', 03:25:35 INFO - 'TERM': 'linux', 03:25:35 INFO - 'TMOUT': '86400', 03:25:35 INFO - 'USER': 'cltbld', 03:25:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:35 INFO - '_': '/tools/buildbot/bin/python'} 03:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:35 INFO - Downloading/unpacking flake8 03:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:25:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:25:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:37 INFO - no previously-included directories found matching 'docs/_build' 03:25:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:25:37 INFO - Running setup.py install for pep8 03:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:25:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:25:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:25:37 INFO - no previously-included directories found matching 'docs/_build' 03:25:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:25:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:25:38 INFO - Cleaning up... 03:25:38 INFO - Return code: 0 03:25:38 INFO - Running post-action listener: _resource_record_post_action 03:25:38 INFO - Running post-action listener: _start_resource_monitoring 03:25:38 INFO - Starting resource monitoring. 03:25:38 INFO - ##### 03:25:38 INFO - ##### Running install step. 03:25:38 INFO - ##### 03:25:38 INFO - Running pre-action listener: _resource_record_pre_action 03:25:38 INFO - Running main action method: install 03:25:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:25:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:25:38 INFO - Reading from file tmpfile_stdout 03:25:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:25:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:25:38 INFO - Reading from file tmpfile_stdout 03:25:38 INFO - Output received: 03:25:38 INFO - Usage: mozinstall [options] installer 03:25:38 INFO - Options: 03:25:38 INFO - -h, --help show this help message and exit 03:25:38 INFO - -d DEST, --destination=DEST 03:25:38 INFO - Directory to install application into. [default: 03:25:38 INFO - "/builds/slave/test-pgo"] 03:25:38 INFO - --app=APP Application being installed. [default: firefox] 03:25:38 INFO - mkdir: /builds/slave/test-pgo/build/application 03:25:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:25:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:25:53 INFO - Reading from file tmpfile_stdout 03:25:53 INFO - Output received: 03:25:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running run-tests step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: run_tests 03:25:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:25:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:25:53 INFO - Python 2.7.3 03:25:53 INFO - Return code: 0 03:25:53 INFO - grabbing minidump binary from tooltool 03:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:53 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 0x1bfe920>, '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 0x1bff820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bffcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:25:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:25:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:25:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:53 INFO - Return code: 0 03:25:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:25:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:25:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:25:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:25:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:25:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:25:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:25:54 INFO - Return code: 0 03:25:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 03:25:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:25:54 INFO - Using env: {'DISPLAY': ':0', 03:25:54 INFO - 'HOME': '/home/cltbld', 03:25:54 INFO - 'LANG': 'en_US.UTF-8', 03:25:54 INFO - 'LANGUAGE': 'en_US:en', 03:25:54 INFO - 'LOGNAME': 'cltbld', 03:25:54 INFO - 'MAIL': '/var/mail/cltbld', 03:25:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:25:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:54 INFO - 'MOZ_NO_REMOTE': '1', 03:25:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:54 INFO - 'NO_EM_RESTART': '1', 03:25:54 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:25:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:25:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:25:54 INFO - 'SHELL': '/bin/bash', 03:25:54 INFO - 'SHLVL': '1', 03:25:54 INFO - 'TERM': 'linux', 03:25:54 INFO - 'TMOUT': '86400', 03:25:54 INFO - 'USER': 'cltbld', 03:25:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896', 03:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:54 INFO - '_': '/tools/buildbot/bin/python'} 03:25:54 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:25:54 INFO - mozversion application_buildid: 20160320004007 03:25:54 INFO - mozversion application_changeset: 303576fae3933ed817545e5beb3d92128fe6caea 03:25:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:25:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:54 INFO - mozversion application_name: Firefox 03:25:54 INFO - mozversion application_remotingname: firefox-dev 03:25:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:54 INFO - mozversion application_vendor: Mozilla 03:25:54 INFO - mozversion application_version: 47.0a2 03:25:54 INFO - mozversion platform_buildid: 20160320004007 03:25:54 INFO - mozversion platform_changeset: 303576fae3933ed817545e5beb3d92128fe6caea 03:25:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:25:54 INFO - mozversion platform_version: 47.0a2 03:25:54 INFO - using testdate: 1458469554 03:25:54 INFO - actual date: 1458469554 03:25:54 INFO - starting webserver on 'localhost:36027' 03:25:54 INFO - SUITE-START | Running 2 tests 03:25:54 INFO - TEST-START | dromaeo_css 03:25:54 INFO - operating with platform_type : linux_ 03:25:54 INFO - Initialising browser for dromaeo_css test... 03:25:54 INFO - TEST-INFO | started process 6275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNeoyMQ/profile http://localhost:36027/getInfo.html) 03:25:58 INFO - PROCESS | 6275 | 03:25:58 INFO - PROCESS | 6275 | (process:6352): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:25:59 INFO - PROCESS | 6275 | __metrics Screen width/height:1600/1200 03:25:59 INFO - PROCESS | 6275 | colorDepth:24 03:25:59 INFO - PROCESS | 6275 | Browser inner width/height: 1024/697 03:25:59 INFO - PROCESS | 6275 | __metrics 03:26:00 ERROR - PROCESS | 6275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:26:00 INFO - TEST-INFO | 6275: exit 0 03:26:00 INFO - Browser initialized. 03:26:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:00 INFO - TEST-INFO | started process 6403 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNeoyMQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:02 INFO - PROCESS | 6403 | 03:26:02 INFO - PROCESS | 6403 | (process:6473): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:12 INFO - PROCESS | 6403 | RSS: Main: 154087424 03:26:12 INFO - PROCESS | 6403 | 03:27:02 INFO - PROCESS | 6403 | 1458469622218 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:10 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36027/tests/dromaeo/cssquery-ext.html) 03:29:11 INFO - PROCESS | 6403 | RSS: Main: 157220864 03:29:11 INFO - PROCESS | 6403 | 03:32:12 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-ext.html (next: http://localhost:36027/tests/dromaeo/cssquery-jquery.html) 03:32:13 INFO - PROCESS | 6403 | RSS: Main: 155926528 03:32:13 INFO - PROCESS | 6403 | 03:35:15 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36027/tests/dromaeo/cssquery-mootools.html) 03:35:15 INFO - PROCESS | 6403 | RSS: Main: 155115520 03:35:15 INFO - PROCESS | 6403 | 03:38:17 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36027/tests/dromaeo/cssquery-prototype.html) 03:38:17 INFO - PROCESS | 6403 | RSS: Main: 155545600 03:38:18 INFO - PROCESS | 6403 | 03:41:20 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36027/tests/dromaeo/cssquery-yui.html) 03:41:20 INFO - PROCESS | 6403 | RSS: Main: 156078080 03:41:20 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | Cycle 1(1): loaded http://localhost:36027/tests/dromaeo/cssquery-yui.html (next: http://localhost:36027/tests/dromaeo/cssquery-dojo.html) 03:44:23 INFO - PROCESS | 6403 | RSS: Main: 158584832 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | __start_tp_report 03:44:23 INFO - PROCESS | 6403 | _x_x_mozilla_page_load 03:44:23 INFO - PROCESS | 6403 | _x_x_mozilla_page_load_details 03:44:23 INFO - PROCESS | 6403 | |i|pagename|runs| 03:44:23 INFO - PROCESS | 6403 | |0;dojo.html;3319.3195394944037;3367.427537318657;3380.8140552269615;3398.9972957977393;3405.5232267482556;5471.890562188759;5478.315210598676;5478.753456094475;5489.725513724307;5504.4770746778995;5463.562914966803;5529.0324193266215;5537.390887002426;5541.0580201365765;5562.9443705563035;4956.801727930879;5042.319286896259;5108.2848401223855;5124.436312005676;5177.508136727005;4854.975725121387;4941.135301322272;5006.849794506153;5011.749412529377;5024.221245706903;5075.289459475676;5100.668456550312;5103.719295438749;5105;5105.948940510603;4935.383077115361;4978;4994.375703037121;4995.775190116436;5003.424606170301;4785.401824771903;4850.199717046718;4888.888888888889;4894.99652571222;4919.72941488218;5218.060749065166;5240.711760853152;5244.108501554745;5249.527542521191;5262.184361423985;5868.97065514674;5870.09013602888;5877.735501902424;5881.264841894763;5932.288125424977;5751.827445176609;5808.1578171165365;5887.470127688486;5889.087191485284;5909.113632955048;5430.456954304577;5475.123980163195;5507.476789704971;5511.669299842022;5530.640508366943;5896.911546326808;6004.789832355847;6010.549208809357;6038.728257228435;6065.878682426415;5740.684262365527;5781.19063331134;5787.334456537468;5797.304323481209;5827.650340979555;5751;5755.107958266475;5764.827055188351;5769.1923130761725;5782.739776710058;5652.123920792284;5741.282339707536;5782.855428614318;5806.216160818235;5815.88368232633;5687.260656114679;5705.657660540381;5730.770769169187;5734.340550836624;5763.971180144073;4374.256376416017;4407.184670835842;4413.16149931512;4422.756748378806;4446.3552784846015;3906.4921560196995;3953.743006704555;3987.2623564640635;4020.155767288902;4020.778857162884;5434.10337294342;5479.53423958968;5484.177373393943;5484.985277723634;5529.30883639545;5837.766489340379;5897.174395584621;5898;5910.261217347832;5914.201582786269;5492.642978206404;5502.0921547944945;5531.419200983919;5589.077802162679;5594.468525490072;4892.315075889378;4977.726225057584;4979.4771548987555;4982.90034199314;4988.90022199554;6022.608530445507;6034.9396506035255;6087.634741915499;6099.376222787589;6099.817005489843;5766.394528574439;5883.676397797991;5892.440218179266;5959.910601340896;5980.312264089512;5941;5968.97015514937;5973.984422648247;5987.730552125077;6056.152138700498;5786.508146807569;5794.333651630117;5804.883902322014;5807.448292412214;5816.36020037804;5755.251817263729;5775.855603609775;5831.212786273799;5833.941660583339;5860.38465961068;5720.456556627114;5753.539716822561;5798.623089499169;5804;5804.361520232686;5620.325560932714;5726.541876649775;5779.479846813807;5780.421957804354;5786.334571524329;5627.099664053731;5668.886622267614;5682.0908654616715;5693.459121383462;5773.942260577341;5616.494515493625;5635.718214089197;5653;5676.631018983753;5731.828045158652;5501.202325662836;5518.061929471919;5532.75102620375;5656.349519805275;5705.486506214461 03:44:23 INFO - PROCESS | 6403 | |1;ext.html;514.6011840823361;526.9198143805199;531.1634176172529;537.551144794097;542.9728513574323;31312.53031204534;40135;40142.79928600353;40434.59565404345;40512;44721;45023.32465013019;45367.77316113423;45447.318290225594;45492.0901581969;8874.556272186397;9004.819903601923;9059.728208153765;9088.318376121784;9110.0434454382;8869.778255543599;9012.909870901305;9025.368224224307;9027.774305642346;9031.774205644879;8947.552622368856;9097.090290970884;9097.54512274387;9105.908940910605;9112.45325280482;9034.548272586377;9080.909190908105;9089;9223.53882305882;9242.907570924272;8963.775905602346;9031.729048128567;9036.277097832157;9079.092090790935;9111.726648200498;42959.57040429587;43216.78391608022;43275.350869736976;43441.78279108616;43618;3665.3402387570227;3728.6084961079237;3761.6990640748672;4312.63342615878;4390.253656878338;32774.836125819456;32844.17889552756;32852.342953140804;33079.50380744291;34376.14059648529;3989.1024519483176;4049.736767110158;4097.672186225095;4112.485939257593;4140.420341152241;280213;282401;282788;283316;284289;46772.7661361691;64512.677436613456;64846.35153648497;64931.67534162299;64998;44762.32856507155;44767;44798.55201448009;44850.55149448529;44903.55096449059;15740.92129539345;15911.283992220378;15987;16019.679606408039;16027.599310017344;13207.66980825487;13262;13299.401526931311;13305.733885322239;13358.198508089547;15157;15641.261857928985;15657.60855978587;15696.529104126894;15756.76364854528;6140.2017737694705;6223.190985171989;6330.847511845995;6333.113364129025;6343.651099189497;1011.6770186335403;1039.8284283093355;1052.952617132231;1059.750958524746;1067.9480711499168;32660;32751.18122046968;33401.83299083489;33514.83242583772;33714.49428258529;1085.3921803789744;1108.778244351133;1124.4995976790412;1126.3917484558247;1145.7135716070982;15412.383504659689;15632;15665.373385064699;15809.604759880865;15810.06031411126;423486;570016;575339;579259;580626;57574.7121264391;58524.122138167964;58644;58722;59143;1518.506485392252;1537.538738378482;1547;1547.4815936661118;1553.0448774003905;30969.535456968613;32010.35979280448;32249.838750806095;32286.677133228368;32772.508412373354;50451.49548504468;51065.23402149045;51388.486115139865;51529;51574.48425515697;310627;313655;315413;316250;316358;34993.82503087468;35438.64561354354;35530.644693552735;35622;35846.82076589705;46435.767821160676;46482.30276545787;46949;47349.28976065293;48187;40399.3940090893;40733.38899916445;40780;40878.182436350515;41416.585834141275;39550.60449395469;39772.80113599414;39852.60147398489;40821.38767918543;41690.58309416867;35827.462588060676;36096.63903361038;36175.63824361828;36437;39818.20363592654;35107.64892351044;35361;35837.64162358447;35930.64069359273;36101.81949090238;27157.86421067882;27988.44023119567;28217.71782282233;28295;28321.291967700974 03:44:23 INFO - PROCESS | 6403 | |2;jquery.html;374.84631301166525;387.78477944740655;389.6473691309364;397.5031210986267;404.36312807328466;17530.561735956606;18443.72334414985;19298.807011929875;20271.898640506814;20410;16684.249208785604;16817.495475135765;16953.660926781457;16964;17220.569485762862;5107.080725469414;5125.923111153335;5329.227262047001;5340.732963351837;5361.383440904287;5170.689758614476;5275.868103297429;5285.6300058995885;5288.391834938992;5306.92039619406;5267.499587539178;5291.206319052154;5300.363956325246;5300.522952934235;5304.840854774363;5381.67709937405;5694.402087780806;5758.856028599298;5770.249867517238;5779.07534794433;5105.846824595268;5136.717480538568;5139.922901156486;5150.4334523202415;5152.793888244503;13932.93033534826;14021.579352619437;14032.01775875689;14037.5086871959;15156.924215378964;2295.7015587973624;2416.8549887006834;2534.3030666566656;2704.1752265559;2776.430831679501;9733.853992190052;10662.200334974908;11842.940785296105;13940.930295348458;14200.076994995292;1803.107461806401;1832.908354582279;1857.6377606366764;1892.1012519053477;1913.885166889991;66600.6669966652;67052;67863.3213667867;68555.31444685589;68576.6571167146;10775.976282253174;10792.568297268179;10990.395528245863;11056.723581910355;11116.666500005012;13802.930985345009;14511.201883896276;14532.854671453362;14585.562433127023;14708.41166353334;7797.493162944391;7927.801804954922;8284;8314.043884953187;8342.708005219789;7785.416093792988;7830.6084695764985;7837.1379148293645;8006.759797205977;8034.437589368688;4934.136526107916;4974.054929563371;4977.228529577921;5044.9495505045215;5065.949340506548;2000.1599328282157;2032.5325175209784;2060.47457898235;2099.6955441460905;2105.063246855135;916.2257892081313;962.7929995051097;978.188103873783;999.4503023337281;1018.5976539266948;15454;17190.054546999785;17429.302827886742;17695.823041769676;18514;978.1343510992681;1027.8201314769885;1038.266253869969;1054.7310435838813;1111.4720507758911;10118.949405252926;10398.324108932895;10460.110890574235;10510.947445262726;10513.84229236562;477550;477855;483356;491144;492812;76383.64764156357;79094.60452697815;79519.20480795234;79947.20052799398;80186.59906700546;1072.5227273863056;1087.8259478483405;1089.929154604948;1090.4057288777476;1111.7220694826294;16073.839261607234;16083.195840208176;16182.433614823425;16271.59321016984;16463.259153338367;34796.65203347934;34839;35308.47037294494;35360.23198839996;35528;48848;50959.23561146512;51520.22719659133;51536.74231628968;51888;7663.808404789925;7724.497907635986;7771.72798952034;7806.297433231037;7937.523748575104;10810.45947702596;11384.886151138713;11449.255798373079;11538.653840384803;11568.652940411801;10061.949690251502;10128.34165779222;10326;10476.476176191007;10486.52810623539;5212.791488340576;7835.725749598737;9759.9024009759;10434.530446130095;10511.421871797125;10239.48802559854;10809.594752682102;10973.670789876316;11271.211015228855;11431.542738290707;7907.802304942423;8106.432549721699;8190.099089100313;8322.334213262804;8509.659613615386;8636.17956294151;10312.123469505175;10803.621873234399;10920.18098642589;11061.83407248908 03:44:23 INFO - PROCESS | 6403 | |3;mootools.html;1568.3804897065659;1624.3259047495287;1859.6187781504793;1912.684407072833;1958.2656503811063;7157.7852664420025;7822.608869556514;7968.6812527498905;8176.386770992177;8245.92802935619;7949.085855126647;7949.801254968629;7961.442699011071;8022.759317220478;8049.114597394282;2274.4086537500243;2306.066043252477;2307.9307620771406;2314.2363020203293;2317.7450480447224;2271.806896413807;2286.199830059474;2297.448612333036;2312.1560630369877;2317.2353123469215;2252.279270633398;2258.8531745436494;2260.4348912771807;2278.8176945844293;2284.6915666385075;2292.8509646873067;2305.204704376996;2309.595820731374;2317.281642690763;2323.604987152188;2302.9424264393524;2322.837401381904;2324.2910912171783;2328.941776455585;2334.3580515358244;8232.423730338878;8272.007359116944;8276.586170691442;8306.210909963544;8326.45878017927;4806.687565308243;4970.751462426864;5013.197888337885;5067.746612669352;5067.822626208065;3206.3587282543585;3286.2113092857544;3315.0220684898013;3330.150811543041;3355.899323020313;1049.6903413492962;1052.1214785653988;1071.5178169823532;1082.0856376361962;1085.907697845684;11281.887181128166;11382.317060976367;11404.258723182966;11408.087353011739;11462;4553.567411095941;4604;4704.29435584665;4732.905341893143;4737.24204127338;9739.26955478342;9788.168005719594;9796.412215267106;9822.361546499455;9825.213982881352;5107.923381149286;5110.156824124052;5136.255242989746;5145.639805213674;5162.6386152968935;3968.047668559525;4345.304751239786;4457.955420445819;4674.859754207379;4682.74244916526;3915.9021024474046;3937.0944682723134;3948.7038472114705;4004.3392840181045;4008.178323443687;1237.07219585311;1275.5854347337151;1283.1210620724833;1292.8513220979519;1295.0351987769172;1372.7323171981368;1381.1436909116412;1387.361813565751;1392.1577445645441;1414.816073910385;7439.665215065335;7818.257265559762;7851.214878512217;7860.764177074582;7871.134175240719;512.0578136229356;522.3131581969698;528.0969542083081;531.9122394702842;534.156033467121;5743.3395159557185;5745.908277427276;5776.480116789509;5860.208871802337;5865.35481097079;9529.714108576754;9947.751306217402;10047.24645651579;10065.345752526062;10077.848832267522;9803.068708472683;9832;9849.50752462374;9913.80172396548;9974.900250997542;7160.10498687664;7234.421246300283;7252.673629686677;7286.417086633057;7353.374963128087;7586.127595326608;7716.691332346643;7730;7741.109772376249;7852.528848269122;8619.741407757778;8692.826143477221;8820.955895220482;8839.337049721167;8927.910720892707;8943.463392196489;8996.59515321799;9007.504587247764;9070.410423322463;9155.267578593563;6309.305976342691;6720.966395167993;6861.348171923659;7118.252583478868;7209.747658831916;7529.623518823927;7808.375329973474;7809.609519524115;7811.687532498864;7893.644785984759;6679.098321726505;6699.229588597374;6743.5953842769595;6827.795166145023;6971.895421568579;6640.501962352746;6652.135222421054;6726.764563240459;6740.764073257608;6744.831379215559;7303.30618591233;7408.740694075682;7447.925520744723;7478.4765066444825;7514.8497030058;6568.948968165262;6609.603423794588;6610.140681711347;6635.469162466895;6652.035454858921;6740.730370785113;6806.863862722619;6813.931860681329;6845.0759147514445;6845.897311540231 03:44:23 INFO - PROCESS | 6403 | |4;prototype.html;347.94085005549056;349.25608453992993;351.9736019798514;357.11613755954033;359.90822340303237;6388.520860935431;6450.548461607689;6460.515461340401;6461.353864613537;6486.57837240579;6346.619202847821;6352.015437607179;6360.522960777948;6364.904526432096;6370.713317900706;4662.953370466303;4700.341952126705;4817.735024573647;4821.90356192876;4833.685810422329;4774.092922344744;4777.307290442884;4787.186178349689;4789.952100478986;4821.156297647897;4797.0405918816205;4812.398450193726;4823.20417131173;4830.661853670244;4833.32333473314;4802.471728109923;4805.759712014403;4831.178699621073;4842.2252439609665;4862.319275301461;4190.455240818705;4196.874093777192;4216.57834216579;4238.7032907696475;4251.638610718092;5888.617239879437;6035.336113027563;6090.116933044728;6120.693965301717;6139.140520327158;5601.215829783833;5614.2701448811395;5619.213310136543;5624.5781566382275;5625.184348269478;6784.050232967388;6806.863862722767;6807.863842723167;6808.5914845109455;6837.829054273683;4561.954380456219;4569.794359253841;4569.862904112882;4588.4723256825555;4593.058423023273;7065.540739851893;7076.610786406797;7139.178994415604;7144.249853765332;7151.4993950423495;4673.615137953441;4695.5069717679835;4726.763661816895;4731.69243999139;4736.242201247784;4767.213409787416;4794.904101917942;4797.784099715521;4800.783964721596;4803.063402636452;5527.806526771544;5576.944230557724;5577.191307260506;5579.609427340048;5589.441055894378;6784.830379240559;6800.761973330909;6811.795646130624;6823.658817059227;6827.146606674166;1673.1717799688988;1680.15992003998;1686.7891513560805;1688.3246701319324;1688.9493315200564;1088.2545456362418;1106.8948449897248;1132.1791701016862;1132.7281452451516;1150.3787954504642;6481.773137940244;6495.642739649365;6540.313267106981;6541.8691626168165;6602.471802255808;6866.519343645997;7011.193712723;7020.297970202939;7034.92965070353;7044.823879402953;6598.10925525048;6643.2360278568585;6669.09967154428;6676.098726671934;6686.364795344434;3761.7931013793955;3823.4647149399107;3825.2349530094093;3836.865709700147;3845.942310865339;7293.270672932665;7303.817404564822;7329.047223860971;7358.96320518394;7384.076990376203;7026.613536255555;7219.60292183935;7261.89107163393;7316.378107860785;7321.524100933422;7313.085864266966;7331.413486921034;7331.963340183372;7339.678857805539;7340.743073992491;7070.575765454089;7091.751788687371;7097.077379940574;7105.076340075757;7111.9288807113335;6901.482388820959;6948.062011628567;6980.267071957372;6981.581105133709;6989.475789315923;7197.604131772593;7314.817129571803;7319.268073192851;7333.486655934247;7377.852442951218;4781.330613714013;4785.521447855187;4810.254410566367;4817.759112044454;4825.5898248649255;7058.188308344606;7073.71705131789;7110.182329032227;7110.5022648414115;7119.430445564239;6858.8285292866085;6859.588424694335;6872.10662613857;6874.106366172366;6896.2069362022;6699.0621313015245;6853.760118395832;6874.65626718652;6895.207051189177;6896.620685862325;6741.59550426976;6792.049113124265;6794.320567943364;6806.489513286424;6811.421029212573;6958.478114141359;6962.408195303456;6996.370326670624;6997.615131167835;6998.40513556333;6689.230738464944;6733.360330768569;6749;6751.459883209233;6752.493562982698 03:44:23 INFO - PROCESS | 6403 | |5;yui.html;847.4533925617975;865.7056600755742;891.0510306523552;897.4480694372959;909.1999040844056;14307.284635768223;14357.712845743079;14377.928110359446;14482.855171448282;14496.057756245837;14023;14044.508442204526;14095.365708543115;14106.506272280472;14131.152130872155;757.4924800383742;913.118840319092;928.2342067794096;936.9531523423801;937.3391758810022;914.3462424366577;917.5779141594875;921.3182245138617;921.6451666108529;923.8845144356956;990.0742805476866;994.0953732103787;996.3822430093352;997.7206382212992;998.1465846701075;986.7089208683456;987.782687808681;987.8221920054388;988.4217732626422;989.990100098997;721.6319676964733;729.9598522081284;731.3929438566031;734.071399679406;735.5807189901758;14033.087849289866;14105.294735263196;14142.151470911778;14150.787738183935;14192.929035354757;12808.551700690525;13292.3353832308;13510.662233444144;13671.589852304447;13675.794863077062;11051.226414151013;11072.889271107266;11161.72095697606;11233;11248.887511124865;3910.2179564087296;3925.234579257046;3932.528096628423;3956.3669812829808;3994.1013272013856;51915.74042129803;51972.960540789354;53542.732286338316;54213.45786542163;54596.908061838934;11355.93725474612;11414.600488982845;11427.542898283975;11478.540858365572;11494.827577586342;19730.013499324978;19733.703994440093;19752.40742777719;19826.90086549558;19844.702329465068;8144.714934977247;8371.744238364294;8474.830503389898;8502.787430314167;8575.871361929576;4656.697314674535;4683.180443422388;4724.71651700899;4798.976005119952;4856.39295088114;3239.368323176958;3283.5238890361243;3290.4899740540254;3302.8348582570775;3323.7839540429795;595.330253464852;617.2253821454046;620.6803496199461;629.222909706512;629.6127881353027;630.5964182922933;712.6614857942436;721.1346384338815;732.4945787406672;735.6027745017738;8615.78460538479;8887.688930887389;8931.598078086501;9030.322725795591;9166.312526560534;600.2077258019373;695.4471195399669;706.9399101076364;711.1643818513227;740.333699670301;4072.205919845661;4235.682323825726;4251.29853574163;4264.232438161099;4279.079997800488;60419;66717.66641166763;66777.99833002509;68098;68160.65919670468;51517.484825152016;51716.22425663618;52683;53146;53506;47613.047739045025;48231.75884120557;48640.02719945652;48728.269075963886;49284.50715492799;8856.734297971072;8882.733517994471;8909.73270801877;9244.075592440702;9278.582463789011;35132.47301290432;35840.4623930636;36078.09804754902;36894;37309.81345093257;44980.77509612562;46668.53331466642;47124.29313560231;47291.763541182074;47652;12266.202696824677;12291.877081229431;12462.875371246171;12481.438335274754;12672;13196.406161722938;13325;13422.127561708458;13755.862441375459;13903.721925561635;11275.943620281847;11747.339751395533;12100.394980250776;12348.506059757508;12430.813537797121;12035.217710848767;12297.077719171277;12401.193922395016;12450.81323780126;12797.680057998625;10928.344299342065;11956.282623042645;12030.458629361525;12415.875841241472;12848.935755321163;10499.990075623795;10604.946975265382;10640.308379955588;10880.347179168959;10988.780224395627;10508;10736.785264294827;10813.459327033774;10865.348079115278;10942.890571094187 03:44:23 INFO - PROCESS | 6403 | __end_tp_report 03:44:23 INFO - PROCESS | 6403 | __start_cc_report 03:44:23 INFO - PROCESS | 6403 | _x_x_mozilla_cycle_collect,325 03:44:23 INFO - PROCESS | 6403 | __end_cc_report 03:44:23 INFO - PROCESS | 6403 | __startTimestamp1458470663283__endTimestamp 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | ------- Summary: start ------- 03:44:23 INFO - PROCESS | 6403 | Number of tests: 6 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#0] dojo.html Cycles:165 Average:5429.55 Median:5652.12 stddev:595.07 (10.5%) stddev-sans-first:573.41 03:44:23 INFO - PROCESS | 6403 | Values: 3319.3 3367.4 3380.8 3399.0 3405.5 5471.9 5478.3 5478.8 5489.7 5504.5 5463.6 5529.0 5537.4 5541.1 5562.9 4956.8 5042.3 5108.3 5124.4 5177.5 4855.0 4941.1 5006.8 5011.7 5024.2 5075.3 5100.7 5103.7 5105.0 5105.9 4935.4 4978.0 4994.4 4995.8 5003.4 4785.4 4850.2 4888.9 4895.0 4919.7 5218.1 5240.7 5244.1 5249.5 5262.2 5869.0 5870.1 5877.7 5881.3 5932.3 5751.8 5808.2 5887.5 5889.1 5909.1 5430.5 5475.1 5507.5 5511.7 5530.6 5896.9 6004.8 6010.5 6038.7 6065.9 5740.7 5781.2 5787.3 5797.3 5827.7 5751.0 5755.1 5764.8 5769.2 5782.7 5652.1 5741.3 5782.9 5806.2 5815.9 5687.3 5705.7 5730.8 5734.3 5764.0 4374.3 4407.2 4413.2 4422.8 4446.4 3906.5 3953.7 3987.3 4020.2 4020.8 5434.1 5479.5 5484.2 5485.0 5529.3 5837.8 5897.2 5898.0 5910.3 5914.2 5492.6 5502.1 5531.4 5589.1 5594.5 4892.3 4977.7 4979.5 4982.9 4988.9 6022.6 6034.9 6087.6 6099.4 6099.8 5766.4 5883.7 5892.4 5959.9 5980.3 5941.0 5969.0 5974.0 5987.7 6056.2 5786.5 5794.3 5804.9 5807.4 5816.4 5755.3 5775.9 5831.2 5833.9 5860.4 5720.5 5753.5 5798.6 5804.0 5804.4 5620.3 5726.5 5779.5 5780.4 5786.3 5627.1 5668.9 5682.1 5693.5 5773.9 5616.5 5635.7 5653.0 5676.6 5731.8 5501.2 5518.1 5532.8 5656.3 5705.5 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#1] ext.html Cycles:180 Average:54794.86 Median:40416.99 stddev:106276.82 (263.0%) stddev-sans-first:106496.82 03:44:23 INFO - PROCESS | 6403 | Values: 514.6 526.9 531.2 537.6 543.0 31312.5 40135.0 40142.8 40434.6 40512.0 44721.0 45023.3 45367.8 45447.3 45492.1 8874.6 9004.8 9059.7 9088.3 9110.0 8869.8 9012.9 9025.4 9027.8 9031.8 8947.6 9097.1 9097.5 9105.9 9112.5 9034.5 9080.9 9089.0 9223.5 9242.9 8963.8 9031.7 9036.3 9079.1 9111.7 42959.6 43216.8 43275.4 43441.8 43618.0 3665.3 3728.6 3761.7 4312.6 4390.3 32774.8 32844.2 32852.3 33079.5 34376.1 3989.1 4049.7 4097.7 4112.5 4140.4 280213.0 282401.0 282788.0 283316.0 284289.0 46772.8 64512.7 64846.4 64931.7 64998.0 44762.3 44767.0 44798.6 44850.6 44903.6 15740.9 15911.3 15987.0 16019.7 16027.6 13207.7 13262.0 13299.4 13305.7 13358.2 15157.0 15641.3 15657.6 15696.5 15756.8 6140.2 6223.2 6330.8 6333.1 6343.7 1011.7 1039.8 1053.0 1059.8 1067.9 32660.0 32751.2 33401.8 33514.8 33714.5 1085.4 1108.8 1124.5 1126.4 1145.7 15412.4 15632.0 15665.4 15809.6 15810.1 423486.0 570016.0 575339.0 579259.0 580626.0 57574.7 58524.1 58644.0 58722.0 59143.0 1518.5 1537.5 1547.0 1547.5 1553.0 30969.5 32010.4 32249.8 32286.7 32772.5 50451.5 51065.2 51388.5 51529.0 51574.5 310627.0 313655.0 315413.0 316250.0 316358.0 34993.8 35438.6 35530.6 35622.0 35846.8 46435.8 46482.3 46949.0 47349.3 48187.0 40399.4 40733.4 40780.0 40878.2 41416.6 39550.6 39772.8 39852.6 40821.4 41690.6 35827.5 36096.6 36175.6 36437.0 39818.2 35107.6 35361.0 35837.6 35930.6 36101.8 27157.9 27988.4 28217.7 28295.0 28321.3 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#2] jquery.html Cycles:180 Average:27066.42 Median:34817.83 stddev:79472.74 (228.3%) stddev-sans-first:79670.41 03:44:23 INFO - PROCESS | 6403 | Values: 374.8 387.8 389.6 397.5 404.4 17530.6 18443.7 19298.8 20271.9 20410.0 16684.2 16817.5 16953.7 16964.0 17220.6 5107.1 5125.9 5329.2 5340.7 5361.4 5170.7 5275.9 5285.6 5288.4 5306.9 5267.5 5291.2 5300.4 5300.5 5304.8 5381.7 5694.4 5758.9 5770.2 5779.1 5105.8 5136.7 5139.9 5150.4 5152.8 13932.9 14021.6 14032.0 14037.5 15156.9 2295.7 2416.9 2534.3 2704.2 2776.4 9733.9 10662.2 11842.9 13940.9 14200.1 1803.1 1832.9 1857.6 1892.1 1913.9 66600.7 67052.0 67863.3 68555.3 68576.7 10776.0 10792.6 10990.4 11056.7 11116.7 13802.9 14511.2 14532.9 14585.6 14708.4 7797.5 7927.8 8284.0 8314.0 8342.7 7785.4 7830.6 7837.1 8006.8 8034.4 4934.1 4974.1 4977.2 5044.9 5065.9 2000.2 2032.5 2060.5 2099.7 2105.1 916.2 962.8 978.2 999.5 1018.6 15454.0 17190.1 17429.3 17695.8 18514.0 978.1 1027.8 1038.3 1054.7 1111.5 10118.9 10398.3 10460.1 10510.9 10513.8 477550.0 477855.0 483356.0 491144.0 492812.0 76383.6 79094.6 79519.2 79947.2 80186.6 1072.5 1087.8 1089.9 1090.4 1111.7 16073.8 16083.2 16182.4 16271.6 16463.3 34796.7 34839.0 35308.5 35360.2 35528.0 48848.0 50959.2 51520.2 51536.7 51888.0 7663.8 7724.5 7771.7 7806.3 7937.5 10810.5 11384.9 11449.3 11538.7 11568.7 10061.9 10128.3 10326.0 10476.5 10486.5 5212.8 7835.7 9759.9 10434.5 10511.4 10239.5 10809.6 10973.7 11271.2 11431.5 7907.8 8106.4 8190.1 8322.3 8509.7 8636.2 10312.1 10803.6 10920.2 11061.8 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#3] mootools.html Cycles:180 Average:5679.75 Median:5818.34 stddev:2978.80 (51.2%) stddev-sans-first:2971.13 03:44:23 INFO - PROCESS | 6403 | Values: 1568.4 1624.3 1859.6 1912.7 1958.3 7157.8 7822.6 7968.7 8176.4 8245.9 7949.1 7949.8 7961.4 8022.8 8049.1 2274.4 2306.1 2307.9 2314.2 2317.7 2271.8 2286.2 2297.4 2312.2 2317.2 2252.3 2258.9 2260.4 2278.8 2284.7 2292.9 2305.2 2309.6 2317.3 2323.6 2302.9 2322.8 2324.3 2328.9 2334.4 8232.4 8272.0 8276.6 8306.2 8326.5 4806.7 4970.8 5013.2 5067.7 5067.8 3206.4 3286.2 3315.0 3330.2 3355.9 1049.7 1052.1 1071.5 1082.1 1085.9 11281.9 11382.3 11404.3 11408.1 11462.0 4553.6 4604.0 4704.3 4732.9 4737.2 9739.3 9788.2 9796.4 9822.4 9825.2 5107.9 5110.2 5136.3 5145.6 5162.6 3968.0 4345.3 4458.0 4674.9 4682.7 3915.9 3937.1 3948.7 4004.3 4008.2 1237.1 1275.6 1283.1 1292.9 1295.0 1372.7 1381.1 1387.4 1392.2 1414.8 7439.7 7818.3 7851.2 7860.8 7871.1 512.1 522.3 528.1 531.9 534.2 5743.3 5745.9 5776.5 5860.2 5865.4 9529.7 9947.8 10047.2 10065.3 10077.8 9803.1 9832.0 9849.5 9913.8 9974.9 7160.1 7234.4 7252.7 7286.4 7353.4 7586.1 7716.7 7730.0 7741.1 7852.5 8619.7 8692.8 8821.0 8839.3 8927.9 8943.5 8996.6 9007.5 9070.4 9155.3 6309.3 6721.0 6861.3 7118.3 7209.7 7529.6 7808.4 7809.6 7811.7 7893.6 6679.1 6699.2 6743.6 6827.8 6971.9 6640.5 6652.1 6726.8 6740.8 6744.8 7303.3 7408.7 7447.9 7478.5 7514.8 6568.9 6609.6 6610.1 6635.5 6652.0 6740.7 6806.9 6813.9 6845.1 6845.9 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#4] prototype.html Cycles:180 Average:5689.74 Median:6491.11 stddev:1751.06 (27.0%) stddev-sans-first:1709.45 03:44:23 INFO - PROCESS | 6403 | Values: 347.9 349.3 352.0 357.1 359.9 6388.5 6450.5 6460.5 6461.4 6486.6 6346.6 6352.0 6360.5 6364.9 6370.7 4663.0 4700.3 4817.7 4821.9 4833.7 4774.1 4777.3 4787.2 4790.0 4821.2 4797.0 4812.4 4823.2 4830.7 4833.3 4802.5 4805.8 4831.2 4842.2 4862.3 4190.5 4196.9 4216.6 4238.7 4251.6 5888.6 6035.3 6090.1 6120.7 6139.1 5601.2 5614.3 5619.2 5624.6 5625.2 6784.1 6806.9 6807.9 6808.6 6837.8 4562.0 4569.8 4569.9 4588.5 4593.1 7065.5 7076.6 7139.2 7144.2 7151.5 4673.6 4695.5 4726.8 4731.7 4736.2 4767.2 4794.9 4797.8 4800.8 4803.1 5527.8 5576.9 5577.2 5579.6 5589.4 6784.8 6800.8 6811.8 6823.7 6827.1 1673.2 1680.2 1686.8 1688.3 1688.9 1088.3 1106.9 1132.2 1132.7 1150.4 6481.8 6495.6 6540.3 6541.9 6602.5 6866.5 7011.2 7020.3 7034.9 7044.8 6598.1 6643.2 6669.1 6676.1 6686.4 3761.8 3823.5 3825.2 3836.9 3845.9 7293.3 7303.8 7329.0 7359.0 7384.1 7026.6 7219.6 7261.9 7316.4 7321.5 7313.1 7331.4 7332.0 7339.7 7340.7 7070.6 7091.8 7097.1 7105.1 7111.9 6901.5 6948.1 6980.3 6981.6 6989.5 7197.6 7314.8 7319.3 7333.5 7377.9 4781.3 4785.5 4810.3 4817.8 4825.6 7058.2 7073.7 7110.2 7110.5 7119.4 6858.8 6859.6 6872.1 6874.1 6896.2 6699.1 6853.8 6874.7 6895.2 6896.6 6741.6 6792.0 6794.3 6806.5 6811.4 6958.5 6962.4 6996.4 6997.6 6998.4 6689.2 6733.4 6749.0 6751.5 6752.5 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - PROCESS | 6403 | [#5] yui.html Cycles:180 Average:14875.53 Median:24818.74 stddev:17205.83 (69.3%) stddev-sans-first:17221.84 03:44:23 INFO - PROCESS | 6403 | Values: 847.5 865.7 891.1 897.4 909.2 14307.3 14357.7 14377.9 14482.9 14496.1 14023.0 14044.5 14095.4 14106.5 14131.2 757.5 913.1 928.2 937.0 937.3 914.3 917.6 921.3 921.6 923.9 990.1 994.1 996.4 997.7 998.1 986.7 987.8 987.8 988.4 990.0 721.6 730.0 731.4 734.1 735.6 14033.1 14105.3 14142.2 14150.8 14192.9 12808.6 13292.3 13510.7 13671.6 13675.8 11051.2 11072.9 11161.7 11233.0 11248.9 3910.2 3925.2 3932.5 3956.4 3994.1 51915.7 51973.0 53542.7 54213.5 54596.9 11355.9 11414.6 11427.5 11478.5 11494.8 19730.0 19733.7 19752.4 19826.9 19844.7 8144.7 8371.7 8474.8 8502.8 8575.9 4656.7 4683.2 4724.7 4799.0 4856.4 3239.4 3283.5 3290.5 3302.8 3323.8 595.3 617.2 620.7 629.2 629.6 630.6 712.7 721.1 732.5 735.6 8615.8 8887.7 8931.6 9030.3 9166.3 600.2 695.4 706.9 711.2 740.3 4072.2 4235.7 4251.3 4264.2 4279.1 60419.0 66717.7 66778.0 68098.0 68160.7 51517.5 51716.2 52683.0 53146.0 53506.0 47613.0 48231.8 48640.0 48728.3 49284.5 8856.7 8882.7 8909.7 9244.1 9278.6 35132.5 35840.5 36078.1 36894.0 37309.8 44980.8 46668.5 47124.3 47291.8 47652.0 12266.2 12291.9 12462.9 12481.4 12672.0 13196.4 13325.0 13422.1 13755.9 13903.7 11275.9 11747.3 12100.4 12348.5 12430.8 12035.2 12297.1 12401.2 12450.8 12797.7 10928.3 11956.3 12030.5 12415.9 12848.9 10500.0 10604.9 10640.3 10880.3 10988.8 10508.0 10736.8 10813.5 10865.3 10942.9 03:44:23 INFO - PROCESS | 6403 | -------- Summary: end -------- 03:44:23 INFO - PROCESS | 6403 | 03:44:23 INFO - TEST-INFO | 6403: exit 0 03:44:23 INFO - TEST-OK | dromaeo_css | took 1109081ms 03:44:23 INFO - TEST-START | kraken 03:44:23 INFO - operating with platform_type : linux_ 03:44:23 INFO - Initialising browser for kraken test... 03:44:23 INFO - TEST-INFO | started process 6644 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZqnDy/profile http://localhost:36027/getInfo.html) 03:44:27 INFO - PROCESS | 6644 | 03:44:27 INFO - PROCESS | 6644 | (process:6723): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:44:28 INFO - PROCESS | 6644 | __metrics Screen width/height:1600/1200 03:44:28 INFO - PROCESS | 6644 | colorDepth:24 03:44:28 INFO - PROCESS | 6644 | Browser inner width/height: 1024/697 03:44:28 INFO - PROCESS | 6644 | __metrics 03:44:29 ERROR - PROCESS | 6644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:44:29 INFO - TEST-INFO | 6644: exit 0 03:44:29 INFO - Browser initialized. 03:44:29 INFO - Running cycle 1/1 for kraken test... 03:44:29 INFO - TEST-INFO | started process 6774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJZqnDy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:31 INFO - PROCESS | 6774 | 03:44:31 INFO - PROCESS | 6774 | (process:6843): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:44:41 INFO - PROCESS | 6774 | RSS: Main: 154542080 03:44:41 INFO - PROCESS | 6774 | 03:44:44 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36027/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:44 INFO - PROCESS | 6774 | RSS: Main: 158265344 03:44:44 INFO - PROCESS | 6774 | 03:44:47 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36027/tests/kraken/driver.html?testName=audio-dft) 03:44:47 INFO - PROCESS | 6774 | RSS: Main: 159895552 03:44:47 INFO - PROCESS | 6774 | 03:44:50 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36027/tests/kraken/driver.html?testName=audio-fft) 03:44:51 INFO - PROCESS | 6774 | RSS: Main: 159498240 03:44:51 INFO - PROCESS | 6774 | 03:44:53 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36027/tests/kraken/driver.html?testName=audio-oscillator) 03:44:54 INFO - PROCESS | 6774 | RSS: Main: 159584256 03:44:54 INFO - PROCESS | 6774 | 03:44:56 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:56 INFO - PROCESS | 6774 | RSS: Main: 159387648 03:44:56 INFO - PROCESS | 6774 | 03:44:59 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36027/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:00 INFO - PROCESS | 6774 | RSS: Main: 158097408 03:45:00 INFO - PROCESS | 6774 | 03:45:03 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36027/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:04 INFO - PROCESS | 6774 | RSS: Main: 158400512 03:45:04 INFO - PROCESS | 6774 | 03:45:07 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36027/tests/kraken/driver.html?testName=json-parse-financial) 03:45:07 INFO - PROCESS | 6774 | RSS: Main: 158212096 03:45:07 INFO - PROCESS | 6774 | 03:45:09 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:10 INFO - PROCESS | 6774 | RSS: Main: 159223808 03:45:10 INFO - PROCESS | 6774 | 03:45:11 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:12 INFO - PROCESS | 6774 | RSS: Main: 160022528 03:45:12 INFO - PROCESS | 6774 | 03:45:14 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:15 INFO - PROCESS | 6774 | RSS: Main: 158785536 03:45:15 INFO - PROCESS | 6774 | 03:45:17 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:18 INFO - PROCESS | 6774 | RSS: Main: 160329728 03:45:18 INFO - PROCESS | 6774 | 03:45:20 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:21 INFO - PROCESS | 6774 | RSS: Main: 159870976 03:45:21 INFO - PROCESS | 6774 | 03:45:22 INFO - PROCESS | 6774 | Cycle 1(1): loaded http://localhost:36027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36027/tests/kraken/driver.html?testName=ai-astar) 03:45:23 INFO - PROCESS | 6774 | RSS: Main: 161439744 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | __start_tp_report 03:45:23 INFO - PROCESS | 6774 | _x_x_mozilla_page_load 03:45:23 INFO - PROCESS | 6774 | _x_x_mozilla_page_load_details 03:45:23 INFO - PROCESS | 6774 | |i|pagename|runs| 03:45:23 INFO - PROCESS | 6774 | |0;ai-astar;112;105;111;110;111;122;112;111;110;111 03:45:23 INFO - PROCESS | 6774 | |1;audio-beat-detection;153;125;148;170;128;150;154;128;172;127 03:45:23 INFO - PROCESS | 6774 | |2;audio-dft;163;162;163;162;161;161;161;161;165;162 03:45:23 INFO - PROCESS | 6774 | |3;audio-fft;76;76;75;162;72;74;72;73;162;75 03:45:23 INFO - PROCESS | 6774 | |4;audio-oscillator;92;93;138;93;94;93;141;93;93;144 03:45:23 INFO - PROCESS | 6774 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;118;117 03:45:23 INFO - PROCESS | 6774 | |6;imaging-darkroom;147;146;148;147;149;147;147;147;147;146 03:45:23 INFO - PROCESS | 6774 | |7;imaging-desaturate;96;97;96;97;98;97;96;96;96;96 03:45:23 INFO - PROCESS | 6774 | |8;json-parse-financial;57;55;55;55;59;56;56;62;54;56 03:45:23 INFO - PROCESS | 6774 | |9;json-stringify-tinderbox;63;64;64;64;64;64;64;64;64;65 03:45:23 INFO - PROCESS | 6774 | |10;stanford-crypto-aes;77;79;79;78;78;80;78;78;79;76 03:45:23 INFO - PROCESS | 6774 | |11;stanford-crypto-ccm;112;109;111;110;115;111;113;111;112;126 03:45:23 INFO - PROCESS | 6774 | |12;stanford-crypto-pbkdf2;140;152;146;143;135;143;146;148;144;134 03:45:23 INFO - PROCESS | 6774 | |13;stanford-crypto-sha256-iterative;69;66;70;70;66;67;67;70;67;69 03:45:23 INFO - PROCESS | 6774 | __end_tp_report 03:45:23 INFO - PROCESS | 6774 | __start_cc_report 03:45:23 INFO - PROCESS | 6774 | _x_x_mozilla_cycle_collect,841 03:45:23 INFO - PROCESS | 6774 | __end_cc_report 03:45:23 INFO - PROCESS | 6774 | __startTimestamp1458470723091__endTimestamp 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | ------- Summary: start ------- 03:45:23 INFO - PROCESS | 6774 | Number of tests: 14 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.20 (3.8%) stddev-sans-first:4.45 03:45:23 INFO - PROCESS | 6774 | Values: 112.0 105.0 111.0 110.0 111.0 122.0 112.0 111.0 110.0 111.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.50 stddev:17.74 (11.7%) stddev-sans-first:18.61 03:45:23 INFO - PROCESS | 6774 | Values: 153.0 125.0 148.0 170.0 128.0 150.0 154.0 128.0 172.0 127.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 03:45:23 INFO - PROCESS | 6774 | Values: 163.0 162.0 163.0 162.0 161.0 161.0 161.0 161.0 165.0 162.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#3] audio-fft Cycles:10 Average:91.70 Median:74.50 stddev:37.08 (49.8%) stddev-sans-first:38.89 03:45:23 INFO - PROCESS | 6774 | Values: 76.0 76.0 75.0 162.0 72.0 74.0 72.0 73.0 162.0 75.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:23.23 (25.0%) stddev-sans-first:23.97 03:45:23 INFO - PROCESS | 6774 | Values: 92.0 93.0 138.0 93.0 94.0 93.0 141.0 93.0 93.0 144.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:45:23 INFO - PROCESS | 6774 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:45:23 INFO - PROCESS | 6774 | Values: 147.0 146.0 148.0 147.0 149.0 147.0 147.0 147.0 147.0 146.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:45:23 INFO - PROCESS | 6774 | Values: 96.0 97.0 96.0 97.0 98.0 97.0 96.0 96.0 96.0 96.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:2.37 (4.2%) stddev-sans-first:2.51 03:45:23 INFO - PROCESS | 6774 | Values: 57.0 55.0 55.0 55.0 59.0 56.0 56.0 62.0 54.0 56.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 03:45:23 INFO - PROCESS | 6774 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:1.14 (1.4%) stddev-sans-first:1.12 03:45:23 INFO - PROCESS | 6774 | Values: 77.0 79.0 79.0 78.0 78.0 80.0 78.0 78.0 79.0 76.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#11] stanford-crypto-ccm Cycles:10 Average:113.00 Median:112.00 stddev:4.85 (4.3%) stddev-sans-first:5.13 03:45:23 INFO - PROCESS | 6774 | Values: 112.0 109.0 111.0 110.0 115.0 111.0 113.0 111.0 112.0 126.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:145.00 stddev:5.57 (3.8%) stddev-sans-first:5.79 03:45:23 INFO - PROCESS | 6774 | Values: 140.0 152.0 146.0 143.0 135.0 143.0 146.0 148.0 144.0 134.0 03:45:23 INFO - PROCESS | 6774 | 03:45:23 INFO - PROCESS | 6774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 03:45:23 INFO - PROCESS | 6774 | Values: 69.0 66.0 70.0 70.0 66.0 67.0 67.0 70.0 67.0 69.0 03:45:23 INFO - PROCESS | 6774 | -------- Summary: end -------- 03:45:23 INFO - PROCESS | 6774 | 03:45:24 INFO - TEST-INFO | 6774: exit 0 03:45:24 INFO - TEST-OK | kraken | took 60106ms 03:45:24 INFO - SUITE-END | took 1169s 03:45:24 INFO - Completed test suite (00:19:29) 03:45:24 INFO - javascript benchmark 03:45:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.3195394944037, 3367.427537318657, 3380.8140552269615, 3398.9972957977393, 3405.5232267482556, 5471.890562188759, 5478.315210598676, 5478.753456094475, 5489.725513724307, 5504.4770746778995, 5463.562914966803, 5529.0324193266215, 5537.390887002426, 5541.0580201365765, 5562.9443705563035, 4956.801727930879, 5042.319286896259, 5108.2848401223855, 5124.436312005676, 5177.508136727005, 4854.975725121387, 4941.135301322272, 5006.849794506153, 5011.749412529377, 5024.221245706903, 5075.289459475676, 5100.668456550312, 5103.719295438749, 5105.0, 5105.948940510603, 4935.383077115361, 4978.0, 4994.375703037121, 4995.775190116436, 5003.424606170301, 4785.401824771903, 4850.199717046718, 4888.888888888889, 4894.99652571222, 4919.72941488218, 5218.060749065166, 5240.711760853152, 5244.108501554745, 5249.527542521191, 5262.184361423985, 5868.97065514674, 5870.09013602888, 5877.735501902424, 5881.264841894763, 5932.288125424977, 5751.827445176609, 5808.1578171165365, 5887.470127688486, 5889.087191485284, 5909.113632955048, 5430.456954304577, 5475.123980163195, 5507.476789704971, 5511.669299842022, 5530.640508366943, 5896.911546326808, 6004.789832355847, 6010.549208809357, 6038.728257228435, 6065.878682426415, 5740.684262365527, 5781.19063331134, 5787.334456537468, 5797.304323481209, 5827.650340979555, 5751.0, 5755.107958266475, 5764.827055188351, 5769.1923130761725, 5782.739776710058, 5652.123920792284, 5741.282339707536, 5782.855428614318, 5806.216160818235, 5815.88368232633, 5687.260656114679, 5705.657660540381, 5730.770769169187, 5734.340550836624, 5763.971180144073, 4374.256376416017, 4407.184670835842, 4413.16149931512, 4422.756748378806, 4446.3552784846015, 3906.4921560196995, 3953.743006704555, 3987.2623564640635, 4020.155767288902, 4020.778857162884, 5434.10337294342, 5479.53423958968, 5484.177373393943, 5484.985277723634, 5529.30883639545, 5837.766489340379, 5897.174395584621, 5898.0, 5910.261217347832, 5914.201582786269, 5492.642978206404, 5502.0921547944945, 5531.419200983919, 5589.077802162679, 5594.468525490072, 4892.315075889378, 4977.726225057584, 4979.4771548987555, 4982.90034199314, 4988.90022199554, 6022.608530445507, 6034.9396506035255, 6087.634741915499, 6099.376222787589, 6099.817005489843, 5766.394528574439, 5883.676397797991, 5892.440218179266, 5959.910601340896, 5980.312264089512, 5941.0, 5968.97015514937, 5973.984422648247, 5987.730552125077, 6056.152138700498, 5786.508146807569, 5794.333651630117, 5804.883902322014, 5807.448292412214, 5816.36020037804, 5755.251817263729, 5775.855603609775, 5831.212786273799, 5833.941660583339, 5860.38465961068, 5720.456556627114, 5753.539716822561, 5798.623089499169, 5804.0, 5804.361520232686, 5620.325560932714, 5726.541876649775, 5779.479846813807, 5780.421957804354, 5786.334571524329, 5627.099664053731, 5668.886622267614, 5682.0908654616715, 5693.459121383462, 5773.942260577341, 5616.494515493625, 5635.718214089197, 5653.0, 5676.631018983753, 5731.828045158652, 5501.202325662836, 5518.061929471919, 5532.75102620375, 5656.349519805275, 5705.486506214461], "unit": "score", "name": "dojo.html", "value": 5391.750656864422}, {"lowerIsBetter": false, "replicates": [514.6011840823361, 526.9198143805199, 531.1634176172529, 537.551144794097, 542.9728513574323, 31312.53031204534, 40135.0, 40142.79928600353, 40434.59565404345, 40512.0, 44721.0, 45023.32465013019, 45367.77316113423, 45447.318290225594, 45492.0901581969, 8874.556272186397, 9004.819903601923, 9059.728208153765, 9088.318376121784, 9110.0434454382, 8869.778255543599, 9012.909870901305, 9025.368224224307, 9027.774305642346, 9031.774205644879, 8947.552622368856, 9097.090290970884, 9097.54512274387, 9105.908940910605, 9112.45325280482, 9034.548272586377, 9080.909190908105, 9089.0, 9223.53882305882, 9242.907570924272, 8963.775905602346, 9031.729048128567, 9036.277097832157, 9079.092090790935, 9111.726648200498, 42959.57040429587, 43216.78391608022, 43275.350869736976, 43441.78279108616, 43618.0, 3665.3402387570227, 3728.6084961079237, 3761.6990640748672, 4312.63342615878, 4390.253656878338, 32774.836125819456, 32844.17889552756, 32852.342953140804, 33079.50380744291, 34376.14059648529, 3989.1024519483176, 4049.736767110158, 4097.672186225095, 4112.485939257593, 4140.420341152241, 280213.0, 282401.0, 282788.0, 283316.0, 284289.0, 46772.7661361691, 64512.677436613456, 64846.35153648497, 64931.67534162299, 64998.0, 44762.32856507155, 44767.0, 44798.55201448009, 44850.55149448529, 44903.55096449059, 15740.92129539345, 15911.283992220378, 15987.0, 16019.679606408039, 16027.599310017344, 13207.66980825487, 13262.0, 13299.401526931311, 13305.733885322239, 13358.198508089547, 15157.0, 15641.261857928985, 15657.60855978587, 15696.529104126894, 15756.76364854528, 6140.2017737694705, 6223.190985171989, 6330.847511845995, 6333.113364129025, 6343.651099189497, 1011.6770186335403, 1039.8284283093355, 1052.952617132231, 1059.750958524746, 1067.9480711499168, 32660.0, 32751.18122046968, 33401.83299083489, 33514.83242583772, 33714.49428258529, 1085.3921803789744, 1108.778244351133, 1124.4995976790412, 1126.3917484558247, 1145.7135716070982, 15412.383504659689, 15632.0, 15665.373385064699, 15809.604759880865, 15810.06031411126, 423486.0, 570016.0, 575339.0, 579259.0, 580626.0, 57574.7121264391, 58524.122138167964, 58644.0, 58722.0, 59143.0, 1518.506485392252, 1537.538738378482, 1547.0, 1547.4815936661118, 1553.0448774003905, 30969.535456968613, 32010.35979280448, 32249.838750806095, 32286.677133228368, 32772.508412373354, 50451.49548504468, 51065.23402149045, 51388.486115139865, 51529.0, 51574.48425515697, 310627.0, 313655.0, 315413.0, 316250.0, 316358.0, 34993.82503087468, 35438.64561354354, 35530.644693552735, 35622.0, 35846.82076589705, 46435.767821160676, 46482.30276545787, 46949.0, 47349.28976065293, 48187.0, 40399.3940090893, 40733.38899916445, 40780.0, 40878.182436350515, 41416.585834141275, 39550.60449395469, 39772.80113599414, 39852.60147398489, 40821.38767918543, 41690.58309416867, 35827.462588060676, 36096.63903361038, 36175.63824361828, 36437.0, 39818.20363592654, 35107.64892351044, 35361.0, 35837.64162358447, 35930.64069359273, 36101.81949090238, 27157.86421067882, 27988.44023119567, 28217.71782282233, 28295.0, 28321.291967700974], "unit": "score", "name": "ext.html", "value": 19597.351514484337}, {"lowerIsBetter": false, "replicates": [374.84631301166525, 387.78477944740655, 389.6473691309364, 397.5031210986267, 404.36312807328466, 17530.561735956606, 18443.72334414985, 19298.807011929875, 20271.898640506814, 20410.0, 16684.249208785604, 16817.495475135765, 16953.660926781457, 16964.0, 17220.569485762862, 5107.080725469414, 5125.923111153335, 5329.227262047001, 5340.732963351837, 5361.383440904287, 5170.689758614476, 5275.868103297429, 5285.6300058995885, 5288.391834938992, 5306.92039619406, 5267.499587539178, 5291.206319052154, 5300.363956325246, 5300.522952934235, 5304.840854774363, 5381.67709937405, 5694.402087780806, 5758.856028599298, 5770.249867517238, 5779.07534794433, 5105.846824595268, 5136.717480538568, 5139.922901156486, 5150.4334523202415, 5152.793888244503, 13932.93033534826, 14021.579352619437, 14032.01775875689, 14037.5086871959, 15156.924215378964, 2295.7015587973624, 2416.8549887006834, 2534.3030666566656, 2704.1752265559, 2776.430831679501, 9733.853992190052, 10662.200334974908, 11842.940785296105, 13940.930295348458, 14200.076994995292, 1803.107461806401, 1832.908354582279, 1857.6377606366764, 1892.1012519053477, 1913.885166889991, 66600.6669966652, 67052.0, 67863.3213667867, 68555.31444685589, 68576.6571167146, 10775.976282253174, 10792.568297268179, 10990.395528245863, 11056.723581910355, 11116.666500005012, 13802.930985345009, 14511.201883896276, 14532.854671453362, 14585.562433127023, 14708.41166353334, 7797.493162944391, 7927.801804954922, 8284.0, 8314.043884953187, 8342.708005219789, 7785.416093792988, 7830.6084695764985, 7837.1379148293645, 8006.759797205977, 8034.437589368688, 4934.136526107916, 4974.054929563371, 4977.228529577921, 5044.9495505045215, 5065.949340506548, 2000.1599328282157, 2032.5325175209784, 2060.47457898235, 2099.6955441460905, 2105.063246855135, 916.2257892081313, 962.7929995051097, 978.188103873783, 999.4503023337281, 1018.5976539266948, 15454.0, 17190.054546999785, 17429.302827886742, 17695.823041769676, 18514.0, 978.1343510992681, 1027.8201314769885, 1038.266253869969, 1054.7310435838813, 1111.4720507758911, 10118.949405252926, 10398.324108932895, 10460.110890574235, 10510.947445262726, 10513.84229236562, 477550.0, 477855.0, 483356.0, 491144.0, 492812.0, 76383.64764156357, 79094.60452697815, 79519.20480795234, 79947.20052799398, 80186.59906700546, 1072.5227273863056, 1087.8259478483405, 1089.929154604948, 1090.4057288777476, 1111.7220694826294, 16073.839261607234, 16083.195840208176, 16182.433614823425, 16271.59321016984, 16463.259153338367, 34796.65203347934, 34839.0, 35308.47037294494, 35360.23198839996, 35528.0, 48848.0, 50959.23561146512, 51520.22719659133, 51536.74231628968, 51888.0, 7663.808404789925, 7724.497907635986, 7771.72798952034, 7806.297433231037, 7937.523748575104, 10810.45947702596, 11384.886151138713, 11449.255798373079, 11538.653840384803, 11568.652940411801, 10061.949690251502, 10128.34165779222, 10326.0, 10476.476176191007, 10486.52810623539, 5212.791488340576, 7835.725749598737, 9759.9024009759, 10434.530446130095, 10511.421871797125, 10239.48802559854, 10809.594752682102, 10973.670789876316, 11271.211015228855, 11431.542738290707, 7907.802304942423, 8106.432549721699, 8190.099089100313, 8322.334213262804, 8509.659613615386, 8636.17956294151, 10312.123469505175, 10803.621873234399, 10920.18098642589, 11061.83407248908], "unit": "score", "name": "jquery.html", "value": 8637.870948569256}, {"lowerIsBetter": false, "replicates": [1568.3804897065659, 1624.3259047495287, 1859.6187781504793, 1912.684407072833, 1958.2656503811063, 7157.7852664420025, 7822.608869556514, 7968.6812527498905, 8176.386770992177, 8245.92802935619, 7949.085855126647, 7949.801254968629, 7961.442699011071, 8022.759317220478, 8049.114597394282, 2274.4086537500243, 2306.066043252477, 2307.9307620771406, 2314.2363020203293, 2317.7450480447224, 2271.806896413807, 2286.199830059474, 2297.448612333036, 2312.1560630369877, 2317.2353123469215, 2252.279270633398, 2258.8531745436494, 2260.4348912771807, 2278.8176945844293, 2284.6915666385075, 2292.8509646873067, 2305.204704376996, 2309.595820731374, 2317.281642690763, 2323.604987152188, 2302.9424264393524, 2322.837401381904, 2324.2910912171783, 2328.941776455585, 2334.3580515358244, 8232.423730338878, 8272.007359116944, 8276.586170691442, 8306.210909963544, 8326.45878017927, 4806.687565308243, 4970.751462426864, 5013.197888337885, 5067.746612669352, 5067.822626208065, 3206.3587282543585, 3286.2113092857544, 3315.0220684898013, 3330.150811543041, 3355.899323020313, 1049.6903413492962, 1052.1214785653988, 1071.5178169823532, 1082.0856376361962, 1085.907697845684, 11281.887181128166, 11382.317060976367, 11404.258723182966, 11408.087353011739, 11462.0, 4553.567411095941, 4604.0, 4704.29435584665, 4732.905341893143, 4737.24204127338, 9739.26955478342, 9788.168005719594, 9796.412215267106, 9822.361546499455, 9825.213982881352, 5107.923381149286, 5110.156824124052, 5136.255242989746, 5145.639805213674, 5162.6386152968935, 3968.047668559525, 4345.304751239786, 4457.955420445819, 4674.859754207379, 4682.74244916526, 3915.9021024474046, 3937.0944682723134, 3948.7038472114705, 4004.3392840181045, 4008.178323443687, 1237.07219585311, 1275.5854347337151, 1283.1210620724833, 1292.8513220979519, 1295.0351987769172, 1372.7323171981368, 1381.1436909116412, 1387.361813565751, 1392.1577445645441, 1414.816073910385, 7439.665215065335, 7818.257265559762, 7851.214878512217, 7860.764177074582, 7871.134175240719, 512.0578136229356, 522.3131581969698, 528.0969542083081, 531.9122394702842, 534.156033467121, 5743.3395159557185, 5745.908277427276, 5776.480116789509, 5860.208871802337, 5865.35481097079, 9529.714108576754, 9947.751306217402, 10047.24645651579, 10065.345752526062, 10077.848832267522, 9803.068708472683, 9832.0, 9849.50752462374, 9913.80172396548, 9974.900250997542, 7160.10498687664, 7234.421246300283, 7252.673629686677, 7286.417086633057, 7353.374963128087, 7586.127595326608, 7716.691332346643, 7730.0, 7741.109772376249, 7852.528848269122, 8619.741407757778, 8692.826143477221, 8820.955895220482, 8839.337049721167, 8927.910720892707, 8943.463392196489, 8996.59515321799, 9007.504587247764, 9070.410423322463, 9155.267578593563, 6309.305976342691, 6720.966395167993, 6861.348171923659, 7118.252583478868, 7209.747658831916, 7529.623518823927, 7808.375329973474, 7809.609519524115, 7811.687532498864, 7893.644785984759, 6679.098321726505, 6699.229588597374, 6743.5953842769595, 6827.795166145023, 6971.895421568579, 6640.501962352746, 6652.135222421054, 6726.764563240459, 6740.764073257608, 6744.831379215559, 7303.30618591233, 7408.740694075682, 7447.925520744723, 7478.4765066444825, 7514.8497030058, 6568.948968165262, 6609.603423794588, 6610.140681711347, 6635.469162466895, 6652.035454858921, 6740.730370785113, 6806.863862722619, 6813.931860681329, 6845.0759147514445, 6845.897311540231], "unit": "score", "name": "mootools.html", "value": 4601.69009466893}, {"lowerIsBetter": false, "replicates": [347.94085005549056, 349.25608453992993, 351.9736019798514, 357.11613755954033, 359.90822340303237, 6388.520860935431, 6450.548461607689, 6460.515461340401, 6461.353864613537, 6486.57837240579, 6346.619202847821, 6352.015437607179, 6360.522960777948, 6364.904526432096, 6370.713317900706, 4662.953370466303, 4700.341952126705, 4817.735024573647, 4821.90356192876, 4833.685810422329, 4774.092922344744, 4777.307290442884, 4787.186178349689, 4789.952100478986, 4821.156297647897, 4797.0405918816205, 4812.398450193726, 4823.20417131173, 4830.661853670244, 4833.32333473314, 4802.471728109923, 4805.759712014403, 4831.178699621073, 4842.2252439609665, 4862.319275301461, 4190.455240818705, 4196.874093777192, 4216.57834216579, 4238.7032907696475, 4251.638610718092, 5888.617239879437, 6035.336113027563, 6090.116933044728, 6120.693965301717, 6139.140520327158, 5601.215829783833, 5614.2701448811395, 5619.213310136543, 5624.5781566382275, 5625.184348269478, 6784.050232967388, 6806.863862722767, 6807.863842723167, 6808.5914845109455, 6837.829054273683, 4561.954380456219, 4569.794359253841, 4569.862904112882, 4588.4723256825555, 4593.058423023273, 7065.540739851893, 7076.610786406797, 7139.178994415604, 7144.249853765332, 7151.4993950423495, 4673.615137953441, 4695.5069717679835, 4726.763661816895, 4731.69243999139, 4736.242201247784, 4767.213409787416, 4794.904101917942, 4797.784099715521, 4800.783964721596, 4803.063402636452, 5527.806526771544, 5576.944230557724, 5577.191307260506, 5579.609427340048, 5589.441055894378, 6784.830379240559, 6800.761973330909, 6811.795646130624, 6823.658817059227, 6827.146606674166, 1673.1717799688988, 1680.15992003998, 1686.7891513560805, 1688.3246701319324, 1688.9493315200564, 1088.2545456362418, 1106.8948449897248, 1132.1791701016862, 1132.7281452451516, 1150.3787954504642, 6481.773137940244, 6495.642739649365, 6540.313267106981, 6541.8691626168165, 6602.471802255808, 6866.519343645997, 7011.193712723, 7020.297970202939, 7034.92965070353, 7044.823879402953, 6598.10925525048, 6643.2360278568585, 6669.09967154428, 6676.098726671934, 6686.364795344434, 3761.7931013793955, 3823.4647149399107, 3825.2349530094093, 3836.865709700147, 3845.942310865339, 7293.270672932665, 7303.817404564822, 7329.047223860971, 7358.96320518394, 7384.076990376203, 7026.613536255555, 7219.60292183935, 7261.89107163393, 7316.378107860785, 7321.524100933422, 7313.085864266966, 7331.413486921034, 7331.963340183372, 7339.678857805539, 7340.743073992491, 7070.575765454089, 7091.751788687371, 7097.077379940574, 7105.076340075757, 7111.9288807113335, 6901.482388820959, 6948.062011628567, 6980.267071957372, 6981.581105133709, 6989.475789315923, 7197.604131772593, 7314.817129571803, 7319.268073192851, 7333.486655934247, 7377.852442951218, 4781.330613714013, 4785.521447855187, 4810.254410566367, 4817.759112044454, 4825.5898248649255, 7058.188308344606, 7073.71705131789, 7110.182329032227, 7110.5022648414115, 7119.430445564239, 6858.8285292866085, 6859.588424694335, 6872.10662613857, 6874.106366172366, 6896.2069362022, 6699.0621313015245, 6853.760118395832, 6874.65626718652, 6895.207051189177, 6896.620685862325, 6741.59550426976, 6792.049113124265, 6794.320567943364, 6806.489513286424, 6811.421029212573, 6958.478114141359, 6962.408195303456, 6996.370326670624, 6997.615131167835, 6998.40513556333, 6689.230738464944, 6733.360330768569, 6749.0, 6751.459883209233, 6752.493562982698], "unit": "score", "name": "prototype.html", "value": 5115.650468817819}, {"lowerIsBetter": false, "replicates": [847.4533925617975, 865.7056600755742, 891.0510306523552, 897.4480694372959, 909.1999040844056, 14307.284635768223, 14357.712845743079, 14377.928110359446, 14482.855171448282, 14496.057756245837, 14023.0, 14044.508442204526, 14095.365708543115, 14106.506272280472, 14131.152130872155, 757.4924800383742, 913.118840319092, 928.2342067794096, 936.9531523423801, 937.3391758810022, 914.3462424366577, 917.5779141594875, 921.3182245138617, 921.6451666108529, 923.8845144356956, 990.0742805476866, 994.0953732103787, 996.3822430093352, 997.7206382212992, 998.1465846701075, 986.7089208683456, 987.782687808681, 987.8221920054388, 988.4217732626422, 989.990100098997, 721.6319676964733, 729.9598522081284, 731.3929438566031, 734.071399679406, 735.5807189901758, 14033.087849289866, 14105.294735263196, 14142.151470911778, 14150.787738183935, 14192.929035354757, 12808.551700690525, 13292.3353832308, 13510.662233444144, 13671.589852304447, 13675.794863077062, 11051.226414151013, 11072.889271107266, 11161.72095697606, 11233.0, 11248.887511124865, 3910.2179564087296, 3925.234579257046, 3932.528096628423, 3956.3669812829808, 3994.1013272013856, 51915.74042129803, 51972.960540789354, 53542.732286338316, 54213.45786542163, 54596.908061838934, 11355.93725474612, 11414.600488982845, 11427.542898283975, 11478.540858365572, 11494.827577586342, 19730.013499324978, 19733.703994440093, 19752.40742777719, 19826.90086549558, 19844.702329465068, 8144.714934977247, 8371.744238364294, 8474.830503389898, 8502.787430314167, 8575.871361929576, 4656.697314674535, 4683.180443422388, 4724.71651700899, 4798.976005119952, 4856.39295088114, 3239.368323176958, 3283.5238890361243, 3290.4899740540254, 3302.8348582570775, 3323.7839540429795, 595.330253464852, 617.2253821454046, 620.6803496199461, 629.222909706512, 629.6127881353027, 630.5964182922933, 712.6614857942436, 721.1346384338815, 732.4945787406672, 735.6027745017738, 8615.78460538479, 8887.688930887389, 8931.598078086501, 9030.322725795591, 9166.312526560534, 600.2077258019373, 695.4471195399669, 706.9399101076364, 711.1643818513227, 740.333699670301, 4072.205919845661, 4235.682323825726, 4251.29853574163, 4264.232438161099, 4279.079997800488, 60419.0, 66717.66641166763, 66777.99833002509, 68098.0, 68160.65919670468, 51517.484825152016, 51716.22425663618, 52683.0, 53146.0, 53506.0, 47613.047739045025, 48231.75884120557, 48640.02719945652, 48728.269075963886, 49284.50715492799, 8856.734297971072, 8882.733517994471, 8909.73270801877, 9244.075592440702, 9278.582463789011, 35132.47301290432, 35840.4623930636, 36078.09804754902, 36894.0, 37309.81345093257, 44980.77509612562, 46668.53331466642, 47124.29313560231, 47291.763541182074, 47652.0, 12266.202696824677, 12291.877081229431, 12462.875371246171, 12481.438335274754, 12672.0, 13196.406161722938, 13325.0, 13422.127561708458, 13755.862441375459, 13903.721925561635, 11275.943620281847, 11747.339751395533, 12100.394980250776, 12348.506059757508, 12430.813537797121, 12035.217710848767, 12297.077719171277, 12401.193922395016, 12450.81323780126, 12797.680057998625, 10928.344299342065, 11956.282623042645, 12030.458629361525, 12415.875841241472, 12848.935755321163, 10499.990075623795, 10604.946975265382, 10640.308379955588, 10880.347179168959, 10988.780224395627, 10508.0, 10736.785264294827, 10813.459327033774, 10865.348079115278, 10942.890571094187], "unit": "score", "name": "yui.html", "value": 6880.380613261796}], "name": "dromaeo_css", "value": 7271.660631243489}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 122.0, 112.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 148.0, 170.0, 128.0, 150.0, 154.0, 128.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 161.0, 161.0, 161.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 75.0, 162.0, 72.0, 74.0, 72.0, 73.0, 162.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 138.0, 93.0, 94.0, 93.0, 141.0, 93.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 55.0, 55.0, 59.0, 56.0, 56.0, 62.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.0}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 79.0, 78.0, 78.0, 80.0, 78.0, 78.0, 79.0, 76.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.2}, {"lowerIsBetter": true, "replicates": [112.0, 109.0, 111.0, 110.0, 115.0, 111.0, 113.0, 111.0, 112.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.0}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 146.0, 143.0, 135.0, 143.0, 146.0, 148.0, 144.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 70.0, 70.0, 66.0, 67.0, 67.0, 70.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1501.9999999999998}]} 03:45:24 INFO - Return code: 0 03:45:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:45:24 ERROR - # TBPL SUCCESS # 03:45:24 INFO - Running post-action listener: _resource_record_post_action 03:45:24 INFO - Running post-run listener: _resource_record_post_run 03:45:25 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 266240; Write bytes: 499023872; Read time: 24; Write time: 437120 03:45:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244768768; Read time: 0; Write time: 294152 03:45:25 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254255104; Read time: 24; Write time: 142968 03:45:25 INFO - Running post-run listener: _upload_blobber_files 03:45:25 INFO - Blob upload gear active. 03:45:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 03:45:25 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:45:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 03:45:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 03:45:25 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:26 INFO - (blobuploader) - INFO - Done attempting. 03:45:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:27 INFO - (blobuploader) - INFO - Done attempting. 03:45:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:27 INFO - Return code: 0 03:45:27 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 03:45:27 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c20b982e0cd45bdff269114235321dce79db2f94479ff0c74a935e1e704d232cc60fe9b1897e1f341679d416f501bf26a38f76f90602bd9749e5f8a87d1e5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38bc254b3fab8801c41e2b40625478bf03cc71f328ffa1d1335433c7fe209b3b132778f74ec20585ed130a3fd2b2dadaaef8e083565eb815cd64d6f234c27d7e"} 03:45:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 03:45:27 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 03:45:27 INFO - Contents: 03:45:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c20b982e0cd45bdff269114235321dce79db2f94479ff0c74a935e1e704d232cc60fe9b1897e1f341679d416f501bf26a38f76f90602bd9749e5f8a87d1e5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38bc254b3fab8801c41e2b40625478bf03cc71f328ffa1d1335433c7fe209b3b132778f74ec20585ed130a3fd2b2dadaaef8e083565eb815cd64d6f234c27d7e"} 03:45:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:27 INFO - Copying logs to upload dir... 03:45:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 03:45:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.589742 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-03-20 03:45:27.247773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-20 03:45:27.251426) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c20b982e0cd45bdff269114235321dce79db2f94479ff0c74a935e1e704d232cc60fe9b1897e1f341679d416f501bf26a38f76f90602bd9749e5f8a87d1e5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38bc254b3fab8801c41e2b40625478bf03cc71f328ffa1d1335433c7fe209b3b132778f74ec20585ed130a3fd2b2dadaaef8e083565eb815cd64d6f234c27d7e"} build_url:https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/XrbCR-vTQqqKptNOs26hrw/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c20b982e0cd45bdff269114235321dce79db2f94479ff0c74a935e1e704d232cc60fe9b1897e1f341679d416f501bf26a38f76f90602bd9749e5f8a87d1e5fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/38bc254b3fab8801c41e2b40625478bf03cc71f328ffa1d1335433c7fe209b3b132778f74ec20585ed130a3fd2b2dadaaef8e083565eb815cd64d6f234c27d7e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-20 03:45:27.276172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:45:27.276490) ========= 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=03627c79f6bb3d1578c4a402000001ba-1458468143.237388-403018896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-20 03:45:27.359816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-20 03:45:27.360170) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-20 03:45:27.360465) ========= ========= Total master_lag: 0.28 =========