builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1454825792.62 results: success (0) buildid: 20160206193305 builduid: 9b65eaa64e9c4e1c86b339519887f171 revision: 76733110704b975154ac0fa779445e6eae5da559 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.620644) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.621143) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.621457) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006392 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.657585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.657852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.689570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.690080) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.741903) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.742160) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.742506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.742770) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 22:16:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.6M=0s 2016-02-06 22:16:34 (39.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.935257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.935543) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015058 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:32.986745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 22:16:32.987053) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 76733110704b975154ac0fa779445e6eae5da559 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 76733110704b975154ac0fa779445e6eae5da559 --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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 22:16:34,199 truncating revision to first 12 chars 2016-02-06 22:16:34,199 Setting DEBUG logging. 2016-02-06 22:16:34,200 attempt 1/10 2016-02-06 22:16:34,200 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/76733110704b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 22:16:34,961 unpacking tar archive at: mozilla-central-76733110704b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.031092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 22:16:34.030842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:34.031163) ========= echo 76733110704b975154ac0fa779445e6eae5da559 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'76733110704b975154ac0fa779445e6eae5da559'] 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76733110704b975154ac0fa779445e6eae5da559 program finished with exit code 0 elapsedTime=0.004398 script_repo_revision: '76733110704b975154ac0fa779445e6eae5da559' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:34.081013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:34.081282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:34.091737) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-06 22:16:34.092006) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:16:35 INFO - MultiFileLogger online at 20160206 22:16:35 in /builds/slave/test-pgo 22:16:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:16:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:16:35 INFO - {'append_to_log': False, 22:16:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:16:35 INFO - 'blob_upload_branch': 'Firefox', 22:16:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:16:35 INFO - 'branch': 'Firefox', 22:16:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:35 INFO - 'config_files': ('talos/linux_config.py',), 22:16:35 INFO - 'default_actions': ('clobber', 22:16:35 INFO - 'read-buildbot-config', 22:16:35 INFO - 'download-and-extract', 22:16:35 INFO - 'populate-webroot', 22:16:35 INFO - 'create-virtualenv', 22:16:35 INFO - 'install', 22:16:35 INFO - 'run-tests'), 22:16:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:35 INFO - 'download_minidump_stackwalk': True, 22:16:35 INFO - 'download_symbols': 'ondemand', 22:16:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:35 INFO - 'installer_path': 'installer.exe', 22:16:35 INFO - 'log_level': 'info', 22:16:35 INFO - 'log_name': 'talos', 22:16:35 INFO - 'log_to_console': True, 22:16:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:16:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:16:35 INFO - 'opt_config_files': (), 22:16:35 INFO - 'pip_index': False, 22:16:35 INFO - 'sps_profile': False, 22:16:35 INFO - 'sps_profile_interval': 0, 22:16:35 INFO - 'suite': 'dromaeojs', 22:16:35 INFO - 'system_bits': '32', 22:16:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:35 INFO - 'title': 'talos-linux64-ix-061', 22:16:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:35 INFO - 'use_talos_json': True, 22:16:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:16:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:35 INFO - 'work_dir': 'build'} 22:16:35 INFO - ##### 22:16:35 INFO - ##### Running clobber step. 22:16:35 INFO - ##### 22:16:35 INFO - Running pre-action listener: _resource_record_pre_action 22:16:35 INFO - Running main action method: clobber 22:16:35 INFO - rmtree: /builds/slave/test-pgo/build 22:16:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:16:35 INFO - Running post-action listener: _resource_record_post_action 22:16:35 INFO - ##### 22:16:35 INFO - ##### Running read-buildbot-config step. 22:16:35 INFO - ##### 22:16:35 INFO - Running pre-action listener: _resource_record_pre_action 22:16:35 INFO - Running main action method: read_buildbot_config 22:16:35 INFO - Using buildbot properties: 22:16:35 INFO - { 22:16:35 INFO - "project": "", 22:16:35 INFO - "product": "firefox", 22:16:35 INFO - "script_repo_revision": "production", 22:16:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 22:16:35 INFO - "repository": "", 22:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 22:16:35 INFO - "buildid": "20160206193305", 22:16:35 INFO - "pgo_build": "True", 22:16:35 INFO - "basedir": "/builds/slave/test-pgo", 22:16:35 INFO - "buildnumber": 662, 22:16:35 INFO - "slavename": "talos-linux64-ix-061", 22:16:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:16:35 INFO - "platform": "ubuntu64_hw", 22:16:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:16:35 INFO - "branch": "mozilla-central", 22:16:35 INFO - "repo_path": "mozilla-central", 22:16:35 INFO - "revision": "76733110704b975154ac0fa779445e6eae5da559", 22:16:35 INFO - "stage_platform": "linux64-pgo", 22:16:35 INFO - "builduid": "9b65eaa64e9c4e1c86b339519887f171", 22:16:35 INFO - "slavebuilddir": "test" 22:16:35 INFO - } 22:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:16:35 INFO - Running post-action listener: _resource_record_post_action 22:16:35 INFO - ##### 22:16:35 INFO - ##### Running download-and-extract step. 22:16:35 INFO - ##### 22:16:35 INFO - Running pre-action listener: _resource_record_pre_action 22:16:35 INFO - Running main action method: download_and_extract 22:16:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:35 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json 22:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json 22:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:16:38 INFO - Downloaded 1448 bytes. 22:16:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:16:38 INFO - Using the following test package requirements: 22:16:38 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:16:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:16:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'jsshell-linux-x86_64.zip'], 22:16:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:16:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:16:38 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:16:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:16:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:38 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:16:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:38 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:41 INFO - Downloaded 23575457 bytes. 22:16:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:16:42 INFO - Return code: 0 22:16:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:42 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:16:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:16:43 INFO - Downloaded 23575457 bytes. 22:16:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:16:45 INFO - Return code: 0 22:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:45 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:16:46 INFO - Downloaded 10706547 bytes. 22:16:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:16:46 INFO - Return code: 0 22:16:46 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')]} 22:16:46 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:16:48 INFO - Downloaded 56564873 bytes. 22:16:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:16:48 INFO - mkdir: /builds/slave/test-pgo/properties 22:16:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:16:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:16:48 INFO - Contents: 22:16:48 INFO - build_url:https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:16:48 INFO - Running post-action listener: _resource_record_post_action 22:16:48 INFO - Running post-action listener: set_extra_try_arguments 22:16:48 INFO - ##### 22:16:48 INFO - ##### Running populate-webroot step. 22:16:48 INFO - ##### 22:16:48 INFO - Running pre-action listener: _resource_record_pre_action 22:16:48 INFO - Running main action method: populate_webroot 22:16:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:16:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:16:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:16:48 INFO - '--tppagecycles', 22:16:48 INFO - '7'], 22:16:48 INFO - 'tests': ['tsvgm']}}, 22:16:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:16:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:16:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:16:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:16:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'tests': ['damp', 'tps']}, 22:16:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['damp', 'tps']}, 22:16:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:16:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:16:48 INFO - 'other': {'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'other_l64': {'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'other_nol64': {'tests': ['a11yr', 22:16:48 INFO - 'ts_paint', 22:16:48 INFO - 'tpaint', 22:16:48 INFO - 'sessionrestore', 22:16:48 INFO - 'sessionrestore_no_auto_restore']}, 22:16:48 INFO - 'svgr': {'tests': ['tsvgx', 22:16:48 INFO - 'tsvgr_opacity', 22:16:48 INFO - 'tart', 22:16:48 INFO - 'tscrollx', 22:16:48 INFO - 'cart']}, 22:16:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['tsvgx', 22:16:48 INFO - 'tsvgr_opacity', 22:16:48 INFO - 'tart', 22:16:48 INFO - 'tscrollx', 22:16:48 INFO - 'cart']}, 22:16:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'tests': ['tp5o']}, 22:16:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'talos_options': ['--e10s'], 22:16:48 INFO - 'tests': ['tp5o']}, 22:16:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'talos_options': ['--xperf_path', 22:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:48 INFO - 'tests': ['tp5n']}, 22:16:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:48 INFO - 'talos_options': ['--e10s', 22:16:48 INFO - '--xperf_path', 22:16:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:48 INFO - 'tests': ['tp5n']}}, 22:16:48 INFO - 'talos.zip': {'path': '', 22:16:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:16:48 INFO - Running post-action listener: _resource_record_post_action 22:16:48 INFO - ##### 22:16:48 INFO - ##### Running create-virtualenv step. 22:16:48 INFO - ##### 22:16:48 INFO - Running pre-action listener: _resource_record_pre_action 22:16:48 INFO - Running main action method: create_virtualenv 22:16:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:16:48 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 22:16:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:16:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:16:48 INFO - Using real prefix '/usr' 22:16:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:16:49 INFO - Installing distribute.............................................................................................................................................................................................done. 22:16:51 INFO - Installing pip.................done. 22:16:51 INFO - Return code: 0 22:16:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:16:51 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')]} 22:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:51 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')]} 22:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:16:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:16:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:16:51 INFO - Using env: {'DISPLAY': ':0', 22:16:51 INFO - 'HOME': '/home/cltbld', 22:16:51 INFO - 'LANG': 'en_US.UTF-8', 22:16:51 INFO - 'LANGUAGE': 'en_US:en', 22:16:51 INFO - 'LOGNAME': 'cltbld', 22:16:51 INFO - 'MAIL': '/var/mail/cltbld', 22:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:51 INFO - 'MOZ_NO_REMOTE': '1', 22:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:51 INFO - 'NO_EM_RESTART': '1', 22:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:51 INFO - 'SHELL': '/bin/bash', 22:16:51 INFO - 'SHLVL': '1', 22:16:51 INFO - 'TERM': 'linux', 22:16:51 INFO - 'TMOUT': '86400', 22:16:51 INFO - 'USER': 'cltbld', 22:16:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:51 INFO - '_': '/tools/buildbot/bin/python'} 22:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:51 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 22:16:51 INFO - Cleaning up... 22:16:51 INFO - Return code: 0 22:16:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:16:51 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')]} 22:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:51 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')]} 22:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:16:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:16:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:16:51 INFO - Using env: {'DISPLAY': ':0', 22:16:51 INFO - 'HOME': '/home/cltbld', 22:16:51 INFO - 'LANG': 'en_US.UTF-8', 22:16:51 INFO - 'LANGUAGE': 'en_US:en', 22:16:51 INFO - 'LOGNAME': 'cltbld', 22:16:51 INFO - 'MAIL': '/var/mail/cltbld', 22:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:51 INFO - 'MOZ_NO_REMOTE': '1', 22:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:51 INFO - 'NO_EM_RESTART': '1', 22:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:51 INFO - 'SHELL': '/bin/bash', 22:16:51 INFO - 'SHLVL': '1', 22:16:51 INFO - 'TERM': 'linux', 22:16:51 INFO - 'TMOUT': '86400', 22:16:51 INFO - 'USER': 'cltbld', 22:16:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:51 INFO - '_': '/tools/buildbot/bin/python'} 22:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:51 INFO - Downloading/unpacking psutil>=0.7.1 22:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:53 INFO - Installing collected packages: psutil 22:16:53 INFO - Running setup.py install for psutil 22:16:53 INFO - building 'psutil._psutil_linux' extension 22:16:53 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 22:16:53 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 22:16:53 INFO - building 'psutil._psutil_posix' extension 22:16:53 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 22:16:54 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 22:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:54 INFO - Successfully installed psutil 22:16:54 INFO - Cleaning up... 22:16:54 INFO - Return code: 0 22:16:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:16:54 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')]} 22:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 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')]} 22:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:54 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:16:54 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 22:16:54 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 22:16:54 INFO - Using env: {'DISPLAY': ':0', 22:16:54 INFO - 'HOME': '/home/cltbld', 22:16:54 INFO - 'LANG': 'en_US.UTF-8', 22:16:54 INFO - 'LANGUAGE': 'en_US:en', 22:16:54 INFO - 'LOGNAME': 'cltbld', 22:16:54 INFO - 'MAIL': '/var/mail/cltbld', 22:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:54 INFO - 'MOZ_NO_REMOTE': '1', 22:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:54 INFO - 'NO_EM_RESTART': '1', 22:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:54 INFO - 'SHELL': '/bin/bash', 22:16:54 INFO - 'SHLVL': '1', 22:16:54 INFO - 'TERM': 'linux', 22:16:54 INFO - 'TMOUT': '86400', 22:16:54 INFO - 'USER': 'cltbld', 22:16:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:54 INFO - '_': '/tools/buildbot/bin/python'} 22:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:16:54 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 22:16:54 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 22:16:54 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 22:16:54 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 22:16:54 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 22:16:54 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 22:16:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:16:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:16:56 INFO - Installing collected packages: mozsystemmonitor 22:16:56 INFO - Running setup.py install for mozsystemmonitor 22:16:56 INFO - Successfully installed mozsystemmonitor 22:16:56 INFO - Cleaning up... 22:16:56 INFO - Return code: 0 22:16:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:16:56 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')]} 22:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:56 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')]} 22:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:56 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:16:56 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 22:16:56 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 22:16:56 INFO - Using env: {'DISPLAY': ':0', 22:16:56 INFO - 'HOME': '/home/cltbld', 22:16:56 INFO - 'LANG': 'en_US.UTF-8', 22:16:56 INFO - 'LANGUAGE': 'en_US:en', 22:16:56 INFO - 'LOGNAME': 'cltbld', 22:16:56 INFO - 'MAIL': '/var/mail/cltbld', 22:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:56 INFO - 'MOZ_NO_REMOTE': '1', 22:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:56 INFO - 'NO_EM_RESTART': '1', 22:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:56 INFO - 'SHELL': '/bin/bash', 22:16:56 INFO - 'SHLVL': '1', 22:16:56 INFO - 'TERM': 'linux', 22:16:56 INFO - 'TMOUT': '86400', 22:16:56 INFO - 'USER': 'cltbld', 22:16:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:56 INFO - '_': '/tools/buildbot/bin/python'} 22:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:16:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:16:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:16:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:59 INFO - Downloading docopt-0.6.1.tar.gz 22:16:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:16:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:16:59 INFO - Running setup.py install for blobuploader 22:16:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:16:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:16:59 INFO - Running setup.py install for requests 22:16:59 INFO - Running setup.py install for docopt 22:16:59 INFO - Successfully installed blobuploader requests docopt 22:16:59 INFO - Cleaning up... 22:16:59 INFO - Return code: 0 22:16:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:16: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')]} 22:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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')]} 22:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:59 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:16:59 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 22:16:59 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 22:16:59 INFO - Using env: {'DISPLAY': ':0', 22:16:59 INFO - 'HOME': '/home/cltbld', 22:16:59 INFO - 'LANG': 'en_US.UTF-8', 22:16:59 INFO - 'LANGUAGE': 'en_US:en', 22:16:59 INFO - 'LOGNAME': 'cltbld', 22:16:59 INFO - 'MAIL': '/var/mail/cltbld', 22:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:59 INFO - 'MOZ_NO_REMOTE': '1', 22:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:59 INFO - 'NO_EM_RESTART': '1', 22:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:59 INFO - 'SHELL': '/bin/bash', 22:16:59 INFO - 'SHLVL': '1', 22:16:59 INFO - 'TERM': 'linux', 22:16:59 INFO - 'TMOUT': '86400', 22:16:59 INFO - 'USER': 'cltbld', 22:16:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:59 INFO - '_': '/tools/buildbot/bin/python'} 22:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:16:59 INFO - Running setup.py (path:/tmp/pip-WICaMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:17:00 INFO - Running setup.py (path:/tmp/pip-SpNhss-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:17:00 INFO - Running setup.py (path:/tmp/pip-ZjH2SX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:17:00 INFO - Running setup.py (path:/tmp/pip-B9FMck-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:17:00 INFO - Running setup.py (path:/tmp/pip-jihS62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:17:00 INFO - Running setup.py (path:/tmp/pip-_60gP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:17:00 INFO - Running setup.py (path:/tmp/pip-dfCXJm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:17:00 INFO - Running setup.py (path:/tmp/pip-SuTvM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:17:00 INFO - Running setup.py (path:/tmp/pip-fozFsy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:17:00 INFO - Running setup.py (path:/tmp/pip-QqpVgt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:17:00 INFO - Running setup.py (path:/tmp/pip-i2wwwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:17:00 INFO - Running setup.py (path:/tmp/pip-KciU8R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:17:00 INFO - Running setup.py (path:/tmp/pip-ViH1oQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:17:00 INFO - Running setup.py (path:/tmp/pip-wxB3dN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:17:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:17:00 INFO - Running setup.py (path:/tmp/pip-ttAPc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:17:01 INFO - Running setup.py (path:/tmp/pip-A5zoir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:17:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:17:01 INFO - Running setup.py (path:/tmp/pip-yUzk7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:17:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:17:01 INFO - Running setup.py install for manifestparser 22:17:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Running setup.py install for mozcrash 22:17:01 INFO - Running setup.py install for mozdebug 22:17:01 INFO - Running setup.py install for mozdevice 22:17:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Running setup.py install for mozfile 22:17:01 INFO - Running setup.py install for mozhttpd 22:17:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Running setup.py install for mozinfo 22:17:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Running setup.py install for mozInstall 22:17:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:17:01 INFO - Running setup.py install for mozleak 22:17:02 INFO - Running setup.py install for mozlog 22:17:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Running setup.py install for moznetwork 22:17:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Running setup.py install for mozprocess 22:17:02 INFO - Running setup.py install for mozprofile 22:17:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Running setup.py install for mozrunner 22:17:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Running setup.py install for mozscreenshot 22:17:02 INFO - Running setup.py install for moztest 22:17:02 INFO - Running setup.py install for mozversion 22:17:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:17:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:17:02 INFO - Cleaning up... 22:17:02 INFO - Return code: 0 22:17:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:17: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')]} 22:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:02 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:17:02 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 22:17:02 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 22:17:02 INFO - Using env: {'DISPLAY': ':0', 22:17:02 INFO - 'HOME': '/home/cltbld', 22:17:02 INFO - 'LANG': 'en_US.UTF-8', 22:17:02 INFO - 'LANGUAGE': 'en_US:en', 22:17:02 INFO - 'LOGNAME': 'cltbld', 22:17:02 INFO - 'MAIL': '/var/mail/cltbld', 22:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:02 INFO - 'MOZ_NO_REMOTE': '1', 22:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:02 INFO - 'NO_EM_RESTART': '1', 22:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:02 INFO - 'SHELL': '/bin/bash', 22:17:02 INFO - 'SHLVL': '1', 22:17:02 INFO - 'TERM': 'linux', 22:17:02 INFO - 'TMOUT': '86400', 22:17:02 INFO - 'USER': 'cltbld', 22:17:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:02 INFO - '_': '/tools/buildbot/bin/python'} 22:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:17:03 INFO - Running setup.py (path:/tmp/pip-OzTAGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:17:03 INFO - Running setup.py (path:/tmp/pip-HLfUrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:17:03 INFO - Running setup.py (path:/tmp/pip-TO3Vvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:17:03 INFO - Running setup.py (path:/tmp/pip-Cb_nLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:17:03 INFO - Running setup.py (path:/tmp/pip-8fEpNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:17:03 INFO - Running setup.py (path:/tmp/pip-lE_Hqj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:17:03 INFO - Running setup.py (path:/tmp/pip-xvCPu3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:17:03 INFO - Running setup.py (path:/tmp/pip-tVzYD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:17:03 INFO - Running setup.py (path:/tmp/pip-a7iVcN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:17:03 INFO - Running setup.py (path:/tmp/pip-2PPhAJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:17:03 INFO - Running setup.py (path:/tmp/pip-kVerC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:17:03 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)) 22:17:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:17:03 INFO - Running setup.py (path:/tmp/pip-IvyFMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:17:04 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)) 22:17:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:17:04 INFO - Running setup.py (path:/tmp/pip-IfroU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:17:04 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)) 22:17:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:17:04 INFO - Running setup.py (path:/tmp/pip-NGl4fW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:17:04 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)) 22:17:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:17:04 INFO - Running setup.py (path:/tmp/pip-onGHp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:17:04 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)) 22:17:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:17:04 INFO - Running setup.py (path:/tmp/pip-QiX0ue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:17:04 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)) 22:17:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:17:04 INFO - Running setup.py (path:/tmp/pip-gcx1X4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:17:04 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)) 22:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:17:04 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)) 22:17:04 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)) 22:17:04 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)) 22:17:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:17:04 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 22:17:04 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 22:17:04 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 22:17:04 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 22:17:04 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 22:17:04 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 22:17:06 INFO - Downloading blessings-1.6.tar.gz 22:17:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:17:06 INFO - Installing collected packages: blessings 22:17:06 INFO - Running setup.py install for blessings 22:17:06 INFO - Successfully installed blessings 22:17:06 INFO - Cleaning up... 22:17:06 INFO - Return code: 0 22:17:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:17:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:17:06 INFO - Reading from file tmpfile_stdout 22:17:06 INFO - Current package versions: 22:17:06 INFO - argparse == 1.2.1 22:17:06 INFO - blessings == 1.6 22:17:06 INFO - blobuploader == 1.2.4 22:17:06 INFO - docopt == 0.6.1 22:17:06 INFO - manifestparser == 1.1 22:17:06 INFO - mozInstall == 1.12 22:17:06 INFO - mozcrash == 0.16 22:17:06 INFO - mozdebug == 0.1 22:17:06 INFO - mozdevice == 0.48 22:17:06 INFO - mozfile == 1.2 22:17:06 INFO - mozhttpd == 0.7 22:17:06 INFO - mozinfo == 0.9 22:17:06 INFO - mozleak == 0.1 22:17:06 INFO - mozlog == 3.1 22:17:06 INFO - moznetwork == 0.27 22:17:06 INFO - mozprocess == 0.22 22:17:06 INFO - mozprofile == 0.28 22:17:06 INFO - mozrunner == 6.11 22:17:06 INFO - mozscreenshot == 0.1 22:17:06 INFO - mozsystemmonitor == 0.0 22:17:06 INFO - moztest == 0.7 22:17:06 INFO - mozversion == 1.4 22:17:06 INFO - psutil == 3.1.1 22:17:06 INFO - requests == 1.2.3 22:17:06 INFO - wsgiref == 0.1.2 22:17:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:17: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')]} 22:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:06 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:17:06 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 22:17:06 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 22:17:06 INFO - Using env: {'DISPLAY': ':0', 22:17:06 INFO - 'HOME': '/home/cltbld', 22:17:06 INFO - 'LANG': 'en_US.UTF-8', 22:17:06 INFO - 'LANGUAGE': 'en_US:en', 22:17:06 INFO - 'LOGNAME': 'cltbld', 22:17:06 INFO - 'MAIL': '/var/mail/cltbld', 22:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:06 INFO - 'MOZ_NO_REMOTE': '1', 22:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:06 INFO - 'NO_EM_RESTART': '1', 22:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:06 INFO - 'SHELL': '/bin/bash', 22:17:06 INFO - 'SHLVL': '1', 22:17:06 INFO - 'TERM': 'linux', 22:17:06 INFO - 'TMOUT': '86400', 22:17:06 INFO - 'USER': 'cltbld', 22:17:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:06 INFO - '_': '/tools/buildbot/bin/python'} 22:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 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)) 22:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:17:06 INFO - Cleaning up... 22:17:06 INFO - Return code: 0 22:17:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:17: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')]} 22:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:06 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:17:06 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 22:17:06 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 22:17:06 INFO - Using env: {'DISPLAY': ':0', 22:17:06 INFO - 'HOME': '/home/cltbld', 22:17:06 INFO - 'LANG': 'en_US.UTF-8', 22:17:06 INFO - 'LANGUAGE': 'en_US:en', 22:17:06 INFO - 'LOGNAME': 'cltbld', 22:17:06 INFO - 'MAIL': '/var/mail/cltbld', 22:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:06 INFO - 'MOZ_NO_REMOTE': '1', 22:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:06 INFO - 'NO_EM_RESTART': '1', 22:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:06 INFO - 'SHELL': '/bin/bash', 22:17:06 INFO - 'SHLVL': '1', 22:17:06 INFO - 'TERM': 'linux', 22:17:06 INFO - 'TMOUT': '86400', 22:17:06 INFO - 'USER': 'cltbld', 22:17:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:06 INFO - '_': '/tools/buildbot/bin/python'} 22:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:07 INFO - Downloading/unpacking jsonschema 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:07 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 22:17:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:17:08 INFO - Downloading/unpacking functools32 (from jsonschema) 22:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:17:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:17:09 INFO - warning: no files found matching '*.txt' 22:17:09 INFO - no previously-included directories found matching 'build' 22:17:09 INFO - no previously-included directories found matching 'dist' 22:17:09 INFO - no previously-included directories found matching '.git*' 22:17:09 INFO - Installing collected packages: jsonschema, functools32 22:17:09 INFO - Running setup.py install for functools32 22:17:09 INFO - warning: no files found matching '*.txt' 22:17:09 INFO - no previously-included directories found matching 'build' 22:17:09 INFO - no previously-included directories found matching 'dist' 22:17:09 INFO - no previously-included directories found matching '.git*' 22:17:09 INFO - Successfully installed jsonschema functools32 22:17:09 INFO - Cleaning up... 22:17:09 INFO - Return code: 0 22:17:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:09 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 0x7fb442030f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1678630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, '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': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', '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 22:17:09 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 22:17:09 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 22:17:09 INFO - Using env: {'DISPLAY': ':0', 22:17:09 INFO - 'HOME': '/home/cltbld', 22:17:09 INFO - 'LANG': 'en_US.UTF-8', 22:17:09 INFO - 'LANGUAGE': 'en_US:en', 22:17:09 INFO - 'LOGNAME': 'cltbld', 22:17:09 INFO - 'MAIL': '/var/mail/cltbld', 22:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:09 INFO - 'MOZ_NO_REMOTE': '1', 22:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:09 INFO - 'NO_EM_RESTART': '1', 22:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:09 INFO - 'SHELL': '/bin/bash', 22:17:09 INFO - 'SHLVL': '1', 22:17:09 INFO - 'TERM': 'linux', 22:17:09 INFO - 'TMOUT': '86400', 22:17:09 INFO - 'USER': 'cltbld', 22:17:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:09 INFO - '_': '/tools/buildbot/bin/python'} 22:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:09 INFO - Downloading/unpacking flake8 22:17:09 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 22:17:09 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 22:17:09 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 22:17:09 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 22:17:09 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 22:17:09 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 22:17:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:17:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:17:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:17:12 INFO - no previously-included directories found matching 'docs/_build' 22:17:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:17:12 INFO - Running setup.py install for pep8 22:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:17:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:17:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:17:12 INFO - no previously-included directories found matching 'docs/_build' 22:17:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:17:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:17:12 INFO - Cleaning up... 22:17:12 INFO - Return code: 0 22:17:12 INFO - Running post-action listener: _resource_record_post_action 22:17:12 INFO - Running post-action listener: _start_resource_monitoring 22:17:12 INFO - Starting resource monitoring. 22:17:12 INFO - ##### 22:17:12 INFO - ##### Running install step. 22:17:12 INFO - ##### 22:17:12 INFO - Running pre-action listener: _resource_record_pre_action 22:17:12 INFO - Running main action method: install 22:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:17:12 INFO - Reading from file tmpfile_stdout 22:17:12 INFO - Detecting whether we're running mozinstall >=1.0... 22:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:17:12 INFO - Reading from file tmpfile_stdout 22:17:12 INFO - Output received: 22:17:12 INFO - Usage: mozinstall [options] installer 22:17:12 INFO - Options: 22:17:12 INFO - -h, --help show this help message and exit 22:17:12 INFO - -d DEST, --destination=DEST 22:17:12 INFO - Directory to install application into. [default: 22:17:12 INFO - "/builds/slave/test-pgo"] 22:17:12 INFO - --app=APP Application being installed. [default: firefox] 22:17:12 INFO - mkdir: /builds/slave/test-pgo/build/application 22:17:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:17:28 INFO - Reading from file tmpfile_stdout 22:17:28 INFO - Output received: 22:17:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:17:28 INFO - Running post-action listener: _resource_record_post_action 22:17:28 INFO - ##### 22:17:28 INFO - ##### Running run-tests step. 22:17:28 INFO - ##### 22:17:28 INFO - Running pre-action listener: _resource_record_pre_action 22:17:28 INFO - Running main action method: run_tests 22:17:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:17:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:17:28 INFO - Python 2.7.3 22:17:28 INFO - Return code: 0 22:17:28 INFO - grabbing minidump binary from tooltool 22:17: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')]} 22:17:28 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 0x1709840>, '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 0x16766b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1676b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:17:28 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 22:17:28 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 22:17:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:17:28 INFO - Return code: 0 22:17:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:17:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:17:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:17:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:17:29 INFO - Return code: 0 22:17:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:17:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:17:29 INFO - Using env: {'DISPLAY': ':0', 22:17:29 INFO - 'HOME': '/home/cltbld', 22:17:29 INFO - 'LANG': 'en_US.UTF-8', 22:17:29 INFO - 'LANGUAGE': 'en_US:en', 22:17:29 INFO - 'LOGNAME': 'cltbld', 22:17:29 INFO - 'MAIL': '/var/mail/cltbld', 22:17:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:17:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:29 INFO - 'MOZ_NO_REMOTE': '1', 22:17:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:29 INFO - 'NO_EM_RESTART': '1', 22:17:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:17:29 INFO - 'SHELL': '/bin/bash', 22:17:29 INFO - 'SHLVL': '1', 22:17:29 INFO - 'TERM': 'linux', 22:17:29 INFO - 'TMOUT': '86400', 22:17:29 INFO - 'USER': 'cltbld', 22:17:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047', 22:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:29 INFO - '_': '/tools/buildbot/bin/python'} 22:17:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:17:30 INFO - mozversion application_buildid: 20160206193305 22:17:30 INFO - mozversion application_changeset: 76733110704b975154ac0fa779445e6eae5da559 22:17:30 INFO - mozversion application_display_name: Nightly 22:17:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:17:30 INFO - mozversion application_name: Firefox 22:17:30 INFO - mozversion application_remotingname: firefox 22:17:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:17:30 INFO - mozversion application_vendor: Mozilla 22:17:30 INFO - mozversion application_version: 47.0a1 22:17:30 INFO - mozversion platform_buildid: 20160206193305 22:17:30 INFO - mozversion platform_changeset: 76733110704b975154ac0fa779445e6eae5da559 22:17:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:17:30 INFO - mozversion platform_version: 47.0a1 22:17:30 INFO - using testdate: 1454825850 22:17:30 INFO - actual date: 1454825850 22:17:30 INFO - starting webserver on 'localhost:55748' 22:17:30 INFO - SUITE-START | Running 2 tests 22:17:30 INFO - TEST-START | dromaeo_css 22:17:30 INFO - operating with platform_type : linux_ 22:17:30 INFO - Initialising browser for dromaeo_css test... 22:17:30 INFO - TEST-INFO | started process 18412 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUmQTY8/profile http://localhost:55748/getInfo.html) 22:17:34 INFO - PROCESS | 18412 | __metrics Screen width/height:1600/1200 22:17:34 INFO - PROCESS | 18412 | colorDepth:24 22:17:34 INFO - PROCESS | 18412 | Browser inner width/height: 1024/697 22:17:34 INFO - PROCESS | 18412 | __metrics 22:17:34 INFO - PROCESS | 18412 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:17:35 INFO - TEST-INFO | 18412: exit 0 22:17:35 INFO - Browser initialized. 22:17:35 INFO - Running cycle 1/1 for dromaeo_css test... 22:17:35 INFO - TEST-INFO | started process 18503 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUmQTY8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:47 INFO - PROCESS | 18503 | RSS: Main: 152268800 22:17:47 INFO - PROCESS | 18503 | 22:18:39 INFO - PROCESS | 18503 | 1454825919086 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] 22:20:47 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55748/tests/dromaeo/cssquery-ext.html) 22:20:48 INFO - PROCESS | 18503 | RSS: Main: 266244096 22:20:48 INFO - PROCESS | 18503 | 22:23:50 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-ext.html (next: http://localhost:55748/tests/dromaeo/cssquery-jquery.html) 22:23:51 INFO - PROCESS | 18503 | RSS: Main: 234070016 22:23:51 INFO - PROCESS | 18503 | 22:26:53 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55748/tests/dromaeo/cssquery-mootools.html) 22:26:53 INFO - PROCESS | 18503 | RSS: Main: 237862912 22:26:53 INFO - PROCESS | 18503 | 22:29:55 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55748/tests/dromaeo/cssquery-prototype.html) 22:29:56 INFO - PROCESS | 18503 | RSS: Main: 210997248 22:29:56 INFO - PROCESS | 18503 | 22:32:59 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55748/tests/dromaeo/cssquery-yui.html) 22:32:59 INFO - PROCESS | 18503 | RSS: Main: 214806528 22:32:59 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | Cycle 1(1): loaded http://localhost:55748/tests/dromaeo/cssquery-yui.html (next: http://localhost:55748/tests/dromaeo/cssquery-dojo.html) 22:36:02 INFO - PROCESS | 18503 | RSS: Main: 303652864 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | __start_tp_report 22:36:02 INFO - PROCESS | 18503 | _x_x_mozilla_page_load 22:36:02 INFO - PROCESS | 18503 | _x_x_mozilla_page_load_details 22:36:02 INFO - PROCESS | 18503 | |i|pagename|runs| 22:36:02 INFO - PROCESS | 18503 | |0;dojo.html;3134.200778801406;3187.505936579831;3229.499427588723;3230.7738458307913;3257.3810975914575;5095.541401273885;5189.074791358866;5219.347581552306;5234.37187537496;5246.449122842104;5195.350581177353;5256.395514515832;5261.86845328867;5263;5267.39424966129;4660.4174478190225;4796.2086255767845;4846.273059041137;4853.39332583427;4878.731669758162;4754.263089221176;4769.403824521934;4823.662343635947;4840.6369522285795;4944.629152813553;4754.096721622881;4801.087793319258;4803.06340263647;4809.470958194631;4826.034793041388;4765.428148622153;4769.4515130760055;4786.305985632064;4793.472718001017;4835.927461088087;4693.741844198567;4707.646926480527;4779.402574678165;4810.182269014241;4844.491328410501;5006.974965125151;5054.342935418372;5066.797328106908;5076.390833100015;5124.92312615311;5603.159526071081;5607.57943154261;5627.521660658808;5629.3526244482;5638.2670252866865;5632.014397480424;5701.14482827575;5713.514351280146;5714.485696287354;5779.711014449303;5278.894422111574;5282.313299271109;5282.656627319212;5283.498067683526;5293.682379057269;5641.435856414326;5703.372629010805;5724.627899186539;5752.223449834219;5760.164776107525;5501.587380946365;5574.470425309589;5579.776808927679;5587.245721827582;5634.661920284796;5531.115021596525;5575.972120139373;5576.386597474275;5577.05190117681;5580.693061881554;5464.371597266365;5556.472135147154;5562.638428502134;5569.498745112959;5588.692621905834;5553.972230138905;5557.333120025542;5564.054110801174;5565.1095824667855;5610.410906854721;4312.849050283287;4314.439122914001;4323.891902702458;4325.589069038437;4352.782360882006;3841.519810023747;3854.209886973164;3888.319544079775;3891.9416208756893;3912.6087391260644;5164.8192313268855;5179.404368497596;5181.53366197044;5182.067227899014;5226.3205783248695;5520.558355331564;5542.889142217214;5545.889082218333;5551.833444996657;5553.222548843165;5151.072806894795;5202.401723801736;5252.369715634149;5255.08036093682;5280.287161233261;4752.310914917318;4794.712317260975;4796.496367881392;4796.880077998008;4841.540053694894;5716.228309178207;5758.88482230353;5810.157527158538;5850.853728656818;5855.092460668603;5579.721013949367;5605.551555875439;5631.380548139619;5634.4365563443325;5704.344000440003;5785.942140578541;5809.215755873072;5832.270966129234;5849.61977471463;5849.883002340014;5502.559795216293;5545.944540554543;5556.916646250229;5558.02734521449;5601.103823388238;5617.045102332695;5622.7750889963945;5623.493885550321;5629.408912064175;5659.26429564154;5483.670979741229;5488.067028605067;5489.780408783604;5490.505854473116;5498.340199176125;5426.131818908955;5478.479544443271;5536.474034966672;5572.331320241597;5599.552035837041;5367.033933891937;5370.865728356666;5383.730813459233;5386.542143917811;5393.730313484231;5449.809256675997;5490.725463726878;5491.6364719314315;5509.779608815603;5550.916736249041;5378.247045413724;5404.594655400782;5460.180972854104;5467.289252397163;5522.337319521683 22:36:02 INFO - PROCESS | 18503 | |1;ext.html;532.4808311895902;561.3600495435202;574.1418612790027;601.9337872833989;610.1823556434377;36762.44856327157;37638.81180594097;37641.81179094107;37675.62324376756;37681.623183768155;41261.17477650453;41825.7908710456;41970.160596788046;42034.159316813646;42040.57959420405;8523.616437260338;8726.127387261287;8729.7817554561;8746.825063498727;8747.693830715927;8519.787005324855;8632.525211113387;8641;8647.610857511427;8653.913460865373;8893.911060889406;8940.776480588005;8960.148785865365;8967.372283940094;8976.147266009719;8848.955755221215;8917.331200160013;8922.598483068212;8929.374943753939;8932.508712020868;8705.651773929036;8828.249598784047;8843.11568843117;8843.159899809507;8846.15961483658;40944.59055409438;41365.58634413678;41380.79309603463;41409.58590414088;41483.377749333784;3335.5497007903864;3355.07735372772;3376.206591451007;3468.9653103468895;3619.819009049563;30409.695903041127;30526;30737;31897.564609592624;31903.6809631903;3880.3985382265796;3916.2167566486532;3938.2714197873483;3950.170464202521;4121.835126594932;200656;200686;200836;200939;202368;53723.46276537263;54679.17981230285;59512.70243648754;59666.10500842491;59698.70150649219;64295;65297.34702653008;65300.40847753419;65367;65649.34350656527;15645.139517326656;15662.765058524132;15797.289121989537;15855.68288634244;15861.682766344838;10479.790404191874;10641.627543035956;11917.344546049877;12343.19769214998;12344.3827808611;19359.47647612904;20310.289139880035;20502.282420115225;20590.794092059186;20607.175712971613;7682.347000504908;7823.374130069581;7864.449488535862;7882.724104656424;7885.723999659985;1007.0181572966445;1043.4782608695652;1060.3531845574194;1081.799867024603;1205.1262834444958;29917;30343;30401.847990760347;30703.69296307053;30913.84543077315;1082.2370228988543;1099.4502748625687;1118.6420345489366;1127.6617014895498;1150.3385553306882;15572.221388930508;16170.191490425432;16343.64638129201;16846.494605161864;17086.48740537786;305988;312049;312354;312502;312650;54158.72920635372;54401.455985439636;54445.72777136168;54447.18329225065;54456.18315725267;1250.787366147757;1367.9521216757564;1396.958091257264;1405.4097279142784;1413.6889884225454;28753;28944.56583151212;29537.556936646397;29801.403971920874;30080.69919300779;40412.393814092226;40673;41578.79210603928;43775;49892.750536247084;235681;236694;238239;238683;238744;30477.390452191277;30783.2304192397;30912.227194320323;30925;30957.380852382375;42910.141797164506;43155.78422107869;43412.78293608512;44192;44366.77816610896;35615.46576801298;35672.464913025804;35882;36074;36826.447603286506;36307.45538816867;36750.8162459186;36759.26481470302;37128.44307335338;37161.25677486381;37264;37359.06602334963;37842;38033.04917377088;38460.61539384571;28397.432051359272;28517.144485665463;30634.387312254075;31735.639468444617;32202.35595288128;22036.559268814854;22192.88903555472;22366.77633223712;22419.887900560392;22623.660645090666 22:36:02 INFO - PROCESS | 18503 | |2;jquery.html;373.09338307911764;373.61575363279053;373.67303609341815;374.14134561182084;381.4183370360202;13066.93466532666;14483.92758036211;15968.995333379764;17292.394766183184;17798.822011779877;10866.076383507412;11244.269122507052;15505.302261398236;15740.606484837885;15741.370345186178;3763.5483741950866;4881.999999999991;5013.548780609744;5026.84919452417;5028.421731500869;5132.23016547519;5395.973020134894;5404.891902161954;5425.538829199523;5427.348718153808;5281.128613778722;5321.175217841241;5346.732663366816;5494.395616482204;5497.835064948058;5419.349678038621;5424.891502169974;5433.782648694048;5460.590455715837;5476.17857321403;5351.973240133774;5359.9732001340135;5361.356637203521;5363.839084827461;5364.6512976656395;13078.86921130786;13110.606681799562;13112.082154249207;13124.343782810822;19682;2093.4243083152255;2099.979000210009;2108.8840113793735;2169.4359466538654;2643.6431081803903;9086.50024248666;9469.242460603135;9477.952610236905;9640.75898102546;9879.802403951953;1792.7221280701513;1880.887146771198;1890.981090189108;1897.3928342930267;1970.8226259636558;62067.37932620661;64497;64959.67520162416;65408.67295663491;66041.66979165122;9870.358426702242;10136.54385552652;10319.432431216204;10340.482975851177;10400.375977441377;12799.552015679592;13614.251216183007;13620.93189534046;13663.453461861613;13679.589612311647;7559;7786.4938778979185;8031.477953933093;8070.2333278338465;8081.313088387553;7874.173211812792;7981.3614910807;8017.7995550110545;8074.071481779553;8076.9192308077345;4154.210699966997;4320.762358070274;4456.131054444417;4522.706024108423;4585.587297143273;1802.089944578006;1822.3916645042889;1838.5495553589456;1868.1873385077263;1869.2336142181641;982.5922242269521;994.4132961552718;1022.3354819367471;1032.5766435761302;1100.3672888089382;14610.26948652563;15429.845701543065;16889.23998420074;17258.82741172572;17300.567485812702;919.3426699909596;923.9882328849899;974.4883935933692;977.6627063663025;1028.8559601655775;8941.59762810675;9249.445033298023;9281.350305478687;9283.535823208813;9429;514828;515779;518292;544047;556529;69177;74748.62625686837;76522.61738691383;77902;80479;1181.0551558753134;1184.1000839362148;1216.3431746856597;1219.1709637446445;1255;14960.551183464513;15209.543713688607;15340.92329538345;15444;15622.140782257085;30992.22519437032;31314.843425782725;31585.52621710722;31669.683303167596;32127.357452850345;46102.53897460982;48878.511214887396;50721.239181413046;51147.23279150741;51464.22803658023;7459.589722565311;7697.076350837935;7759.418043646862;7817.452778305692;7836.490628109154;9204.815903682023;11222.60720874798;11428.828567571327;11570.537178512765;11992.520299188283;8201.507909525448;9921.15670168015;10556.630517932143;10679.87861274555;10703.143748500257;9730.124288813757;9771.609135634495;9935.552900119657;10124.493775311352;10300.175985920958;9944.950275248577;9956.502174891371;10152;10262.948685256824;10350.327228730108;7347.228541003332;7552;7571;7580.393568514616;7585.469017168966;9247.30645201626;10222.48887555634;10299.794004119725;10389.324693894872;10400.791984160425 22:36:02 INFO - PROCESS | 18503 | |3;mootools.html;1331.5406184866217;1496.7680009598512;1513.152634524666;1677.547062293181;1803.4589623113063;7173.06750122484;7663.8084047898765;7795.415343849206;7812.179721129285;7849.411294152933;7526.322630963212;7687.577183254919;7689.653965571549;7699.884501732478;7703.229677032294;2021.1208124465904;2063.8968051597362;2064.3394113883564;2338.8830558472096;2365.38499990003;2040.540878302385;2288;2323;2339.7660233976635;2347.0377145370403;2218.0684112672716;2225.410266279437;2233.944151396212;2275.1695631094613;2276.3398614401804;2279.939827979997;2310.757370476101;2319.1998760427628;2324.418895276181;2349.682792822964;2305.7694230576976;2323.7560056194025;2323.8954247058755;2328.2316835444262;2335.5679199348006;7842.254985776342;7890.368770498347;7894.092179399385;7896.644650990719;7898.447108702393;4783.473817880031;4864.124457597631;4921.680090794087;4928.33467481889;4933.333999910002;3171.7462602991704;3206.6633003534757;3209.8395080246128;3224;3225.1130938991732;993.145894530703;1005.3515482513811;1027.1731256338644;1048.3605000949415;1053.9051485366354;10592.523336449878;10743.462826858626;10749.731256718567;10753.354798712102;10765.569377224901;4412.205802955499;4491.88770280739;4503.392042074343;4510.661700372485;4558.361829343895;9277.072292770668;9283.25733941283;9289.814203715889;9302.441853488812;9305.860412093823;4947.6536642434685;4980.676256043345;4981.32752078472;4984.576311013604;4988.326575912278;4541.3188021797;4552.089582083597;4552.157850797613;4553.772311384418;4556.453225612948;3492.7904325740537;3733.2160246348026;3735.2529494100745;3811.2568049230135;3857.1321452672923;1217.3669691760413;1245.0413181849924;1247.644421339932;1252.4614415801293;1262.551794113095;1330.8735670111323;1338.899582531314;1340.5978206538;1345.5021641992525;1370.4997675848244;7257.237990011078;7391.260873912674;7428.925710742823;7779.92220077792;7837.7648670539975;1134.2910680824484;1134.615768762109;1138.692553010699;1150.1373969522858;1165.6386520178603;5781.277340332458;5824.068149096124;5829.038208695518;5833.912491312633;5837.9124313135335;9014.729558113268;9038.683646072355;9137.634494620273;9241.353105282566;9323.720288391223;9225.677101301422;9229.769255768526;9233.815323693489;9242.21441177494;9253.306002049872;7208.855822883513;7341.412686985029;7403.962980185064;7432.405407567381;7464;7370.889436658347;7447.031885854804;7451.962740186481;7459.925400745923;7467.514611550232;8247.134050924567;8306.875396869173;8500.149985001697;8647.092055334351;8651.307895368229;8190.140035296208;8265.669373225004;8395.664173432995;8408.831823363376;8409.159084091541;6601.075849381186;6744.460443164437;6771.729130834711;6775.864482710417;6776.288489708707;6532.444742196776;7123.715051397886;7500.474966752493;7649.158592554703;7697.923020769945;7225.24134965821;7316.9634151828905;7361.558306501627;7432.219616940143;7459.36595389398;6970.11806812168;7107.076080109553;7182.820429489305;7187.712491500281;7391.0761154855645;6972.267911869383;6973.755918542826;6974.442044636518;6979.685914133977;7010.649467526501;6347.809565713036;6715.160604924385;6715.294894036056;6719.428848547733;6721.395074443323;6758;6790.151231096113;6796.18445786489;6802.829929251809;6813.557118787263 22:36:02 INFO - PROCESS | 18503 | |4;prototype.html;337.4651177883055;352.1495588154607;352.1513153300546;356.9821508924553;362.49070056570525;5864.501517371029;6013.518918486516;6030.849228769283;6065.514758819295;6071.028635418339;5769.249997500329;5948.821535353935;5966.79116230932;5983.700814959257;5993.310769261536;4678.485366609671;4682.789274482648;4684.039771846763;4688.765561721901;4691.835785747499;4491.640668746509;4545.909081818361;4645.27998160284;4658.534146585348;4687.132880417117;4577.725336479822;4588.013577080927;4612.3542704021465;4612.377329060568;4617.6536759742985;4607.631389488833;4623.214053610861;4626.398568186114;4626.791794369228;4626.953730462686;4091.89770255743;4092.7953602319767;4095.3242714952;4099.077707515815;4099.877003689894;5623.578231632644;5728.62763920348;5741.110127930177;5745.683987380692;5750.942490575083;5402.810901618424;5414.10667239905;5421.9457805421835;5422.891542169174;5425.701586412746;6106.48094911933;6375.521835862329;6375.744970201186;6377.489800815923;6387.073874288202;4412.448443944507;4487.416635837353;4497.640188784922;4528.479224889114;4536.047430039695;6620.404163625249;6628.138342015555;6637.601743895381;6641.402273795382;6644.900326495106;4673.299005149255;4677.3919390479705;4681.67228294023;4685.882852928636;4693.55411235932;4638.628909687217;4728.172569800271;4728.486884197024;4732.597729193058;4750.334953106568;5421.105517589633;5427.158790387496;5428.131498960148;5430.8099216527235;5432.375276843135;6417.550771446047;6422.839429014312;6427.357264273629;6432.099506069154;6432.646204458706;1658.3449537432646;1681.3106626283165;1682.528891910267;1683.7053515634716;1684.5451728033363;1063.9308444951052;1095.1567293184362;1096.6107032003683;1110.7833972375308;1168.1297433412162;6003.039513677878;6062.454379105901;6071.089336599545;6071.362506936796;6102.176206212193;6554.14796076507;6563.573367731177;6564.376384243489;6570.934290657128;6587.901181482282;6074.635521868614;6084.148219249309;6085;6143.938560614426;6146.139540464339;3446.724262059029;3547.166415892263;3548.8757893473603;3552.1652411683235;3555.253396786652;6869.965650171717;6870.3473170048765;6872.41584465316;6874.518783685194;6882.070920425778;6657.1012913257055;6683.5989840608745;6689.665516724144;6709.7651582194385;6716.697748601325;6687.799366019027;6812.182538095461;6831.69257383409;6842.7605033823575;6854.657267136524;6392.648404337806;6498.837529061811;6550.508711846535;6555.704993275219;6625.238097618835;6464.709088090953;6483.708233129426;6495.253045899782;6578.8355291118105;6588.374104460068;6863.450923925974;6872.931270687229;6941.0629565010095;6946.027556142245;6959.164900212007;4466.28539433702;4502.842400515966;4546.772661366852;4553.2942393929;4556.794944227451;6670.099536562502;6678.098456708282;6678.766243181465;6691.297413771484;6697.3637504437;6488.2538508072175;6494;6508.479321654161;6509.576877502947;6509.837254068686;6387.584806987531;6416.390442907917;6492.220933487823;6493.155889734304;6498.642574658439;6335.683215839282;6338.904916426165;6339.4928405726505;6341.334159913143;6342.460890824332;6514.967425162844;6518.380753828379;6518.902216466851;6526.9347306528225;6532.281449040697;6204.968975155276;6359.777407790705;6370.8088757337355;6381.968090159705;6398.680065996588 22:36:02 INFO - PROCESS | 18503 | |5;yui.html;804.6298702596802;807.8424707182102;819.3527113580271;827.9047909490408;829.1429874934294;13738;14053.227072511008;14071.788923166148;14111.71776564468;14127.71744565108;13077.934610326958;13192.802107968388;13273.668158296023;13284.867151328484;13309.334533273322;688.5902887781762;699.6711545573572;818.5866137600503;825.154216927651;834.4492634860993;832.5129799067553;841.3269384492412;847.2290215903529;853.6628031927416;853.9786505337354;888.076400543434;891.2157301574605;891.9464832110061;892.0544223123477;892.2906289499831;705.048184950318;848.3043903998692;865.0311650950912;868.1405408645395;886.2422628652506;637.677972623822;639.4756299834138;640.1230314469207;640.3756337570878;640.6636515829181;13878.583642490741;13898.722025559533;13941.372638231303;13948.2328471934;13958.162510249316;12934.676633084155;12987;13130;13407.128536645087;13463.192208467523;10806.945965270203;10962.342259464458;10968.17738669595;11122.833157502644;11275.32348059119;3644.671979521856;3678.7792732435873;3714.7956862372557;3790.9431358529646;3795.905102372435;46615.30077048847;46658.76670616659;46763.766181168874;47329.52670473286;47480;10300.330478518872;10578.10086142671;10713.678589642168;10773.192010599236;11005.559777608805;19031.714524282146;19127.33054343119;19193.232270709294;19197;19209;7154.785356439315;7475.140358858801;7724.343430808444;7796.064472263251;8000.919990800134;4312.094460163338;4454.844080457233;4467.977660111678;4484.618807401407;4533.7279763213655;3158.652548219694;3179.205198700325;3191.984040079785;3196.2009497625595;3197.1367730712577;572.7823427097676;575.0454245951701;581.520245797219;588.8115802943017;607.341034977046;582.6183849578533;589.7316720891984;591.3199820206711;605.19757920968;616.7841255560518;8663.870041949376;9250.953745231365;9305.022972587782;9337.159655631025;9357.578908949114;603.7434090511515;663.4305009445676;683.719674933275;685.3283781893772;701.7298340139083;3661.359262129117;3686.2258925625383;4011.2779699654343;4494.752788596658;4587.3348364486965;56805.431945680844;58541.41458585445;58707;59045;59314;50224.74887625612;50368.496315036384;50755;50985.745071275145;51043;46268.305975410396;46473.76763116163;46636.3004554932;46793.29810052852;46852;8895.421797583136;9250.352475326663;9420.528973551433;9421.905780942103;9426.528673566158;35033.29933401369;35278.82360588181;35523.289534208656;35799.46300805438;35944.460833087;45074.3238851424;45077;45338.773306133255;45824.770876145405;45879.31181032221;11156.330620162817;11522;11568.305901645928;11607.36159511235;11762.294262344287;11310.151738619801;11381.235908434206;11532.077433805107;11791.115666324888;12345.382730863601;11977.161598688008;12148.635540933787;12172.2696638202;12325.630231093082;12600.495980161058;11136.220464567403;11284.887151128713;11382;11831.053515718893;11891.82162267584;11208.719782005515;11450;11495;11799.52801887915;11993.520259189883;9536;9925.1067403934;9960.701030109327;10106.039926206999;10251.179905607683;9483.857742133736;10377.792444151226;10464.947675261576;10471.842922356323;10485.633002844865 22:36:02 INFO - PROCESS | 18503 | __end_tp_report 22:36:02 INFO - PROCESS | 18503 | __start_cc_report 22:36:02 INFO - PROCESS | 18503 | _x_x_mozilla_cycle_collect,897 22:36:02 INFO - PROCESS | 18503 | __end_cc_report 22:36:02 INFO - PROCESS | 18503 | __startTimestamp1454826962609__endTimestamp 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | ------- Summary: start ------- 22:36:02 INFO - PROCESS | 18503 | Number of tests: 6 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#0] dojo.html Cycles:165 Average:5213.19 Median:5426.13 stddev:565.70 (10.4%) stddev-sans-first:543.42 22:36:02 INFO - PROCESS | 18503 | Values: 3134.2 3187.5 3229.5 3230.8 3257.4 5095.5 5189.1 5219.3 5234.4 5246.4 5195.4 5256.4 5261.9 5263.0 5267.4 4660.4 4796.2 4846.3 4853.4 4878.7 4754.3 4769.4 4823.7 4840.6 4944.6 4754.1 4801.1 4803.1 4809.5 4826.0 4765.4 4769.5 4786.3 4793.5 4835.9 4693.7 4707.6 4779.4 4810.2 4844.5 5007.0 5054.3 5066.8 5076.4 5124.9 5603.2 5607.6 5627.5 5629.4 5638.3 5632.0 5701.1 5713.5 5714.5 5779.7 5278.9 5282.3 5282.7 5283.5 5293.7 5641.4 5703.4 5724.6 5752.2 5760.2 5501.6 5574.5 5579.8 5587.2 5634.7 5531.1 5576.0 5576.4 5577.1 5580.7 5464.4 5556.5 5562.6 5569.5 5588.7 5554.0 5557.3 5564.1 5565.1 5610.4 4312.8 4314.4 4323.9 4325.6 4352.8 3841.5 3854.2 3888.3 3891.9 3912.6 5164.8 5179.4 5181.5 5182.1 5226.3 5520.6 5542.9 5545.9 5551.8 5553.2 5151.1 5202.4 5252.4 5255.1 5280.3 4752.3 4794.7 4796.5 4796.9 4841.5 5716.2 5758.9 5810.2 5850.9 5855.1 5579.7 5605.6 5631.4 5634.4 5704.3 5785.9 5809.2 5832.3 5849.6 5849.9 5502.6 5545.9 5556.9 5558.0 5601.1 5617.0 5622.8 5623.5 5629.4 5659.3 5483.7 5488.1 5489.8 5490.5 5498.3 5426.1 5478.5 5536.5 5572.3 5599.6 5367.0 5370.9 5383.7 5386.5 5393.7 5449.8 5490.7 5491.6 5509.8 5550.9 5378.2 5404.6 5460.2 5467.3 5522.3 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#1] ext.html Cycles:180 Average:42963.87 Median:36755.04 stddev:66256.53 (180.3%) stddev-sans-first:66365.80 22:36:02 INFO - PROCESS | 18503 | Values: 532.5 561.4 574.1 601.9 610.2 36762.4 37638.8 37641.8 37675.6 37681.6 41261.2 41825.8 41970.2 42034.2 42040.6 8523.6 8726.1 8729.8 8746.8 8747.7 8519.8 8632.5 8641.0 8647.6 8653.9 8893.9 8940.8 8960.1 8967.4 8976.1 8849.0 8917.3 8922.6 8929.4 8932.5 8705.7 8828.2 8843.1 8843.2 8846.2 40944.6 41365.6 41380.8 41409.6 41483.4 3335.5 3355.1 3376.2 3469.0 3619.8 30409.7 30526.0 30737.0 31897.6 31903.7 3880.4 3916.2 3938.3 3950.2 4121.8 200656.0 200686.0 200836.0 200939.0 202368.0 53723.5 54679.2 59512.7 59666.1 59698.7 64295.0 65297.3 65300.4 65367.0 65649.3 15645.1 15662.8 15797.3 15855.7 15861.7 10479.8 10641.6 11917.3 12343.2 12344.4 19359.5 20310.3 20502.3 20590.8 20607.2 7682.3 7823.4 7864.4 7882.7 7885.7 1007.0 1043.5 1060.4 1081.8 1205.1 29917.0 30343.0 30401.8 30703.7 30913.8 1082.2 1099.5 1118.6 1127.7 1150.3 15572.2 16170.2 16343.6 16846.5 17086.5 305988.0 312049.0 312354.0 312502.0 312650.0 54158.7 54401.5 54445.7 54447.2 54456.2 1250.8 1368.0 1397.0 1405.4 1413.7 28753.0 28944.6 29537.6 29801.4 30080.7 40412.4 40673.0 41578.8 43775.0 49892.8 235681.0 236694.0 238239.0 238683.0 238744.0 30477.4 30783.2 30912.2 30925.0 30957.4 42910.1 43155.8 43412.8 44192.0 44366.8 35615.5 35672.5 35882.0 36074.0 36826.4 36307.5 36750.8 36759.3 37128.4 37161.3 37264.0 37359.1 37842.0 38033.0 38460.6 28397.4 28517.1 30634.4 31735.6 32202.4 22036.6 22192.9 22366.8 22419.9 22623.7 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#2] jquery.html Cycles:180 Average:27560.07 Median:25492.27 stddev:86796.48 (340.5%) stddev-sans-first:87015.96 22:36:02 INFO - PROCESS | 18503 | Values: 373.1 373.6 373.7 374.1 381.4 13066.9 14483.9 15969.0 17292.4 17798.8 10866.1 11244.3 15505.3 15740.6 15741.4 3763.5 4882.0 5013.5 5026.8 5028.4 5132.2 5396.0 5404.9 5425.5 5427.3 5281.1 5321.2 5346.7 5494.4 5497.8 5419.3 5424.9 5433.8 5460.6 5476.2 5352.0 5360.0 5361.4 5363.8 5364.7 13078.9 13110.6 13112.1 13124.3 19682.0 2093.4 2100.0 2108.9 2169.4 2643.6 9086.5 9469.2 9478.0 9640.8 9879.8 1792.7 1880.9 1891.0 1897.4 1970.8 62067.4 64497.0 64959.7 65408.7 66041.7 9870.4 10136.5 10319.4 10340.5 10400.4 12799.6 13614.3 13620.9 13663.5 13679.6 7559.0 7786.5 8031.5 8070.2 8081.3 7874.2 7981.4 8017.8 8074.1 8076.9 4154.2 4320.8 4456.1 4522.7 4585.6 1802.1 1822.4 1838.5 1868.2 1869.2 982.6 994.4 1022.3 1032.6 1100.4 14610.3 15429.8 16889.2 17258.8 17300.6 919.3 924.0 974.5 977.7 1028.9 8941.6 9249.4 9281.4 9283.5 9429.0 514828.0 515779.0 518292.0 544047.0 556529.0 69177.0 74748.6 76522.6 77902.0 80479.0 1181.1 1184.1 1216.3 1219.2 1255.0 14960.6 15209.5 15340.9 15444.0 15622.1 30992.2 31314.8 31585.5 31669.7 32127.4 46102.5 48878.5 50721.2 51147.2 51464.2 7459.6 7697.1 7759.4 7817.5 7836.5 9204.8 11222.6 11428.8 11570.5 11992.5 8201.5 9921.2 10556.6 10679.9 10703.1 9730.1 9771.6 9935.6 10124.5 10300.2 9945.0 9956.5 10152.0 10262.9 10350.3 7347.2 7552.0 7571.0 7580.4 7585.5 9247.3 10222.5 10299.8 10389.3 10400.8 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#3] mootools.html Cycles:180 Average:5529.20 Median:6566.76 stddev:2807.28 (42.7%) stddev-sans-first:2797.42 22:36:02 INFO - PROCESS | 18503 | Values: 1331.5 1496.8 1513.2 1677.5 1803.5 7173.1 7663.8 7795.4 7812.2 7849.4 7526.3 7687.6 7689.7 7699.9 7703.2 2021.1 2063.9 2064.3 2338.9 2365.4 2040.5 2288.0 2323.0 2339.8 2347.0 2218.1 2225.4 2233.9 2275.2 2276.3 2279.9 2310.8 2319.2 2324.4 2349.7 2305.8 2323.8 2323.9 2328.2 2335.6 7842.3 7890.4 7894.1 7896.6 7898.4 4783.5 4864.1 4921.7 4928.3 4933.3 3171.7 3206.7 3209.8 3224.0 3225.1 993.1 1005.4 1027.2 1048.4 1053.9 10592.5 10743.5 10749.7 10753.4 10765.6 4412.2 4491.9 4503.4 4510.7 4558.4 9277.1 9283.3 9289.8 9302.4 9305.9 4947.7 4980.7 4981.3 4984.6 4988.3 4541.3 4552.1 4552.2 4553.8 4556.5 3492.8 3733.2 3735.3 3811.3 3857.1 1217.4 1245.0 1247.6 1252.5 1262.6 1330.9 1338.9 1340.6 1345.5 1370.5 7257.2 7391.3 7428.9 7779.9 7837.8 1134.3 1134.6 1138.7 1150.1 1165.6 5781.3 5824.1 5829.0 5833.9 5837.9 9014.7 9038.7 9137.6 9241.4 9323.7 9225.7 9229.8 9233.8 9242.2 9253.3 7208.9 7341.4 7404.0 7432.4 7464.0 7370.9 7447.0 7452.0 7459.9 7467.5 8247.1 8306.9 8500.1 8647.1 8651.3 8190.1 8265.7 8395.7 8408.8 8409.2 6601.1 6744.5 6771.7 6775.9 6776.3 6532.4 7123.7 7500.5 7649.2 7697.9 7225.2 7317.0 7361.6 7432.2 7459.4 6970.1 7107.1 7182.8 7187.7 7391.1 6972.3 6973.8 6974.4 6979.7 7010.6 6347.8 6715.2 6715.3 6719.4 6721.4 6758.0 6790.2 6796.2 6802.8 6813.6 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#4] prototype.html Cycles:180 Average:5375.08 Median:6068.27 stddev:1603.96 (26.4%) stddev-sans-first:1563.26 22:36:02 INFO - PROCESS | 18503 | Values: 337.5 352.1 352.2 357.0 362.5 5864.5 6013.5 6030.8 6065.5 6071.0 5769.2 5948.8 5966.8 5983.7 5993.3 4678.5 4682.8 4684.0 4688.8 4691.8 4491.6 4545.9 4645.3 4658.5 4687.1 4577.7 4588.0 4612.4 4612.4 4617.7 4607.6 4623.2 4626.4 4626.8 4627.0 4091.9 4092.8 4095.3 4099.1 4099.9 5623.6 5728.6 5741.1 5745.7 5750.9 5402.8 5414.1 5421.9 5422.9 5425.7 6106.5 6375.5 6375.7 6377.5 6387.1 4412.4 4487.4 4497.6 4528.5 4536.0 6620.4 6628.1 6637.6 6641.4 6644.9 4673.3 4677.4 4681.7 4685.9 4693.6 4638.6 4728.2 4728.5 4732.6 4750.3 5421.1 5427.2 5428.1 5430.8 5432.4 6417.6 6422.8 6427.4 6432.1 6432.6 1658.3 1681.3 1682.5 1683.7 1684.5 1063.9 1095.2 1096.6 1110.8 1168.1 6003.0 6062.5 6071.1 6071.4 6102.2 6554.1 6563.6 6564.4 6570.9 6587.9 6074.6 6084.1 6085.0 6143.9 6146.1 3446.7 3547.2 3548.9 3552.2 3555.3 6870.0 6870.3 6872.4 6874.5 6882.1 6657.1 6683.6 6689.7 6709.8 6716.7 6687.8 6812.2 6831.7 6842.8 6854.7 6392.6 6498.8 6550.5 6555.7 6625.2 6464.7 6483.7 6495.3 6578.8 6588.4 6863.5 6872.9 6941.1 6946.0 6959.2 4466.3 4502.8 4546.8 4553.3 4556.8 6670.1 6678.1 6678.8 6691.3 6697.4 6488.3 6494.0 6508.5 6509.6 6509.8 6387.6 6416.4 6492.2 6493.2 6498.6 6335.7 6338.9 6339.5 6341.3 6342.5 6515.0 6518.4 6518.9 6526.9 6532.3 6205.0 6359.8 6370.8 6382.0 6398.7 22:36:02 INFO - PROCESS | 18503 | 22:36:02 INFO - PROCESS | 18503 | [#5] yui.html Cycles:180 Average:14051.15 Median:24805.36 stddev:15954.74 (64.3%) stddev-sans-first:15968.48 22:36:02 INFO - PROCESS | 18503 | Values: 804.6 807.8 819.4 827.9 829.1 13738.0 14053.2 14071.8 14111.7 14127.7 13077.9 13192.8 13273.7 13284.9 13309.3 688.6 699.7 818.6 825.2 834.4 832.5 841.3 847.2 853.7 854.0 888.1 891.2 891.9 892.1 892.3 705.0 848.3 865.0 868.1 886.2 637.7 639.5 640.1 640.4 640.7 13878.6 13898.7 13941.4 13948.2 13958.2 12934.7 12987.0 13130.0 13407.1 13463.2 10806.9 10962.3 10968.2 11122.8 11275.3 3644.7 3678.8 3714.8 3790.9 3795.9 46615.3 46658.8 46763.8 47329.5 47480.0 10300.3 10578.1 10713.7 10773.2 11005.6 19031.7 19127.3 19193.2 19197.0 19209.0 7154.8 7475.1 7724.3 7796.1 8000.9 4312.1 4454.8 4468.0 4484.6 4533.7 3158.7 3179.2 3192.0 3196.2 3197.1 572.8 575.0 581.5 588.8 607.3 582.6 589.7 591.3 605.2 616.8 8663.9 9251.0 9305.0 9337.2 9357.6 603.7 663.4 683.7 685.3 701.7 3661.4 3686.2 4011.3 4494.8 4587.3 56805.4 58541.4 58707.0 59045.0 59314.0 50224.7 50368.5 50755.0 50985.7 51043.0 46268.3 46473.8 46636.3 46793.3 46852.0 8895.4 9250.4 9420.5 9421.9 9426.5 35033.3 35278.8 35523.3 35799.5 35944.5 45074.3 45077.0 45338.8 45824.8 45879.3 11156.3 11522.0 11568.3 11607.4 11762.3 11310.2 11381.2 11532.1 11791.1 12345.4 11977.2 12148.6 12172.3 12325.6 12600.5 11136.2 11284.9 11382.0 11831.1 11891.8 11208.7 11450.0 11495.0 11799.5 11993.5 9536.0 9925.1 9960.7 10106.0 10251.2 9483.9 10377.8 10464.9 10471.8 10485.6 22:36:02 INFO - PROCESS | 18503 | -------- Summary: end -------- 22:36:02 INFO - PROCESS | 18503 | 22:36:03 INFO - TEST-INFO | 18503: exit 0 22:36:03 INFO - TEST-OK | dromaeo_css | took 1113111ms 22:36:03 INFO - TEST-START | kraken 22:36:03 INFO - operating with platform_type : linux_ 22:36:03 INFO - Initialising browser for kraken test... 22:36:03 INFO - TEST-INFO | started process 18693 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8RxlRG/profile http://localhost:55748/getInfo.html) 22:36:07 INFO - PROCESS | 18693 | __metrics Screen width/height:1600/1200 22:36:07 INFO - PROCESS | 18693 | colorDepth:24 22:36:07 INFO - PROCESS | 18693 | Browser inner width/height: 1024/697 22:36:07 INFO - PROCESS | 18693 | __metrics 22:36:07 INFO - PROCESS | 18693 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:08 INFO - TEST-INFO | 18693: exit 0 22:36:08 INFO - Browser initialized. 22:36:08 INFO - Running cycle 1/1 for kraken test... 22:36:08 INFO - TEST-INFO | started process 18771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8RxlRG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:36:20 INFO - PROCESS | 18771 | RSS: Main: 151068672 22:36:20 INFO - PROCESS | 18771 | 22:36:23 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55748/tests/kraken/driver.html?testName=audio-beat-detection) 22:36:23 INFO - PROCESS | 18771 | RSS: Main: 193630208 22:36:23 INFO - PROCESS | 18771 | 22:36:26 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55748/tests/kraken/driver.html?testName=audio-dft) 22:36:26 INFO - PROCESS | 18771 | RSS: Main: 182001664 22:36:26 INFO - PROCESS | 18771 | 22:36:29 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55748/tests/kraken/driver.html?testName=audio-fft) 22:36:30 INFO - PROCESS | 18771 | RSS: Main: 165392384 22:36:30 INFO - PROCESS | 18771 | 22:36:32 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55748/tests/kraken/driver.html?testName=audio-oscillator) 22:36:32 INFO - PROCESS | 18771 | RSS: Main: 167686144 22:36:32 INFO - PROCESS | 18771 | 22:36:35 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55748/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:36:35 INFO - PROCESS | 18771 | RSS: Main: 170676224 22:36:35 INFO - PROCESS | 18771 | 22:36:38 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55748/tests/kraken/driver.html?testName=imaging-darkroom) 22:36:39 INFO - PROCESS | 18771 | RSS: Main: 171118592 22:36:39 INFO - PROCESS | 18771 | 22:36:42 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55748/tests/kraken/driver.html?testName=imaging-desaturate) 22:36:43 INFO - PROCESS | 18771 | RSS: Main: 170196992 22:36:43 INFO - PROCESS | 18771 | 22:36:46 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55748/tests/kraken/driver.html?testName=json-parse-financial) 22:36:46 INFO - PROCESS | 18771 | RSS: Main: 171515904 22:36:46 INFO - PROCESS | 18771 | 22:36:48 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55748/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:36:48 INFO - PROCESS | 18771 | RSS: Main: 183062528 22:36:48 INFO - PROCESS | 18771 | 22:36:50 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:36:51 INFO - PROCESS | 18771 | RSS: Main: 181485568 22:36:51 INFO - PROCESS | 18771 | 22:36:53 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:36:53 INFO - PROCESS | 18771 | RSS: Main: 188338176 22:36:53 INFO - PROCESS | 18771 | 22:36:56 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:36:56 INFO - PROCESS | 18771 | RSS: Main: 194465792 22:36:56 INFO - PROCESS | 18771 | 22:36:59 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:36:59 INFO - PROCESS | 18771 | RSS: Main: 193978368 22:36:59 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | Cycle 1(1): loaded http://localhost:55748/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55748/tests/kraken/driver.html?testName=ai-astar) 22:37:01 INFO - PROCESS | 18771 | RSS: Main: 254849024 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | __start_tp_report 22:37:01 INFO - PROCESS | 18771 | _x_x_mozilla_page_load 22:37:01 INFO - PROCESS | 18771 | _x_x_mozilla_page_load_details 22:37:01 INFO - PROCESS | 18771 | |i|pagename|runs| 22:37:01 INFO - PROCESS | 18771 | |0;ai-astar;110;110;107;110;112;111;103;112;113;110 22:37:01 INFO - PROCESS | 18771 | |1;audio-beat-detection;150;130;155;167;129;157;152;126;170;128 22:37:01 INFO - PROCESS | 18771 | |2;audio-dft;160;161;165;162;163;163;163;165;162;163 22:37:01 INFO - PROCESS | 18771 | |3;audio-fft;75;73;100;93;76;75;74;117;94;74 22:37:01 INFO - PROCESS | 18771 | |4;audio-oscillator;97;96;150;95;96;96;139;96;97;139 22:37:01 INFO - PROCESS | 18771 | |5;imaging-gaussian-blur;119;115;117;116;115;115;115;115;119;114 22:37:01 INFO - PROCESS | 18771 | |6;imaging-darkroom;146;145;145;145;146;145;145;146;146;146 22:37:01 INFO - PROCESS | 18771 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 22:37:01 INFO - PROCESS | 18771 | |8;json-parse-financial;59;60;56;56;57;56;56;66;55;55 22:37:01 INFO - PROCESS | 18771 | |9;json-stringify-tinderbox;66;68;66;67;68;67;67;66;70;67 22:37:01 INFO - PROCESS | 18771 | |10;stanford-crypto-aes;85;84;85;85;84;84;86;84;89;86 22:37:01 INFO - PROCESS | 18771 | |11;stanford-crypto-ccm;124;118;118;123;115;116;120;120;125;119 22:37:01 INFO - PROCESS | 18771 | |12;stanford-crypto-pbkdf2;152;146;152;152;162;144;151;154;152;152 22:37:01 INFO - PROCESS | 18771 | |13;stanford-crypto-sha256-iterative;70;69;69;67;68;70;67;71;67;67 22:37:01 INFO - PROCESS | 18771 | __end_tp_report 22:37:01 INFO - PROCESS | 18771 | __start_cc_report 22:37:01 INFO - PROCESS | 18771 | _x_x_mozilla_cycle_collect,985 22:37:01 INFO - PROCESS | 18771 | __end_cc_report 22:37:01 INFO - PROCESS | 18771 | __startTimestamp1454827021946__endTimestamp 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | ------- Summary: start ------- 22:37:01 INFO - PROCESS | 18771 | Number of tests: 14 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:2.90 (2.6%) stddev-sans-first:3.07 22:37:01 INFO - PROCESS | 18771 | Values: 110.0 110.0 107.0 110.0 112.0 111.0 103.0 112.0 113.0 110.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:16.79 (10.9%) stddev-sans-first:17.76 22:37:01 INFO - PROCESS | 18771 | Values: 150.0 130.0 155.0 167.0 129.0 157.0 152.0 126.0 170.0 128.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:1.57 (1.0%) stddev-sans-first:1.32 22:37:01 INFO - PROCESS | 18771 | Values: 160.0 161.0 165.0 162.0 163.0 163.0 163.0 165.0 162.0 163.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#3] audio-fft Cycles:10 Average:85.10 Median:75.00 stddev:15.13 (20.2%) stddev-sans-first:15.60 22:37:01 INFO - PROCESS | 18771 | Values: 75.0 73.0 100.0 93.0 76.0 75.0 74.0 117.0 94.0 74.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.68 (23.6%) stddev-sans-first:23.55 22:37:01 INFO - PROCESS | 18771 | Values: 97.0 96.0 150.0 95.0 96.0 96.0 139.0 96.0 97.0 139.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.50 stddev:1.76 (1.5%) stddev-sans-first:1.50 22:37:01 INFO - PROCESS | 18771 | Values: 119.0 115.0 117.0 116.0 115.0 115.0 115.0 115.0 119.0 114.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:37:01 INFO - PROCESS | 18771 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:37:01 INFO - PROCESS | 18771 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.50 stddev:3.37 (6.0%) stddev-sans-first:3.54 22:37:01 INFO - PROCESS | 18771 | Values: 59.0 60.0 56.0 56.0 57.0 56.0 56.0 66.0 55.0 55.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 22:37:01 INFO - PROCESS | 18771 | Values: 66.0 68.0 66.0 67.0 68.0 67.0 67.0 66.0 70.0 67.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.55 (1.8%) stddev-sans-first:1.64 22:37:01 INFO - PROCESS | 18771 | Values: 85.0 84.0 85.0 85.0 84.0 84.0 86.0 84.0 89.0 86.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:120.00 stddev:3.33 (2.8%) stddev-sans-first:3.16 22:37:01 INFO - PROCESS | 18771 | Values: 124.0 118.0 118.0 123.0 115.0 116.0 120.0 120.0 125.0 119.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:152.00 stddev:4.76 (3.1%) stddev-sans-first:5.05 22:37:01 INFO - PROCESS | 18771 | Values: 152.0 146.0 152.0 152.0 162.0 144.0 151.0 154.0 152.0 152.0 22:37:01 INFO - PROCESS | 18771 | 22:37:01 INFO - PROCESS | 18771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.50 22:37:01 INFO - PROCESS | 18771 | Values: 70.0 69.0 69.0 67.0 68.0 70.0 67.0 71.0 67.0 67.0 22:37:01 INFO - PROCESS | 18771 | -------- Summary: end -------- 22:37:01 INFO - PROCESS | 18771 | 22:37:02 INFO - TEST-INFO | 18771: exit 0 22:37:02 INFO - TEST-OK | kraken | took 59574ms 22:37:02 INFO - SUITE-END | took 1172s 22:37:03 INFO - Completed test suite (00:19:32) 22:37:03 INFO - Working with test: dromaeo_css 22:37:03 INFO - Generating results file: dromaeo_css 22:37:03 INFO - Working with test: kraken 22:37:03 INFO - Generating results file: kraken 22:37:03 INFO - javascript benchmark 22:37:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:37:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:37:03 INFO - process_Request line: dromaeo_css 6953.23 graph.html#tests=[[72,1,35]] 22:37:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:37:03 INFO - process_Request line: kraken 1521.50 graph.html#tests=[[232,1,35]] 22:37:03 INFO - RETURN: dromaeo_css: 6953.23 22:37:03 INFO - RETURN: kraken: 1521.50 22:37:03 INFO - javascript benchmark 22:37:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.200778801406, 3187.505936579831, 3229.499427588723, 3230.7738458307913, 3257.3810975914575, 5095.541401273885, 5189.074791358866, 5219.347581552306, 5234.37187537496, 5246.449122842104, 5195.350581177353, 5256.395514515832, 5261.86845328867, 5263.0, 5267.39424966129, 4660.4174478190225, 4796.2086255767845, 4846.273059041137, 4853.39332583427, 4878.731669758162, 4754.263089221176, 4769.403824521934, 4823.662343635947, 4840.6369522285795, 4944.629152813553, 4754.096721622881, 4801.087793319258, 4803.06340263647, 4809.470958194631, 4826.034793041388, 4765.428148622153, 4769.4515130760055, 4786.305985632064, 4793.472718001017, 4835.927461088087, 4693.741844198567, 4707.646926480527, 4779.402574678165, 4810.182269014241, 4844.491328410501, 5006.974965125151, 5054.342935418372, 5066.797328106908, 5076.390833100015, 5124.92312615311, 5603.159526071081, 5607.57943154261, 5627.521660658808, 5629.3526244482, 5638.2670252866865, 5632.014397480424, 5701.14482827575, 5713.514351280146, 5714.485696287354, 5779.711014449303, 5278.894422111574, 5282.313299271109, 5282.656627319212, 5283.498067683526, 5293.682379057269, 5641.435856414326, 5703.372629010805, 5724.627899186539, 5752.223449834219, 5760.164776107525, 5501.587380946365, 5574.470425309589, 5579.776808927679, 5587.245721827582, 5634.661920284796, 5531.115021596525, 5575.972120139373, 5576.386597474275, 5577.05190117681, 5580.693061881554, 5464.371597266365, 5556.472135147154, 5562.638428502134, 5569.498745112959, 5588.692621905834, 5553.972230138905, 5557.333120025542, 5564.054110801174, 5565.1095824667855, 5610.410906854721, 4312.849050283287, 4314.439122914001, 4323.891902702458, 4325.589069038437, 4352.782360882006, 3841.519810023747, 3854.209886973164, 3888.319544079775, 3891.9416208756893, 3912.6087391260644, 5164.8192313268855, 5179.404368497596, 5181.53366197044, 5182.067227899014, 5226.3205783248695, 5520.558355331564, 5542.889142217214, 5545.889082218333, 5551.833444996657, 5553.222548843165, 5151.072806894795, 5202.401723801736, 5252.369715634149, 5255.08036093682, 5280.287161233261, 4752.310914917318, 4794.712317260975, 4796.496367881392, 4796.880077998008, 4841.540053694894, 5716.228309178207, 5758.88482230353, 5810.157527158538, 5850.853728656818, 5855.092460668603, 5579.721013949367, 5605.551555875439, 5631.380548139619, 5634.4365563443325, 5704.344000440003, 5785.942140578541, 5809.215755873072, 5832.270966129234, 5849.61977471463, 5849.883002340014, 5502.559795216293, 5545.944540554543, 5556.916646250229, 5558.02734521449, 5601.103823388238, 5617.045102332695, 5622.7750889963945, 5623.493885550321, 5629.408912064175, 5659.26429564154, 5483.670979741229, 5488.067028605067, 5489.780408783604, 5490.505854473116, 5498.340199176125, 5426.131818908955, 5478.479544443271, 5536.474034966672, 5572.331320241597, 5599.552035837041, 5367.033933891937, 5370.865728356666, 5383.730813459233, 5386.542143917811, 5393.730313484231, 5449.809256675997, 5490.725463726878, 5491.6364719314315, 5509.779608815603, 5550.916736249041, 5378.247045413724, 5404.594655400782, 5460.180972854104, 5467.289252397163, 5522.337319521683], "unit": "score", "name": "dojo.html", "value": 5177.564212438046}, {"lowerIsBetter": false, "replicates": [532.4808311895902, 561.3600495435202, 574.1418612790027, 601.9337872833989, 610.1823556434377, 36762.44856327157, 37638.81180594097, 37641.81179094107, 37675.62324376756, 37681.623183768155, 41261.17477650453, 41825.7908710456, 41970.160596788046, 42034.159316813646, 42040.57959420405, 8523.616437260338, 8726.127387261287, 8729.7817554561, 8746.825063498727, 8747.693830715927, 8519.787005324855, 8632.525211113387, 8641.0, 8647.610857511427, 8653.913460865373, 8893.911060889406, 8940.776480588005, 8960.148785865365, 8967.372283940094, 8976.147266009719, 8848.955755221215, 8917.331200160013, 8922.598483068212, 8929.374943753939, 8932.508712020868, 8705.651773929036, 8828.249598784047, 8843.11568843117, 8843.159899809507, 8846.15961483658, 40944.59055409438, 41365.58634413678, 41380.79309603463, 41409.58590414088, 41483.377749333784, 3335.5497007903864, 3355.07735372772, 3376.206591451007, 3468.9653103468895, 3619.819009049563, 30409.695903041127, 30526.0, 30737.0, 31897.564609592624, 31903.6809631903, 3880.3985382265796, 3916.2167566486532, 3938.2714197873483, 3950.170464202521, 4121.835126594932, 200656.0, 200686.0, 200836.0, 200939.0, 202368.0, 53723.46276537263, 54679.17981230285, 59512.70243648754, 59666.10500842491, 59698.70150649219, 64295.0, 65297.34702653008, 65300.40847753419, 65367.0, 65649.34350656527, 15645.139517326656, 15662.765058524132, 15797.289121989537, 15855.68288634244, 15861.682766344838, 10479.790404191874, 10641.627543035956, 11917.344546049877, 12343.19769214998, 12344.3827808611, 19359.47647612904, 20310.289139880035, 20502.282420115225, 20590.794092059186, 20607.175712971613, 7682.347000504908, 7823.374130069581, 7864.449488535862, 7882.724104656424, 7885.723999659985, 1007.0181572966445, 1043.4782608695652, 1060.3531845574194, 1081.799867024603, 1205.1262834444958, 29917.0, 30343.0, 30401.847990760347, 30703.69296307053, 30913.84543077315, 1082.2370228988543, 1099.4502748625687, 1118.6420345489366, 1127.6617014895498, 1150.3385553306882, 15572.221388930508, 16170.191490425432, 16343.64638129201, 16846.494605161864, 17086.48740537786, 305988.0, 312049.0, 312354.0, 312502.0, 312650.0, 54158.72920635372, 54401.455985439636, 54445.72777136168, 54447.18329225065, 54456.18315725267, 1250.787366147757, 1367.9521216757564, 1396.958091257264, 1405.4097279142784, 1413.6889884225454, 28753.0, 28944.56583151212, 29537.556936646397, 29801.403971920874, 30080.69919300779, 40412.393814092226, 40673.0, 41578.79210603928, 43775.0, 49892.750536247084, 235681.0, 236694.0, 238239.0, 238683.0, 238744.0, 30477.390452191277, 30783.2304192397, 30912.227194320323, 30925.0, 30957.380852382375, 42910.141797164506, 43155.78422107869, 43412.78293608512, 44192.0, 44366.77816610896, 35615.46576801298, 35672.464913025804, 35882.0, 36074.0, 36826.447603286506, 36307.45538816867, 36750.8162459186, 36759.26481470302, 37128.44307335338, 37161.25677486381, 37264.0, 37359.06602334963, 37842.0, 38033.04917377088, 38460.61539384571, 28397.432051359272, 28517.144485665463, 30634.387312254075, 31735.639468444617, 32202.35595288128, 22036.559268814854, 22192.88903555472, 22366.77633223712, 22419.887900560392, 22623.660645090666], "unit": "score", "name": "ext.html", "value": 18409.302514471598}, {"lowerIsBetter": false, "replicates": [373.09338307911764, 373.61575363279053, 373.67303609341815, 374.14134561182084, 381.4183370360202, 13066.93466532666, 14483.92758036211, 15968.995333379764, 17292.394766183184, 17798.822011779877, 10866.076383507412, 11244.269122507052, 15505.302261398236, 15740.606484837885, 15741.370345186178, 3763.5483741950866, 4881.999999999991, 5013.548780609744, 5026.84919452417, 5028.421731500869, 5132.23016547519, 5395.973020134894, 5404.891902161954, 5425.538829199523, 5427.348718153808, 5281.128613778722, 5321.175217841241, 5346.732663366816, 5494.395616482204, 5497.835064948058, 5419.349678038621, 5424.891502169974, 5433.782648694048, 5460.590455715837, 5476.17857321403, 5351.973240133774, 5359.9732001340135, 5361.356637203521, 5363.839084827461, 5364.6512976656395, 13078.86921130786, 13110.606681799562, 13112.082154249207, 13124.343782810822, 19682.0, 2093.4243083152255, 2099.979000210009, 2108.8840113793735, 2169.4359466538654, 2643.6431081803903, 9086.50024248666, 9469.242460603135, 9477.952610236905, 9640.75898102546, 9879.802403951953, 1792.7221280701513, 1880.887146771198, 1890.981090189108, 1897.3928342930267, 1970.8226259636558, 62067.37932620661, 64497.0, 64959.67520162416, 65408.67295663491, 66041.66979165122, 9870.358426702242, 10136.54385552652, 10319.432431216204, 10340.482975851177, 10400.375977441377, 12799.552015679592, 13614.251216183007, 13620.93189534046, 13663.453461861613, 13679.589612311647, 7559.0, 7786.4938778979185, 8031.477953933093, 8070.2333278338465, 8081.313088387553, 7874.173211812792, 7981.3614910807, 8017.7995550110545, 8074.071481779553, 8076.9192308077345, 4154.210699966997, 4320.762358070274, 4456.131054444417, 4522.706024108423, 4585.587297143273, 1802.089944578006, 1822.3916645042889, 1838.5495553589456, 1868.1873385077263, 1869.2336142181641, 982.5922242269521, 994.4132961552718, 1022.3354819367471, 1032.5766435761302, 1100.3672888089382, 14610.26948652563, 15429.845701543065, 16889.23998420074, 17258.82741172572, 17300.567485812702, 919.3426699909596, 923.9882328849899, 974.4883935933692, 977.6627063663025, 1028.8559601655775, 8941.59762810675, 9249.445033298023, 9281.350305478687, 9283.535823208813, 9429.0, 514828.0, 515779.0, 518292.0, 544047.0, 556529.0, 69177.0, 74748.62625686837, 76522.61738691383, 77902.0, 80479.0, 1181.0551558753134, 1184.1000839362148, 1216.3431746856597, 1219.1709637446445, 1255.0, 14960.551183464513, 15209.543713688607, 15340.92329538345, 15444.0, 15622.140782257085, 30992.22519437032, 31314.843425782725, 31585.52621710722, 31669.683303167596, 32127.357452850345, 46102.53897460982, 48878.511214887396, 50721.239181413046, 51147.23279150741, 51464.22803658023, 7459.589722565311, 7697.076350837935, 7759.418043646862, 7817.452778305692, 7836.490628109154, 9204.815903682023, 11222.60720874798, 11428.828567571327, 11570.537178512765, 11992.520299188283, 8201.507909525448, 9921.15670168015, 10556.630517932143, 10679.87861274555, 10703.143748500257, 9730.124288813757, 9771.609135634495, 9935.552900119657, 10124.493775311352, 10300.175985920958, 9944.950275248577, 9956.502174891371, 10152.0, 10262.948685256824, 10350.327228730108, 7347.228541003332, 7552.0, 7571.0, 7580.393568514616, 7585.469017168966, 9247.30645201626, 10222.48887555634, 10299.794004119725, 10389.324693894872, 10400.791984160425], "unit": "score", "name": "jquery.html", "value": 8250.424316226019}, {"lowerIsBetter": false, "replicates": [1331.5406184866217, 1496.7680009598512, 1513.152634524666, 1677.547062293181, 1803.4589623113063, 7173.06750122484, 7663.8084047898765, 7795.415343849206, 7812.179721129285, 7849.411294152933, 7526.322630963212, 7687.577183254919, 7689.653965571549, 7699.884501732478, 7703.229677032294, 2021.1208124465904, 2063.8968051597362, 2064.3394113883564, 2338.8830558472096, 2365.38499990003, 2040.540878302385, 2288.0, 2323.0, 2339.7660233976635, 2347.0377145370403, 2218.0684112672716, 2225.410266279437, 2233.944151396212, 2275.1695631094613, 2276.3398614401804, 2279.939827979997, 2310.757370476101, 2319.1998760427628, 2324.418895276181, 2349.682792822964, 2305.7694230576976, 2323.7560056194025, 2323.8954247058755, 2328.2316835444262, 2335.5679199348006, 7842.254985776342, 7890.368770498347, 7894.092179399385, 7896.644650990719, 7898.447108702393, 4783.473817880031, 4864.124457597631, 4921.680090794087, 4928.33467481889, 4933.333999910002, 3171.7462602991704, 3206.6633003534757, 3209.8395080246128, 3224.0, 3225.1130938991732, 993.145894530703, 1005.3515482513811, 1027.1731256338644, 1048.3605000949415, 1053.9051485366354, 10592.523336449878, 10743.462826858626, 10749.731256718567, 10753.354798712102, 10765.569377224901, 4412.205802955499, 4491.88770280739, 4503.392042074343, 4510.661700372485, 4558.361829343895, 9277.072292770668, 9283.25733941283, 9289.814203715889, 9302.441853488812, 9305.860412093823, 4947.6536642434685, 4980.676256043345, 4981.32752078472, 4984.576311013604, 4988.326575912278, 4541.3188021797, 4552.089582083597, 4552.157850797613, 4553.772311384418, 4556.453225612948, 3492.7904325740537, 3733.2160246348026, 3735.2529494100745, 3811.2568049230135, 3857.1321452672923, 1217.3669691760413, 1245.0413181849924, 1247.644421339932, 1252.4614415801293, 1262.551794113095, 1330.8735670111323, 1338.899582531314, 1340.5978206538, 1345.5021641992525, 1370.4997675848244, 7257.237990011078, 7391.260873912674, 7428.925710742823, 7779.92220077792, 7837.7648670539975, 1134.2910680824484, 1134.615768762109, 1138.692553010699, 1150.1373969522858, 1165.6386520178603, 5781.277340332458, 5824.068149096124, 5829.038208695518, 5833.912491312633, 5837.9124313135335, 9014.729558113268, 9038.683646072355, 9137.634494620273, 9241.353105282566, 9323.720288391223, 9225.677101301422, 9229.769255768526, 9233.815323693489, 9242.21441177494, 9253.306002049872, 7208.855822883513, 7341.412686985029, 7403.962980185064, 7432.405407567381, 7464.0, 7370.889436658347, 7447.031885854804, 7451.962740186481, 7459.925400745923, 7467.514611550232, 8247.134050924567, 8306.875396869173, 8500.149985001697, 8647.092055334351, 8651.307895368229, 8190.140035296208, 8265.669373225004, 8395.664173432995, 8408.831823363376, 8409.159084091541, 6601.075849381186, 6744.460443164437, 6771.729130834711, 6775.864482710417, 6776.288489708707, 6532.444742196776, 7123.715051397886, 7500.474966752493, 7649.158592554703, 7697.923020769945, 7225.24134965821, 7316.9634151828905, 7361.558306501627, 7432.219616940143, 7459.36595389398, 6970.11806812168, 7107.076080109553, 7182.820429489305, 7187.712491500281, 7391.0761154855645, 6972.267911869383, 6973.755918542826, 6974.442044636518, 6979.685914133977, 7010.649467526501, 6347.809565713036, 6715.160604924385, 6715.294894036056, 6719.428848547733, 6721.395074443323, 6758.0, 6790.151231096113, 6796.18445786489, 6802.829929251809, 6813.557118787263], "unit": "score", "name": "mootools.html", "value": 4574.021641658133}, {"lowerIsBetter": false, "replicates": [337.4651177883055, 352.1495588154607, 352.1513153300546, 356.9821508924553, 362.49070056570525, 5864.501517371029, 6013.518918486516, 6030.849228769283, 6065.514758819295, 6071.028635418339, 5769.249997500329, 5948.821535353935, 5966.79116230932, 5983.700814959257, 5993.310769261536, 4678.485366609671, 4682.789274482648, 4684.039771846763, 4688.765561721901, 4691.835785747499, 4491.640668746509, 4545.909081818361, 4645.27998160284, 4658.534146585348, 4687.132880417117, 4577.725336479822, 4588.013577080927, 4612.3542704021465, 4612.377329060568, 4617.6536759742985, 4607.631389488833, 4623.214053610861, 4626.398568186114, 4626.791794369228, 4626.953730462686, 4091.89770255743, 4092.7953602319767, 4095.3242714952, 4099.077707515815, 4099.877003689894, 5623.578231632644, 5728.62763920348, 5741.110127930177, 5745.683987380692, 5750.942490575083, 5402.810901618424, 5414.10667239905, 5421.9457805421835, 5422.891542169174, 5425.701586412746, 6106.48094911933, 6375.521835862329, 6375.744970201186, 6377.489800815923, 6387.073874288202, 4412.448443944507, 4487.416635837353, 4497.640188784922, 4528.479224889114, 4536.047430039695, 6620.404163625249, 6628.138342015555, 6637.601743895381, 6641.402273795382, 6644.900326495106, 4673.299005149255, 4677.3919390479705, 4681.67228294023, 4685.882852928636, 4693.55411235932, 4638.628909687217, 4728.172569800271, 4728.486884197024, 4732.597729193058, 4750.334953106568, 5421.105517589633, 5427.158790387496, 5428.131498960148, 5430.8099216527235, 5432.375276843135, 6417.550771446047, 6422.839429014312, 6427.357264273629, 6432.099506069154, 6432.646204458706, 1658.3449537432646, 1681.3106626283165, 1682.528891910267, 1683.7053515634716, 1684.5451728033363, 1063.9308444951052, 1095.1567293184362, 1096.6107032003683, 1110.7833972375308, 1168.1297433412162, 6003.039513677878, 6062.454379105901, 6071.089336599545, 6071.362506936796, 6102.176206212193, 6554.14796076507, 6563.573367731177, 6564.376384243489, 6570.934290657128, 6587.901181482282, 6074.635521868614, 6084.148219249309, 6085.0, 6143.938560614426, 6146.139540464339, 3446.724262059029, 3547.166415892263, 3548.8757893473603, 3552.1652411683235, 3555.253396786652, 6869.965650171717, 6870.3473170048765, 6872.41584465316, 6874.518783685194, 6882.070920425778, 6657.1012913257055, 6683.5989840608745, 6689.665516724144, 6709.7651582194385, 6716.697748601325, 6687.799366019027, 6812.182538095461, 6831.69257383409, 6842.7605033823575, 6854.657267136524, 6392.648404337806, 6498.837529061811, 6550.508711846535, 6555.704993275219, 6625.238097618835, 6464.709088090953, 6483.708233129426, 6495.253045899782, 6578.8355291118105, 6588.374104460068, 6863.450923925974, 6872.931270687229, 6941.0629565010095, 6946.027556142245, 6959.164900212007, 4466.28539433702, 4502.842400515966, 4546.772661366852, 4553.2942393929, 4556.794944227451, 6670.099536562502, 6678.098456708282, 6678.766243181465, 6691.297413771484, 6697.3637504437, 6488.2538508072175, 6494.0, 6508.479321654161, 6509.576877502947, 6509.837254068686, 6387.584806987531, 6416.390442907917, 6492.220933487823, 6493.155889734304, 6498.642574658439, 6335.683215839282, 6338.904916426165, 6339.4928405726505, 6341.334159913143, 6342.460890824332, 6514.967425162844, 6518.380753828379, 6518.902216466851, 6526.9347306528225, 6532.281449040697, 6204.968975155276, 6359.777407790705, 6370.8088757337355, 6381.968090159705, 6398.680065996588], "unit": "score", "name": "prototype.html", "value": 4859.321763150251}, {"lowerIsBetter": false, "replicates": [804.6298702596802, 807.8424707182102, 819.3527113580271, 827.9047909490408, 829.1429874934294, 13738.0, 14053.227072511008, 14071.788923166148, 14111.71776564468, 14127.71744565108, 13077.934610326958, 13192.802107968388, 13273.668158296023, 13284.867151328484, 13309.334533273322, 688.5902887781762, 699.6711545573572, 818.5866137600503, 825.154216927651, 834.4492634860993, 832.5129799067553, 841.3269384492412, 847.2290215903529, 853.6628031927416, 853.9786505337354, 888.076400543434, 891.2157301574605, 891.9464832110061, 892.0544223123477, 892.2906289499831, 705.048184950318, 848.3043903998692, 865.0311650950912, 868.1405408645395, 886.2422628652506, 637.677972623822, 639.4756299834138, 640.1230314469207, 640.3756337570878, 640.6636515829181, 13878.583642490741, 13898.722025559533, 13941.372638231303, 13948.2328471934, 13958.162510249316, 12934.676633084155, 12987.0, 13130.0, 13407.128536645087, 13463.192208467523, 10806.945965270203, 10962.342259464458, 10968.17738669595, 11122.833157502644, 11275.32348059119, 3644.671979521856, 3678.7792732435873, 3714.7956862372557, 3790.9431358529646, 3795.905102372435, 46615.30077048847, 46658.76670616659, 46763.766181168874, 47329.52670473286, 47480.0, 10300.330478518872, 10578.10086142671, 10713.678589642168, 10773.192010599236, 11005.559777608805, 19031.714524282146, 19127.33054343119, 19193.232270709294, 19197.0, 19209.0, 7154.785356439315, 7475.140358858801, 7724.343430808444, 7796.064472263251, 8000.919990800134, 4312.094460163338, 4454.844080457233, 4467.977660111678, 4484.618807401407, 4533.7279763213655, 3158.652548219694, 3179.205198700325, 3191.984040079785, 3196.2009497625595, 3197.1367730712577, 572.7823427097676, 575.0454245951701, 581.520245797219, 588.8115802943017, 607.341034977046, 582.6183849578533, 589.7316720891984, 591.3199820206711, 605.19757920968, 616.7841255560518, 8663.870041949376, 9250.953745231365, 9305.022972587782, 9337.159655631025, 9357.578908949114, 603.7434090511515, 663.4305009445676, 683.719674933275, 685.3283781893772, 701.7298340139083, 3661.359262129117, 3686.2258925625383, 4011.2779699654343, 4494.752788596658, 4587.3348364486965, 56805.431945680844, 58541.41458585445, 58707.0, 59045.0, 59314.0, 50224.74887625612, 50368.496315036384, 50755.0, 50985.745071275145, 51043.0, 46268.305975410396, 46473.76763116163, 46636.3004554932, 46793.29810052852, 46852.0, 8895.421797583136, 9250.352475326663, 9420.528973551433, 9421.905780942103, 9426.528673566158, 35033.29933401369, 35278.82360588181, 35523.289534208656, 35799.46300805438, 35944.460833087, 45074.3238851424, 45077.0, 45338.773306133255, 45824.770876145405, 45879.31181032221, 11156.330620162817, 11522.0, 11568.305901645928, 11607.36159511235, 11762.294262344287, 11310.151738619801, 11381.235908434206, 11532.077433805107, 11791.115666324888, 12345.382730863601, 11977.161598688008, 12148.635540933787, 12172.2696638202, 12325.630231093082, 12600.495980161058, 11136.220464567403, 11284.887151128713, 11382.0, 11831.053515718893, 11891.82162267584, 11208.719782005515, 11450.0, 11495.0, 11799.52801887915, 11993.520259189883, 9536.0, 9925.1067403934, 9960.701030109327, 10106.039926206999, 10251.179905607683, 9483.857742133736, 10377.792444151226, 10464.947675261576, 10471.842922356323, 10485.633002844865], "unit": "score", "name": "yui.html", "value": 6465.059441449083}], "name": "dromaeo_css", "value": 6953.237410991986}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 107.0, 110.0, 112.0, 111.0, 103.0, 112.0, 113.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 155.0, 167.0, 129.0, 157.0, 152.0, 126.0, 170.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 165.0, 162.0, 163.0, 163.0, 163.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 100.0, 93.0, 76.0, 75.0, 74.0, 117.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 150.0, 95.0, 96.0, 96.0, 139.0, 96.0, 97.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 117.0, 116.0, 115.0, 115.0, 115.0, 115.0, 119.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 56.0, 56.0, 57.0, 56.0, 56.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 86.0, 84.0, 89.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.2}, {"lowerIsBetter": true, "replicates": [124.0, 118.0, 118.0, 123.0, 115.0, 116.0, 120.0, 120.0, 125.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [152.0, 146.0, 152.0, 152.0, 162.0, 144.0, 151.0, 154.0, 152.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 67.0, 68.0, 70.0, 67.0, 71.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1521.5}]} 22:37:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1521.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6953.23"}}} 22:37:03 INFO - Return code: 0 22:37:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:37:03 INFO - # TBPL SUCCESS # 22:37:03 INFO - Running post-action listener: _resource_record_post_action 22:37:03 INFO - Running post-run listener: _resource_record_post_run 22:37:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 16384; Write bytes: 552165376; Read time: 40; Write time: 404792 22:37:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253734912; Read time: 0; Write time: 210536 22:37:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 16384; Write bytes: 298225664; Read time: 40; Write time: 194240 22:37:04 INFO - Running post-run listener: _upload_blobber_files 22:37:04 INFO - Blob upload gear active. 22:37:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:37:04 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:37:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:37:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:37:04 INFO - (blobuploader) - INFO - Open directory for files ... 22:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:05 INFO - (blobuploader) - INFO - Done attempting. 22:37:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:37:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:37:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:37:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:37:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:37:06 INFO - (blobuploader) - INFO - Done attempting. 22:37:06 INFO - (blobuploader) - INFO - Iteration through files over. 22:37:06 INFO - Return code: 0 22:37:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:37:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:37:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb707f4bfe3f2566c788eefb7f1f6665cdd7bd3a8e5369c126f8275398fbdf64630b7ab3eca83497cc4f944ef37a9b66bba7f9859ee5441c84b5222638d6a8c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/985a89ac9dd8c768c492e9456c00eea23ff495eba2f2cb8260c2be50b828413463d47da475dd535c94468dda24bf9e0ca06ad435ac559cc77f192219047e5b16"} 22:37:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:37:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:37:06 INFO - Contents: 22:37:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb707f4bfe3f2566c788eefb7f1f6665cdd7bd3a8e5369c126f8275398fbdf64630b7ab3eca83497cc4f944ef37a9b66bba7f9859ee5441c84b5222638d6a8c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/985a89ac9dd8c768c492e9456c00eea23ff495eba2f2cb8260c2be50b828413463d47da475dd535c94468dda24bf9e0ca06ad435ac559cc77f192219047e5b16"} 22:37:06 INFO - Running post-run listener: copy_logs_to_upload_dir 22:37:06 INFO - Copying logs to upload dir... 22:37:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:37:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.483249 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-02-06 22:37:05.577266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 22:37:05.580804) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb707f4bfe3f2566c788eefb7f1f6665cdd7bd3a8e5369c126f8275398fbdf64630b7ab3eca83497cc4f944ef37a9b66bba7f9859ee5441c84b5222638d6a8c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/985a89ac9dd8c768c492e9456c00eea23ff495eba2f2cb8260c2be50b828413463d47da475dd535c94468dda24bf9e0ca06ad435ac559cc77f192219047e5b16"} build_url:https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb707f4bfe3f2566c788eefb7f1f6665cdd7bd3a8e5369c126f8275398fbdf64630b7ab3eca83497cc4f944ef37a9b66bba7f9859ee5441c84b5222638d6a8c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/985a89ac9dd8c768c492e9456c00eea23ff495eba2f2cb8260c2be50b828413463d47da475dd535c94468dda24bf9e0ca06ad435ac559cc77f192219047e5b16"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 22:37:05.605060) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:37:05.605460) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1454822518.272661-535789047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:37:05.687935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 22:37:05.688227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 22:37:05.688519) ========= ========= Total master_lag: 0.28 =========