builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1454825767.32 results: success (0) buildid: 20160206193305 builduid: 9b65eaa64e9c4e1c86b339519887f171 revision: 76733110704b975154ac0fa779445e6eae5da559 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.322648) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.323070) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.323397) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.390257) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.390592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.435609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.435934) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.495265) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.495565) ========= 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:07.496162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.499553) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 22:16:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-02-06 22:16:07 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.618768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.619114) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020648 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:07.672027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 22:16:07.672552) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 22:16:07,897 truncating revision to first 12 chars 2016-02-06 22:16:07,897 Setting DEBUG logging. 2016-02-06 22:16:07,897 attempt 1/10 2016-02-06 22:16:07,897 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:08,991 unpacking tar archive at: mozilla-central-76733110704b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370261 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 22:16:09.056600) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:09.057124) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76733110704b975154ac0fa779445e6eae5da559 program finished with exit code 0 elapsedTime=0.004647 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:09.108467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:09.108855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 22:16:09.119514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-06 22:16:09.119914) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:16:09 INFO - MultiFileLogger online at 20160206 22:16:09 in /builds/slave/test-pgo 22:16:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:16:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:16:09 INFO - {'append_to_log': False, 22:16:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:16:09 INFO - 'blob_upload_branch': 'Firefox', 22:16:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:16:09 INFO - 'branch': 'Firefox', 22:16:09 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:09 INFO - 'config_files': ('talos/linux_config.py',), 22:16:09 INFO - 'default_actions': ('clobber', 22:16:09 INFO - 'read-buildbot-config', 22:16:09 INFO - 'download-and-extract', 22:16:09 INFO - 'populate-webroot', 22:16:09 INFO - 'create-virtualenv', 22:16:09 INFO - 'install', 22:16:09 INFO - 'run-tests'), 22:16:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:09 INFO - 'download_minidump_stackwalk': True, 22:16:09 INFO - 'download_symbols': 'ondemand', 22:16:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:09 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:09 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:09 INFO - 'installer_path': 'installer.exe', 22:16:09 INFO - 'log_level': 'info', 22:16:09 INFO - 'log_name': 'talos', 22:16:09 INFO - 'log_to_console': True, 22:16:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:16:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:16:09 INFO - 'opt_config_files': (), 22:16:09 INFO - 'pip_index': False, 22:16:09 INFO - 'sps_profile': False, 22:16:09 INFO - 'sps_profile_interval': 0, 22:16:09 INFO - 'suite': 'dromaeojs-e10s', 22:16:09 INFO - 'system_bits': '32', 22:16:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:09 INFO - 'title': 'talos-linux64-ix-050', 22:16:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:09 INFO - 'use_talos_json': True, 22:16:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:16:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:09 INFO - 'work_dir': 'build'} 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running clobber step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: clobber 22:16:09 INFO - rmtree: /builds/slave/test-pgo/build 22:16:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:16:09 INFO - Running post-action listener: _resource_record_post_action 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running read-buildbot-config step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: read_buildbot_config 22:16:09 INFO - Using buildbot properties: 22:16:09 INFO - { 22:16:09 INFO - "project": "", 22:16:09 INFO - "product": "firefox", 22:16:09 INFO - "script_repo_revision": "production", 22:16:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:16:09 INFO - "repository": "", 22:16:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:16:09 INFO - "buildid": "20160206193305", 22:16:09 INFO - "pgo_build": "True", 22:16:09 INFO - "basedir": "/builds/slave/test-pgo", 22:16:09 INFO - "buildnumber": 99, 22:16:09 INFO - "slavename": "talos-linux64-ix-050", 22:16:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:16:09 INFO - "platform": "ubuntu64_hw", 22:16:09 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:16:09 INFO - "branch": "mozilla-central", 22:16:09 INFO - "repo_path": "mozilla-central", 22:16:09 INFO - "revision": "76733110704b975154ac0fa779445e6eae5da559", 22:16:09 INFO - "stage_platform": "linux64-pgo", 22:16:09 INFO - "builduid": "9b65eaa64e9c4e1c86b339519887f171", 22:16:09 INFO - "slavebuilddir": "test" 22:16:09 INFO - } 22:16:09 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:09 INFO - Running post-action listener: _resource_record_post_action 22:16:09 INFO - ##### 22:16:09 INFO - ##### Running download-and-extract step. 22:16:09 INFO - ##### 22:16:09 INFO - Running pre-action listener: _resource_record_pre_action 22:16:09 INFO - Running main action method: download_and_extract 22:16:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:16: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:16:09 INFO - https://queue.taskcluster.net/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:16:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json 22:16:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cPjTN9tCQ4CKoduTnryeDg/artifacts/public/build/test_packages.json 22:16:09 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:09 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:12 INFO - Downloaded 1448 bytes. 22:16:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:16:12 INFO - Using the following test package requirements: 22:16:12 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:12 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:16:12 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:16:12 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'jsshell-linux-x86_64.zip'], 22:16:12 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:16:12 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:12 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:16:12 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:16:12 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:16:12 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:16:12 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:16:12 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:16:12 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:16:12 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:12 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:12 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:12 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:12 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:12 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:14 INFO - Downloaded 23575457 bytes. 22:16:14 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:14 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:15 INFO - Return code: 0 22:16:15 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:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:15 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:15 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:15 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:15 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:15 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:18 INFO - Downloaded 23575457 bytes. 22:16:18 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:18 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:19 INFO - Return code: 0 22:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:19 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:19 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:19 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:19 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:19 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:20 INFO - Downloaded 10706547 bytes. 22:16:20 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:20 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:20 INFO - Return code: 0 22:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:20 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:20 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:20 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:20 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:20 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:22 INFO - Downloaded 56564873 bytes. 22:16:22 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:22 INFO - mkdir: /builds/slave/test-pgo/properties 22:16:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:16:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:16:22 INFO - Contents: 22:16:22 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:22 INFO - Running post-action listener: _resource_record_post_action 22:16:22 INFO - Running post-action listener: set_extra_try_arguments 22:16:22 INFO - ##### 22:16:22 INFO - ##### Running populate-webroot step. 22:16:22 INFO - ##### 22:16:22 INFO - Running pre-action listener: _resource_record_pre_action 22:16:22 INFO - Running main action method: populate_webroot 22:16:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:16:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:16:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:16:22 INFO - '--tppagecycles', 22:16:22 INFO - '7'], 22:16:22 INFO - 'tests': ['tsvgm']}}, 22:16:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:16:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:16:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:16:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:16:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['damp', 'tps']}, 22:16:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['damp', 'tps']}, 22:16:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:16:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:16:22 INFO - 'other': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other_l64': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'other_nol64': {'tests': ['a11yr', 22:16:22 INFO - 'ts_paint', 22:16:22 INFO - 'tpaint', 22:16:22 INFO - 'sessionrestore', 22:16:22 INFO - 'sessionrestore_no_auto_restore']}, 22:16:22 INFO - 'svgr': {'tests': ['tsvgx', 22:16:22 INFO - 'tsvgr_opacity', 22:16:22 INFO - 'tart', 22:16:22 INFO - 'tscrollx', 22:16:22 INFO - 'cart']}, 22:16:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tsvgx', 22:16:22 INFO - 'tsvgr_opacity', 22:16:22 INFO - 'tart', 22:16:22 INFO - 'tscrollx', 22:16:22 INFO - 'cart']}, 22:16:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'tests': ['tp5o']}, 22:16:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s'], 22:16:22 INFO - 'tests': ['tp5o']}, 22:16:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--xperf_path', 22:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:22 INFO - 'tests': ['tp5n']}, 22:16:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:22 INFO - 'talos_options': ['--e10s', 22:16:22 INFO - '--xperf_path', 22:16:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:22 INFO - 'tests': ['tp5n']}}, 22:16:22 INFO - 'talos.zip': {'path': '', 22:16:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:16:22 INFO - Running post-action listener: _resource_record_post_action 22:16:22 INFO - ##### 22:16:22 INFO - ##### Running create-virtualenv step. 22:16:22 INFO - ##### 22:16:22 INFO - Running pre-action listener: _resource_record_pre_action 22:16:22 INFO - Running main action method: create_virtualenv 22:16:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:16:22 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:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:16:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:16:22 INFO - Using real prefix '/usr' 22:16:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 22:16:25 INFO - Installing pip.................done. 22:16:25 INFO - Return code: 0 22:16:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 22:16:25 INFO - 'HOME': '/home/cltbld', 22:16:25 INFO - 'LANG': 'en_US.UTF-8', 22:16:25 INFO - 'LANGUAGE': 'en_US:en', 22:16:25 INFO - 'LOGNAME': 'cltbld', 22:16:25 INFO - 'MAIL': '/var/mail/cltbld', 22:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:25 INFO - 'MOZ_NO_REMOTE': '1', 22:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:25 INFO - 'NO_EM_RESTART': '1', 22:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:25 INFO - 'SHELL': '/bin/bash', 22:16:25 INFO - 'SHLVL': '1', 22:16:25 INFO - 'TERM': 'linux', 22:16:25 INFO - 'TMOUT': '86400', 22:16:25 INFO - 'USER': 'cltbld', 22:16:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:25 INFO - '_': '/tools/buildbot/bin/python'} 22:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:25 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:25 INFO - Cleaning up... 22:16:25 INFO - Return code: 0 22:16:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:25 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 22:16:25 INFO - 'HOME': '/home/cltbld', 22:16:25 INFO - 'LANG': 'en_US.UTF-8', 22:16:25 INFO - 'LANGUAGE': 'en_US:en', 22:16:25 INFO - 'LOGNAME': 'cltbld', 22:16:25 INFO - 'MAIL': '/var/mail/cltbld', 22:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:25 INFO - 'MOZ_NO_REMOTE': '1', 22:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:25 INFO - 'NO_EM_RESTART': '1', 22:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:25 INFO - 'SHELL': '/bin/bash', 22:16:25 INFO - 'SHLVL': '1', 22:16:25 INFO - 'TERM': 'linux', 22:16:25 INFO - 'TMOUT': '86400', 22:16:25 INFO - 'USER': 'cltbld', 22:16:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:25 INFO - '_': '/tools/buildbot/bin/python'} 22:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:25 INFO - Downloading/unpacking psutil>=0.7.1 22:16:25 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:25 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:25 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:25 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:25 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:25 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:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:27 INFO - Installing collected packages: psutil 22:16:27 INFO - Running setup.py install for psutil 22:16:27 INFO - building 'psutil._psutil_linux' extension 22:16:27 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:27 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:27 INFO - building 'psutil._psutil_posix' extension 22:16:27 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:28 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:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:16:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:16:28 INFO - Successfully installed psutil 22:16:28 INFO - Cleaning up... 22:16:28 INFO - Return code: 0 22:16:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:16: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:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16: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:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:28 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 22:16:28 INFO - 'HOME': '/home/cltbld', 22:16:28 INFO - 'LANG': 'en_US.UTF-8', 22:16:28 INFO - 'LANGUAGE': 'en_US:en', 22:16:28 INFO - 'LOGNAME': 'cltbld', 22:16:28 INFO - 'MAIL': '/var/mail/cltbld', 22:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:28 INFO - 'MOZ_NO_REMOTE': '1', 22:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:28 INFO - 'NO_EM_RESTART': '1', 22:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:28 INFO - 'SHELL': '/bin/bash', 22:16:28 INFO - 'SHLVL': '1', 22:16:28 INFO - 'TERM': 'linux', 22:16:28 INFO - 'TMOUT': '86400', 22:16:28 INFO - 'USER': 'cltbld', 22:16:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:28 INFO - '_': '/tools/buildbot/bin/python'} 22:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:16:28 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:28 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:28 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:28 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:28 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:28 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:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:16:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:16:30 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:30 INFO - Installing collected packages: mozsystemmonitor 22:16:30 INFO - Running setup.py install for mozsystemmonitor 22:16:30 INFO - Successfully installed mozsystemmonitor 22:16:30 INFO - Cleaning up... 22:16:30 INFO - Return code: 0 22:16:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:16:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:16:30 INFO - Using env: {'DISPLAY': ':0', 22:16:30 INFO - 'HOME': '/home/cltbld', 22:16:30 INFO - 'LANG': 'en_US.UTF-8', 22:16:30 INFO - 'LANGUAGE': 'en_US:en', 22:16:30 INFO - 'LOGNAME': 'cltbld', 22:16:30 INFO - 'MAIL': '/var/mail/cltbld', 22:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:30 INFO - 'MOZ_NO_REMOTE': '1', 22:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:30 INFO - 'NO_EM_RESTART': '1', 22:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:30 INFO - 'SHELL': '/bin/bash', 22:16:30 INFO - 'SHLVL': '1', 22:16:30 INFO - 'TERM': 'linux', 22:16:30 INFO - 'TMOUT': '86400', 22:16:30 INFO - 'USER': 'cltbld', 22:16:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:30 INFO - '_': '/tools/buildbot/bin/python'} 22:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:30 INFO - Downloading/unpacking blobuploader==1.2.4 22:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 22:16:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:16:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:16:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:33 INFO - Downloading docopt-0.6.1.tar.gz 22:16:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 22:16:33 INFO - Running setup.py install for blobuploader 22:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:16:33 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:16:33 INFO - Running setup.py install for requests 22:16:33 INFO - Running setup.py install for docopt 22:16:33 INFO - Successfully installed blobuploader requests docopt 22:16:33 INFO - Cleaning up... 22:16:33 INFO - Return code: 0 22:16:33 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:33 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 22:16:33 INFO - 'HOME': '/home/cltbld', 22:16:33 INFO - 'LANG': 'en_US.UTF-8', 22:16:33 INFO - 'LANGUAGE': 'en_US:en', 22:16:33 INFO - 'LOGNAME': 'cltbld', 22:16:33 INFO - 'MAIL': '/var/mail/cltbld', 22:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:33 INFO - 'MOZ_NO_REMOTE': '1', 22:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:33 INFO - 'NO_EM_RESTART': '1', 22:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:33 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:33 INFO - 'SHELL': '/bin/bash', 22:16:33 INFO - 'SHLVL': '1', 22:16:33 INFO - 'TERM': 'linux', 22:16:33 INFO - 'TMOUT': '86400', 22:16:33 INFO - 'USER': 'cltbld', 22:16:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:33 INFO - '_': '/tools/buildbot/bin/python'} 22:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:16:34 INFO - Running setup.py (path:/tmp/pip-MmuQA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:16:34 INFO - Running setup.py (path:/tmp/pip-ipxmNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:16:34 INFO - Running setup.py (path:/tmp/pip-Uv__U6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:16:34 INFO - Running setup.py (path:/tmp/pip-_vyBg8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:16:34 INFO - Running setup.py (path:/tmp/pip-USUsJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:16:34 INFO - Running setup.py (path:/tmp/pip-n7d_h1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:16:34 INFO - Running setup.py (path:/tmp/pip-nIJ_Lh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:16:34 INFO - Running setup.py (path:/tmp/pip-boselX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:16:34 INFO - Running setup.py (path:/tmp/pip-HqiaMy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:16:34 INFO - Running setup.py (path:/tmp/pip-N9paHe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:16:34 INFO - Running setup.py (path:/tmp/pip-qnUPS7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:16:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:16:34 INFO - Running setup.py (path:/tmp/pip-vCtRWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:16:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:16:35 INFO - Running setup.py (path:/tmp/pip-uJleTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:16:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:16:35 INFO - Running setup.py (path:/tmp/pip-ed9ZY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:16:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:16:35 INFO - Running setup.py (path:/tmp/pip-Rqdxd9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:16:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:16:35 INFO - Running setup.py (path:/tmp/pip-Dayv_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:16:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:16:35 INFO - Running setup.py (path:/tmp/pip-T9MW4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:16:35 INFO - Running setup.py install for manifestparser 22:16:35 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:16:35 INFO - Running setup.py install for mozcrash 22:16:35 INFO - Running setup.py install for mozdebug 22:16:35 INFO - Running setup.py install for mozdevice 22:16:35 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:16:35 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:16:35 INFO - Running setup.py install for mozfile 22:16:35 INFO - Running setup.py install for mozhttpd 22:16:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozinfo 22:16:36 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozInstall 22:16:36 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozleak 22:16:36 INFO - Running setup.py install for mozlog 22:16:36 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for moznetwork 22:16:36 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozprocess 22:16:36 INFO - Running setup.py install for mozprofile 22:16:36 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozrunner 22:16:36 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:16:36 INFO - Running setup.py install for mozscreenshot 22:16:36 INFO - Running setup.py install for moztest 22:16:37 INFO - Running setup.py install for mozversion 22:16:37 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:16:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:16:37 INFO - Cleaning up... 22:16:37 INFO - Return code: 0 22:16:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:37 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:37 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:16:37 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:16:37 INFO - Using env: {'DISPLAY': ':0', 22:16:37 INFO - 'HOME': '/home/cltbld', 22:16:37 INFO - 'LANG': 'en_US.UTF-8', 22:16:37 INFO - 'LANGUAGE': 'en_US:en', 22:16:37 INFO - 'LOGNAME': 'cltbld', 22:16:37 INFO - 'MAIL': '/var/mail/cltbld', 22:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:37 INFO - 'MOZ_NO_REMOTE': '1', 22:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:37 INFO - 'NO_EM_RESTART': '1', 22:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:37 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:37 INFO - 'SHELL': '/bin/bash', 22:16:37 INFO - 'SHLVL': '1', 22:16:37 INFO - 'TERM': 'linux', 22:16:37 INFO - 'TMOUT': '86400', 22:16:37 INFO - 'USER': 'cltbld', 22:16:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:37 INFO - '_': '/tools/buildbot/bin/python'} 22:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:16:37 INFO - Running setup.py (path:/tmp/pip-WcjgZw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:16:37 INFO - Running setup.py (path:/tmp/pip-kHIUue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:16:37 INFO - Running setup.py (path:/tmp/pip-gQOuhP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:16:37 INFO - Running setup.py (path:/tmp/pip-2MgCYm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:16:37 INFO - Running setup.py (path:/tmp/pip-B02nyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:16:37 INFO - Running setup.py (path:/tmp/pip-P05EMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:16:37 INFO - Running setup.py (path:/tmp/pip-IOvXQv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:16:37 INFO - Running setup.py (path:/tmp/pip-4Oqkt1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:16:37 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:16:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:16:37 INFO - Running setup.py (path:/tmp/pip-edSEsb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:16:38 INFO - Running setup.py (path:/tmp/pip-2ozwVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:16:38 INFO - Running setup.py (path:/tmp/pip-xXoGwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:16:38 INFO - Running setup.py (path:/tmp/pip-W9p7tL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:16:38 INFO - Running setup.py (path:/tmp/pip-y4SmRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:16:38 INFO - Running setup.py (path:/tmp/pip-1SUOJU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:16:38 INFO - Running setup.py (path:/tmp/pip-7fn9Uq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:16:38 INFO - Running setup.py (path:/tmp/pip-MluCw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:16:38 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:16:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:16:38 INFO - Running setup.py (path:/tmp/pip-VaEgzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:16:38 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:16:38 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:16:38 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:16:38 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:16:38 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:16:38 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:16:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:16:38 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:38 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:38 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:38 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:38 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:38 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:40 INFO - Downloading blessings-1.6.tar.gz 22:16:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:16:40 INFO - Installing collected packages: blessings 22:16:40 INFO - Running setup.py install for blessings 22:16:40 INFO - Successfully installed blessings 22:16:40 INFO - Cleaning up... 22:16:40 INFO - Return code: 0 22:16:40 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:16:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:16:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:16:40 INFO - Reading from file tmpfile_stdout 22:16:40 INFO - Current package versions: 22:16:40 INFO - argparse == 1.2.1 22:16:40 INFO - blessings == 1.6 22:16:40 INFO - blobuploader == 1.2.4 22:16:40 INFO - docopt == 0.6.1 22:16:40 INFO - manifestparser == 1.1 22:16:40 INFO - mozInstall == 1.12 22:16:40 INFO - mozcrash == 0.16 22:16:40 INFO - mozdebug == 0.1 22:16:40 INFO - mozdevice == 0.48 22:16:40 INFO - mozfile == 1.2 22:16:40 INFO - mozhttpd == 0.7 22:16:40 INFO - mozinfo == 0.9 22:16:40 INFO - mozleak == 0.1 22:16:40 INFO - mozlog == 3.1 22:16:40 INFO - moznetwork == 0.27 22:16:40 INFO - mozprocess == 0.22 22:16:40 INFO - mozprofile == 0.28 22:16:40 INFO - mozrunner == 6.11 22:16:40 INFO - mozscreenshot == 0.1 22:16:40 INFO - mozsystemmonitor == 0.0 22:16:40 INFO - moztest == 0.7 22:16:40 INFO - mozversion == 1.4 22:16:40 INFO - psutil == 3.1.1 22:16:40 INFO - requests == 1.2.3 22:16:40 INFO - wsgiref == 0.1.2 22:16:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:40 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:40 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:16:40 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:16:40 INFO - Using env: {'DISPLAY': ':0', 22:16:40 INFO - 'HOME': '/home/cltbld', 22:16:40 INFO - 'LANG': 'en_US.UTF-8', 22:16:40 INFO - 'LANGUAGE': 'en_US:en', 22:16:40 INFO - 'LOGNAME': 'cltbld', 22:16:40 INFO - 'MAIL': '/var/mail/cltbld', 22:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:40 INFO - 'MOZ_NO_REMOTE': '1', 22:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:40 INFO - 'NO_EM_RESTART': '1', 22:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:40 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:40 INFO - 'SHELL': '/bin/bash', 22:16:40 INFO - 'SHLVL': '1', 22:16:40 INFO - 'TERM': 'linux', 22:16:40 INFO - 'TMOUT': '86400', 22:16:40 INFO - 'USER': 'cltbld', 22:16:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:40 INFO - '_': '/tools/buildbot/bin/python'} 22:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 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:16:41 INFO - Cleaning up... 22:16:41 INFO - Return code: 0 22:16:41 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:41 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:41 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:16:41 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:16:41 INFO - Using env: {'DISPLAY': ':0', 22:16:41 INFO - 'HOME': '/home/cltbld', 22:16:41 INFO - 'LANG': 'en_US.UTF-8', 22:16:41 INFO - 'LANGUAGE': 'en_US:en', 22:16:41 INFO - 'LOGNAME': 'cltbld', 22:16:41 INFO - 'MAIL': '/var/mail/cltbld', 22:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:41 INFO - 'MOZ_NO_REMOTE': '1', 22:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:41 INFO - 'NO_EM_RESTART': '1', 22:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:41 INFO - 'SHELL': '/bin/bash', 22:16:41 INFO - 'SHLVL': '1', 22:16:41 INFO - 'TERM': 'linux', 22:16:41 INFO - 'TMOUT': '86400', 22:16:41 INFO - 'USER': 'cltbld', 22:16:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:41 INFO - '_': '/tools/buildbot/bin/python'} 22:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:41 INFO - Downloading/unpacking jsonschema 22:16:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:16:43 INFO - Downloading/unpacking functools32 (from jsonschema) 22:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:43 INFO - Downloading functools32-3.2.3-2.tar.gz 22:16:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:16:43 INFO - warning: no files found matching '*.txt' 22:16:43 INFO - no previously-included directories found matching 'build' 22:16:43 INFO - no previously-included directories found matching 'dist' 22:16:43 INFO - no previously-included directories found matching '.git*' 22:16:43 INFO - Installing collected packages: jsonschema, functools32 22:16:43 INFO - Running setup.py install for functools32 22:16:43 INFO - warning: no files found matching '*.txt' 22:16:43 INFO - no previously-included directories found matching 'build' 22:16:43 INFO - no previously-included directories found matching 'dist' 22:16:43 INFO - no previously-included directories found matching '.git*' 22:16:43 INFO - Successfully installed jsonschema functools32 22:16:43 INFO - Cleaning up... 22:16:43 INFO - Return code: 0 22:16:43 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:16:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:16:43 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 0x7fbcaa48af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, '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': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', '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:43 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:16:43 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:16:43 INFO - Using env: {'DISPLAY': ':0', 22:16:43 INFO - 'HOME': '/home/cltbld', 22:16:43 INFO - 'LANG': 'en_US.UTF-8', 22:16:43 INFO - 'LANGUAGE': 'en_US:en', 22:16:43 INFO - 'LOGNAME': 'cltbld', 22:16:43 INFO - 'MAIL': '/var/mail/cltbld', 22:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:16:43 INFO - 'MOZ_NO_REMOTE': '1', 22:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:16:43 INFO - 'NO_EM_RESTART': '1', 22:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:16:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:16:43 INFO - 'SHELL': '/bin/bash', 22:16:43 INFO - 'SHLVL': '1', 22:16:43 INFO - 'TERM': 'linux', 22:16:43 INFO - 'TMOUT': '86400', 22:16:43 INFO - 'USER': 'cltbld', 22:16:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:16:43 INFO - '_': '/tools/buildbot/bin/python'} 22:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:16:43 INFO - Downloading/unpacking flake8 22:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:16:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:16:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:16:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:16:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:16:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:16:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:16:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:16:46 INFO - no previously-included directories found matching 'docs/_build' 22:16:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:16:46 INFO - Running setup.py install for pep8 22:16:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:16:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:16:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:16:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:16:46 INFO - no previously-included directories found matching 'docs/_build' 22:16:46 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:16:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:16:46 INFO - Cleaning up... 22:16:46 INFO - Return code: 0 22:16:46 INFO - Running post-action listener: _resource_record_post_action 22:16:46 INFO - Running post-action listener: _start_resource_monitoring 22:16:46 INFO - Starting resource monitoring. 22:16:46 INFO - ##### 22:16:46 INFO - ##### Running install step. 22:16:46 INFO - ##### 22:16:46 INFO - Running pre-action listener: _resource_record_pre_action 22:16:46 INFO - Running main action method: install 22:16:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:16:46 INFO - Reading from file tmpfile_stdout 22:16:46 INFO - Detecting whether we're running mozinstall >=1.0... 22:16:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:16:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:16:46 INFO - Reading from file tmpfile_stdout 22:16:46 INFO - Output received: 22:16:46 INFO - Usage: mozinstall [options] installer 22:16:46 INFO - Options: 22:16:46 INFO - -h, --help show this help message and exit 22:16:46 INFO - -d DEST, --destination=DEST 22:16:46 INFO - Directory to install application into. [default: 22:16:46 INFO - "/builds/slave/test-pgo"] 22:16:46 INFO - --app=APP Application being installed. [default: firefox] 22:16:46 INFO - mkdir: /builds/slave/test-pgo/build/application 22:16:46 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:16:46 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:03 INFO - Reading from file tmpfile_stdout 22:17:03 INFO - Output received: 22:17:03 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:17:03 INFO - Running post-action listener: _resource_record_post_action 22:17:03 INFO - ##### 22:17:03 INFO - ##### Running run-tests step. 22:17:03 INFO - ##### 22:17:03 INFO - Running pre-action listener: _resource_record_pre_action 22:17:03 INFO - Running main action method: run_tests 22:17:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:17:03 INFO - Python 2.7.3 22:17:03 INFO - Return code: 0 22:17:03 INFO - grabbing minidump binary from tooltool 22:17:03 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:03 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 0x1141840>, '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 0x10ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:17:03 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:03 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:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:17:03 INFO - Return code: 0 22:17:03 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:17:03 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:17:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:17:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:17:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:17:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:17:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:17:04 INFO - Return code: 0 22:17:04 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-e10s', '--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-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:17:04 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-e10s --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-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:17:04 INFO - Using env: {'DISPLAY': ':0', 22:17:04 INFO - 'HOME': '/home/cltbld', 22:17:04 INFO - 'LANG': 'en_US.UTF-8', 22:17:04 INFO - 'LANGUAGE': 'en_US:en', 22:17:04 INFO - 'LOGNAME': 'cltbld', 22:17:04 INFO - 'MAIL': '/var/mail/cltbld', 22:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:04 INFO - 'MOZ_NO_REMOTE': '1', 22:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:17:04 INFO - 'NO_EM_RESTART': '1', 22:17:04 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:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:17:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:17:04 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:17:04 INFO - 'SHELL': '/bin/bash', 22:17:04 INFO - 'SHLVL': '1', 22:17:04 INFO - 'TERM': 'linux', 22:17:04 INFO - 'TMOUT': '86400', 22:17:04 INFO - 'USER': 'cltbld', 22:17:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175', 22:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:04 INFO - '_': '/tools/buildbot/bin/python'} 22:17:04 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-e10s', '--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-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:17:04 INFO - mozversion application_buildid: 20160206193305 22:17:04 INFO - mozversion application_changeset: 76733110704b975154ac0fa779445e6eae5da559 22:17:04 INFO - mozversion application_display_name: Nightly 22:17:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:17:04 INFO - mozversion application_name: Firefox 22:17:04 INFO - mozversion application_remotingname: firefox 22:17:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:17:04 INFO - mozversion application_vendor: Mozilla 22:17:04 INFO - mozversion application_version: 47.0a1 22:17:04 INFO - mozversion platform_buildid: 20160206193305 22:17:04 INFO - mozversion platform_changeset: 76733110704b975154ac0fa779445e6eae5da559 22:17:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:17:04 INFO - mozversion platform_version: 47.0a1 22:17:04 INFO - using testdate: 1454825824 22:17:04 INFO - actual date: 1454825824 22:17:04 INFO - starting webserver on 'localhost:60048' 22:17:04 INFO - SUITE-START | Running 2 tests 22:17:04 INFO - TEST-START | dromaeo_css 22:17:04 INFO - operating with platform_type : linux_ 22:17:04 INFO - Initialising browser for dromaeo_css test... 22:17:04 INFO - TEST-INFO | started process 12531 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSEcKCz/profile http://localhost:60048/getInfo.html) 22:17:07 INFO - PROCESS | 12531 | 22:17:07 INFO - PROCESS | 12531 | (process:12613): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:17:08 INFO - PROCESS | 12531 | __metrics Screen width/height:1600/1200 22:17:08 INFO - PROCESS | 12531 | colorDepth:24 22:17:08 INFO - PROCESS | 12531 | Browser inner width/height: 1024/697 22:17:08 INFO - PROCESS | 12531 | __metrics 22:17:09 INFO - TEST-INFO | 12531: exit 0 22:17:09 INFO - Browser initialized. 22:17:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:17:09 INFO - TEST-INFO | started process 12662 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSEcKCz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:10 INFO - PROCESS | 12662 | 22:17:10 INFO - PROCESS | 12662 | (process:12720): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:17:21 INFO - PROCESS | 12662 | RSS: Main: 155865088 22:17:21 INFO - PROCESS | 12662 | 22:18:11 INFO - PROCESS | 12662 | 1454825891025 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:18 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60048/tests/dromaeo/cssquery-ext.html) 22:20:20 INFO - PROCESS | 12662 | RSS: Main: 162648064 22:20:20 INFO - PROCESS | 12662 | 22:23:22 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-ext.html (next: http://localhost:60048/tests/dromaeo/cssquery-jquery.html) 22:23:22 INFO - PROCESS | 12662 | RSS: Main: 160612352 22:23:22 INFO - PROCESS | 12662 | 22:26:24 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60048/tests/dromaeo/cssquery-mootools.html) 22:26:25 INFO - PROCESS | 12662 | RSS: Main: 159420416 22:26:25 INFO - PROCESS | 12662 | 22:29:27 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60048/tests/dromaeo/cssquery-prototype.html) 22:29:27 INFO - PROCESS | 12662 | RSS: Main: 156975104 22:29:27 INFO - PROCESS | 12662 | 22:32:29 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60048/tests/dromaeo/cssquery-yui.html) 22:32:30 INFO - PROCESS | 12662 | RSS: Main: 156790784 22:32:30 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | Cycle 1(1): loaded http://localhost:60048/tests/dromaeo/cssquery-yui.html (next: http://localhost:60048/tests/dromaeo/cssquery-dojo.html) 22:35:33 INFO - PROCESS | 12662 | RSS: Main: 159891456 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | __start_tp_report 22:35:33 INFO - PROCESS | 12662 | _x_x_mozilla_page_load 22:35:33 INFO - PROCESS | 12662 | _x_x_mozilla_page_load_details 22:35:33 INFO - PROCESS | 12662 | |i|pagename|runs| 22:35:33 INFO - PROCESS | 12662 | |0;dojo.html;3236.4174448599256;3249.1877030742316;3256.316173603543;3280.8195549244783;3301.1747063234193;5268.130758424855;5405.54052905503;5423.996560636285;5426.430224826396;5436.809711660093;5362.973185134078;5434.538064264542;5476.808311709091;5491.945080549193;5501.312335958005;112.80998031058799;4945.25821126832;4946.109700253962;5014.197728363462;5086.872828179306;4869.683470574419;4896.094222568836;4908.386451693538;4949.381327334083;5013.398392192942;4936.58039066678;4945.678530895499;4953.23224900141;4965.751712414383;5021.447640759514;4909.165441874854;4951.207806750903;4963.3299504566785;4964.776585053682;4976.527229913152;4891.706497610155;4916.778744956486;4923.926141107886;4935;4960.87597810054;5165.276861239429;5215.921761173548;5225.6318590786805;5226.085435048852;5290.65610735301;5739.62692424991;5791.913121303184;5796.304443466769;5802.245708057968;5815.15680226369;5875.941240587625;5911.586188966774;5925.792597259118;5955.970220148914;5985.191999080112;5362.973185134088;5414.242006119146;5437.700926449043;5438.184272359138;5441.211024401479;5908.645481271137;5909.143174239711;5911.438413350725;5979.641221526722;5997.340292567814;5597.74810133545;5661.433856614388;5665.433456654301;5665.66006039639;5665.980123577796;5761.884762304814;5762.337331206881;5774.68239246837;5776.56675749312;5786.652800831964;5835.153902684087;5838.153467747238;5846.795362162304;5848.5321174305955;5893.44012318829;5780.219670344533;5812.622179558315;5823.417658234142;5828.271466066742;5862.560307976919;4414.668899832525;4488.483824360175;4499.482559505634;4520.276755719069;4520.751358675305;4011.7793521356607;4016.2369149861433;4016.638502534786;4032.838686452568;4064.5935406459707;5363.141897296414;5495.395506494282;5500.22996780451;5509.531689806331;5521.420250873601;5850.5027072699295;5880.294364676266;5880.382559831241;5933.851653708605;5992.370801065913;5393.379761327497;5426.34883813937;5477.75350109246;5486.451354864482;5506.862328441821;4922.064807686528;5004.149294619923;5018.5985121190215;5028.899422011539;5033.270175824485;6070.2412198475195;6071.362506936796;6143.1706719592285;6148.1699970504305;6148.262208535004;5848.590598658053;5875.089361149029;5884.264466941632;5892.027815410495;5893.086571581412;5995.640261584319;6036.305824830025;6054.727537260922;6071.483923866521;6091.116788065617;5773.4803867650435;5788.942110578841;5836.912446313224;5846.824595262149;5872.911906321494;5880.176775251382;5886.05823068307;5896.086106653475;5902.5277977762535;5903.11453281994;5667.206591077335;5678.5457163426;5732.455416735404;5748.425157484218;5751.482366587027;5692.117721753135;5716.314042314949;5726.484616384545;5734.541236701138;5747.5401967841635;5557.722113894209;5612.158176273591;5614;5615.943840561542;5620.522255608319;5614;5753.05074662676;5753.165790960204;5764.798232061858;5825.737841797214;5633.718314084362;5640.633358831663;5651.519620832275;5666.376698563237;5714.914276285942 22:35:33 INFO - PROCESS | 12662 | |1;ext.html;525.6714553404122;552.5579536370907;565.5390856451992;575.9164921086442;594.8869714754196;35315.293694126136;35768;36211.09472263191;36228.637713622855;36309.27381452372;35915.82042089792;36426.271474570494;36427.271454570895;36479.817600911956;36488;8232.464889782175;8413.074561798197;8444.704435344764;8453.788655283637;8474.067852536216;8421.073681894986;8724.563771811416;8725.040245572982;8727.0836562161;8730.25792807609;8705.129487051308;8762.824743505158;8782.60478278479;8793.648254069862;8805.95597022014;8670.132986701343;8780.956095219546;8794.956025219897;8796.560171991376;8834.779130521723;8587.785305367353;8603.354748393895;8648.308135349156;8686.218240358336;8746.256568191711;35938;36059.4591081134;36498.452523212174;36510.817445912864;36511.63488365109;3327.4842399427885;3358.1772465745803;3538.0093573799377;3615.349237137314;3846.615338466159;30777;31047.84476077628;31212.8439357804;32246;32406.189845253823;3765.924681506382;3781.4327850822324;3938.743981641213;3958.129211573449;4012.9799351003057;216272;216990;218650;219383;220767;58715;59417.40582594119;59517.72652504154;59599.70200148971;59601.701991490634;61138.69430652818;70794.64602676954;71217.2878271221;71544.28455715376;71555.64222178856;14294.356753946098;14364.569062928129;14441.638959026108;14443.277836108153;14508.129512229089;12649.810252846215;12721.554745584046;12723.172993755376;12780.041496887585;12783.61649150527;21047.8947605261;21504;21989.041972444793;22090;22225.888870555544;8722.30221582272;8934.06192349807;9045.77385565366;9081.909180908238;9107.772305692411;1059.586761163147;1090.5092708281147;1120.176670147441;1142.2118738070706;1148.6324376199702;29733.256668583024;29798.40403191924;30067;30069.0848863754;30509.542356864666;1120.8486854274731;1122.4892673833385;1130.8416821644976;1189.2091758980182;1199.3343694249775;15458.690826183638;15755.13346765916;15852;15866.473120730048;15964.92017539905;306466;309614;311150;311332;311750;53458.198127028125;53654;53812.192817107774;54160.729196353765;54338;1282.6985658370274;1308.2739079810606;1316.1182008054627;1319.6832760137497;1326.111505291457;29164.416711665224;33986.83006584951;34589;34718.65281347154;34937.47593786146;50827;51424.74287628687;51720.48279517156;51727;51985.22022169746;287418;287651;289074;289166;289280;41890.37164442475;42808.357874631285;43021.02392549648;43577.12845743131;43763.12473750571;43329.783351083046;44100.33849492196;44400;44407.445739398965;45020;36743.81628091842;36929.44605830861;36998.63001369952;37616.81191594025;37963.620363796006;37495.43756843704;37544.249115017;37589.624103758615;37914;38259;37642;37795;37892.62107378891;38004.239915202095;38209.6179038206;31504.527432088078;32531.837340813145;33021.33957320888;33048.834755827025;33236.83381583077;26863;27855.303617409725;28072.43855122927;28966.27584310409;29242.268943276587 22:35:33 INFO - PROCESS | 12662 | |2;jquery.html;366.9321175582516;369.48825876161516;373.1064101476962;374.6141474281491;376.5631867034239;13901.443942242324;16268.43060492883;16996.83003169968;17162.570935726613;17786.822131778677;10813.08088812452;11309.208355415103;14864.55406337809;15786.289616967235;15914.761278580801;4869.732164730947;4929.186684197103;5134.0758663440565;5143.12566863634;5154.510321519469;5030.748462576875;5089.440161582223;5130.897382052357;5143.305653736735;5171.146760784485;5008.924866127011;5205.713685747282;5220.530152286294;5515.558755299567;5589.189567512708;5054.418741844698;5136.845894623168;5142.717150556718;5173.767180476888;5622.269105016322;5325.946740532584;5374.274472946141;5375.354957405098;5379.300690910196;5406.864828379283;13638.454461821515;18781.0609469526;18929.148188331557;19045.238190472504;19862.708923920043;1957.1290775604862;2100.6428907085833;2182;2310.7111611048617;2831;9051.909480905239;9184.586693598803;9320.44077355354;9664;9700.369475984038;1733.566608347913;1802.1980218802637;1835.9357422490148;1869.1121717184365;1880.5956719305277;58785;61652;62551;62864;63911.36088639147;10258.43578603169;10310.690679279634;10475.109615682752;10551.314164579278;10587.205959553065;13780.931095344458;13926.373313200931;13993.230372329619;14024.929875350557;14055.718885622435;7891.64487598048;7946.284834364935;7951.562664053533;8047.919520804717;8065.6370463329295;7798.454108212484;7872.763817085496;7901.960490197513;7975.7607271781935;7997.880031799527;4440.78043418519;4529.23003089469;4538.614217791459;4575.58819706228;4583.770811459413;1814;1814.528222662091;1891.394753678837;1908.2653178526368;1915.9712604310946;476.71635376951355;859.2309882654989;908.8505684057158;957.2820384711466;1047.738065483629;10235;10800.567977280978;10853.34879907208;10972.615958441416;11081.612143574936;477.23880410744806;482.5777444735856;486.67636022044945;503.44620916991016;512.7231295100678;5863.7947671832135;6001.279846418458;6053.697315134225;6064.575479716377;6073.18012068374;396949;408336;411628;413340;559476;66631.66684166645;79126.60436697895;79943.60028199822;80327.59836200898;81686.18313816786;1176.7352345722315;1180.4805885410392;1182.5447202826974;1208.891199792023;1226.6013545597716;15260.771088433461;15336.309866055832;15486.148261845707;15555.611109722347;15938.282777275283;33901.32197356089;34066.318673625894;34185.316293674485;34823.12942176466;35358.823205883804;48743.75628121837;49475.02099915963;49731.502684972686;49735.50264497309;50113;7254.637268136466;7316.597587132759;7323.780286591411;7345.192028876712;7557.508761930457;9575.664851730156;11015.228933974546;11202.551897923991;11492;11832.467538960595;3137.654857965668;5749.252597162509;9791.971842956673;10015.69952901414;10350.378977261389;10275.7431064224;10354.5340459678;10380;10381.9480902595;10441.895581044093;10503.579856805642;10620.89379106199;10685.893141068489;10804.621838235624;10888.18338624622;6902.240753517009;7012.789616311519;7057.505974581935;7663.540187588763;7702.768916932501;8990.32572557074;9640.180584650383;9773.951130244588;9821.263405244492;9833.262505311986 22:35:33 INFO - PROCESS | 12662 | |3;mootools.html;1514.0991110289378;1532.6628141808806;1699.7620333153352;1806.810284920084;1823.1066777279136;6948.6873090710915;7693.499922505033;7741.729039483619;7886.44794864359;7968.243016913399;7798.96100519498;7861.528308301492;7862.882056769139;7945.165757595441;7963.402744794134;2297.7702229777015;2326.2323433267065;2331.976680233193;2332.125452955142;2335.381124002141;2274.2949685597437;2325.104834638659;2360.1857359211044;2362.515684284726;2370.2178281167257;2017.1527958257493;2257.4356410897276;2298.230092918874;2301.413139649387;2321.292005938188;2270.8523945943543;2274.329072923475;2317.0615900560215;2328.429534763985;2328.639060945556;2294.977050229493;2299.2182657896396;2299.5630830142386;2302.873341966191;2306.031466783955;7785.260400261966;7830;7855.018122734658;7862.567558784264;7885.763427097197;4602.217623004098;4660.044690838404;4679.789409476582;4686.156491831469;4706.905861882743;3025.4705426550267;3060.6786287439722;3157.3527426877436;3170.556122142902;3174.761892858022;984.8375018122001;994.2543092680489;1800.5498625343664;1866.5333666583354;1914.2056046740586;10517.9474102629;10543.103836173934;10614;10622.362658240452;10642.201834862417;4236.724612900151;4346.456692913386;4349.826006959686;4351.325544540601;4378.584034516716;8666.653333866701;8715.869261961076;8756.25571826402;8760.693375731818;8768.517731524827;4839.685420447659;4851.078295123985;4863.586595139382;4869.318295438641;4872.585830204402;4516.683832131785;4525.570070843265;4538.251188553918;4556.0432309214775;4571.862844114682;3470.583529976419;3537.25717599307;3554.573451185874;3565.8751943682364;3584.8924532264073;989.8861630912537;1019.5870672377699;1021.6322124035341;1022.0648106982177;1052.074174726236;1034.1261633919326;1045.1220974381556;1048.130052056791;1201.4653479201672;1363.2638375277238;7363.521371110861;7368.521046131984;7469.477136600386;7484.401247900155;7506.211847755907;1121.1983431846106;1128.2271643923775;1151.3609946479617;1152.2280072351546;1168.9532418703157;5621.831345059655;5773.018586840247;5779.913301300484;5790.160426738099;5805.390434004453;9091.31815113869;9283.860742088875;9450.243980481546;9634.855477167848;9676.080772326617;9330.720078397659;9452.054794520493;9821.312508124505;9822.852657210147;9944.105030547285;7542.736004239825;7576.3181313682035;7702.306792388712;7714.228577142353;7719.382449404035;7223.783286501413;7327.596982166032;7365.815854603464;7396.297351751575;7430.777076687708;8541.231289184003;8660.263877570225;8820.2061814437;8844.115588441362;8949.284057275532;8644.308455323433;8848.955755221441;8871.112888711077;8988.55057247122;8995.82008359816;6474.546781725234;6487.221533415832;6508.186476690414;6543.672816359068;6570.638614876228;7317.414606831334;7407.444441666788;7456.142543607554;7487.700491980478;7493.063367079115;6962.860742785218;7263.309985551364;7367.1527774304495;7438.218987006287;7471.40228781707;7108.822279443055;7115.359617634438;7132.072830531998;7163.06880105583;7215.314545118205;7070.292970702889;7098.929010709827;7106.538075025107;7125.608091554807;7163.2478589747325;6589.571677840925;6752.291009444134;6757;6803.625800581016;6837.760678376233;6786.796396108125;6804.523683342119;6830.248672645906;6830.93169068303;6850.38346548813 22:35:33 INFO - PROCESS | 12662 | |4;prototype.html;331.40347374725496;337.9138319728468;348.80292634661413;352.8976596786932;359.85785614682203;6133.325334213233;6240.251169859612;6284.842878928023;6339.9049014264765;6352.015437607172;6298.622082675042;6302.180716506848;6313.116163737069;6333.081703153051;6334.588251763632;4863.562279394854;4870.902581948359;4874.707517548958;4876;4881.755912204393;4846.055019271226;4851.320815085891;4885.071836351082;4890.633202509808;4892.046051020053;4735.479097299294;4797;4813.37426134602;4814.879628009293;4821.30091136785;4817.759112044401;4828.106800241966;4831.734254615994;4832.710037397767;4840.70955742653;4246.002189485468;4247.320428731388;4252.128313695685;4254.723442976197;4255;5898.758471780739;5978.611390259663;6007.189029481008;6020.6989650517735;6023.939760602381;5629.437056294338;5669.31968163823;5670.773169073233;5671.63134396267;5678.517326027292;6655.134832471747;6683.365080317362;6701.463882889358;6713.194416669982;6723.966380168117;4655.674102812804;4689.95310046902;4702.31816386622;4703.600193983515;4703.64722645803;6870.31296870314;6982.6857791399;7004.824879378057;7030.859382812367;7045.542039767399;4822.662413631082;4827.372441582642;4830.468648448667;4835.879103022382;4838.225883858566;4914.680545764514;4915.336429582032;4920.483349248278;4927.704337739747;4938.678985865908;5474.343078830566;5621.4659607337235;5626.015447296707;5630.23991761107;5644.85887852807;6735.461163106939;6759.087523184406;6767.695453704497;6779.559328643622;6783;1648.2665213979903;1693.6274019715643;1700.9744853826955;1735.6875762362895;1740.0603674016143;1110.6001839337832;1112.3492756737398;1147.9713007174887;1163.6160067177811;1170.5142365918218;6173.81478555644;6225.066240063936;6231.283402408781;6242.65665388408;6249.593776404519;6698.062271282024;6713.429358504484;6723.66381680914;6726.428253598499;6739.966300168566;6069.998450255746;6116.449519543263;6152.630842149485;6188.381161883775;6190.659513726789;3691;3723.6834869035893;3724.515812944354;3727.9440808387353;3728.142527218755;7113;7126.679299431538;7128.144622645315;7128.536645118154;7132.928670713331;6820.31796820324;6953.89569156463;6971.268016858258;6984.755533556301;6987;7061.682224299816;7116.679749411289;7132.643367831588;7134.607596582237;7138.143422789299;6795;6818.18181818185;6825.419839313714;6831.624260665512;6833.077534532973;6658.700358483977;6716.932830671631;6753.1220941277315;6764.526483146133;6855.520113592001;7312.15910170316;7319.853602927805;7322.267773222635;7323.890141647986;7326.487145899736;4625.236835922035;4659.790309436015;4663.743494107856;4668.486466488752;4695.084458530554;6781.762638307636;6971.825704357431;6992.1958974718555;7016.7544135954995;7018.33325834045;6743.561668491532;6755.1556055493065;6768.018637297663;6822.692978815866;6822.897656535255;6778.525503214728;6795.72817087311;6826.283240259701;6828.351306626061;6836.111305530249;6510.44661203803;6606.4384527315715;6652.101966234496;6670.466362690876;6673.566218195801;6795.38841504267;6843.213030501556;6849.623270719959;6864.176298844171;6867.759628413181;6662.467002639681;6663.5002374821115;6672.499562532732;6676.399124078856;6683.398494135551 22:35:33 INFO - PROCESS | 12662 | |5;yui.html;779.4621711019396;785.4580339565699;802.5224991130277;819.2135549872122;828.2752591482453;13666.658333541667;13780.517681881136;13804.102733322326;13929.30353482327;13957.511487097954;12752.55366062188;13155.999999999976;13210.735785284289;13361.198328100321;13368.465261389532;686.9210040845292;826.8470332988386;829.8838162657232;840.8318336332727;843.641452382738;837.5351679817699;839.6179738219096;843.5908584336592;849.7238397520799;852.86780549015;881.1364862434785;886.4415418286503;887.4896934262792;887.8756974023642;887.9334049946248;874.1870060843413;876.7238319929202;878.2841983783228;879.7404765594165;882.1839798186716;646.612032780328;648.6724204276857;652.4486808646686;653.3270731146927;654.4437228355907;13108.47566097355;13136.277504737236;13205;13207.669808254774;13208.603741887759;13184.538541151014;13189.868101319056;13283.800742988862;13343.599692009158;13522.661933451644;10735.355878647228;10804.297720648132;10842.403667798268;10897.945510272399;10938.671839844817;3572.982135089334;3585.551806024247;3611.6749492545796;3616.077900135475;3732.458793474958;48343;48463.51536484625;48550;48624.756876215746;48804.75597622024;10021.148202402732;10245.641402550875;10303;10303.278770485995;10362.430066346273;18939.242430302635;18979.81020189808;19013.669043167123;19050;19093.904530477535;7471.701131954661;7512.5492470451945;7522.360599349007;7616.23837616234;7764.3788496920115;4336.392904993303;4493.326001099861;4548.658850586219;4585.1746685596245;4775.355327030807;3069.1559821048945;3110.2535391505876;3137.0588823352905;3146.8426578670974;3149.4488464518618;583.804425517448;589.8613825750945;593.8070127208674;598.1237487081446;606.9863328241759;610.6610830988844;622.6668732228236;674.1438373265925;697.822055375876;727.4616783580112;8894.777630559287;9048.864267036;9067.54662266884;9102.271818254523;9189.77025574366;713.5255055388212;716.3087620446295;733.398613137233;734.3317581001263;757.4205732614554;3918.5885482024546;4023.6378725914224;4117.236220979505;4319.9784001080425;4425.645948324191;56758.14862777061;57780.13329800056;57999;58120.4187958115;58207;50310.49689503131;50643.49356506388;50949.235761463606;50961.490385095676;51722.48277517252;46153.538464615594;46295.53704462912;46327;46687.29969050467;47378.76310618425;8310;8315;8458.28104611115;8491.19333663301;8493;34712.30575388529;35060.824695877374;35237.295254094264;35512.28975420529;35791;39390.80304598458;43623.56376436195;43750.343744843216;44004.33993490036;45097.54902450933;11232.438378081226;11235.775284494428;11354.72905418936;11554.133439992202;11629.418529073344;12353.567625133077;12364.381780910739;12534.247945123321;12619.87380126187;12627;11605.709857253636;11805.468753905923;11939.46272417726;12051.935081148564;12301;10942.343459392461;11370.829437558608;11423.200375973602;11609.3614851184;11770.52917883275;11706.239094458833;11775.057995360521;11870.347130907883;12199.573014944433;12209.633710988684;9947.950260248652;9999.950000249952;10142.073006128812;10205.74485637865;10625.149988001096;8643.524606146722;9196.448213107235;10128.949355253177;10146.768064623802;10180.592776288866 22:35:33 INFO - PROCESS | 12662 | __end_tp_report 22:35:33 INFO - PROCESS | 12662 | __start_cc_report 22:35:33 INFO - PROCESS | 12662 | _x_x_mozilla_cycle_collect,324 22:35:33 INFO - PROCESS | 12662 | __end_cc_report 22:35:33 INFO - PROCESS | 12662 | __startTimestamp1454826933314__endTimestamp 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | ------- Summary: start ------- 22:35:33 INFO - PROCESS | 12662 | Number of tests: 6 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#0] dojo.html Cycles:165 Average:5390.16 Median:5633.72 stddev:733.77 (13.0%) stddev-sans-first:716.30 22:35:33 INFO - PROCESS | 12662 | Values: 3236.4 3249.2 3256.3 3280.8 3301.2 5268.1 5405.5 5424.0 5426.4 5436.8 5363.0 5434.5 5476.8 5491.9 5501.3 112.8 4945.3 4946.1 5014.2 5086.9 4869.7 4896.1 4908.4 4949.4 5013.4 4936.6 4945.7 4953.2 4965.8 5021.4 4909.2 4951.2 4963.3 4964.8 4976.5 4891.7 4916.8 4923.9 4935.0 4960.9 5165.3 5215.9 5225.6 5226.1 5290.7 5739.6 5791.9 5796.3 5802.2 5815.2 5875.9 5911.6 5925.8 5956.0 5985.2 5363.0 5414.2 5437.7 5438.2 5441.2 5908.6 5909.1 5911.4 5979.6 5997.3 5597.7 5661.4 5665.4 5665.7 5666.0 5761.9 5762.3 5774.7 5776.6 5786.7 5835.2 5838.2 5846.8 5848.5 5893.4 5780.2 5812.6 5823.4 5828.3 5862.6 4414.7 4488.5 4499.5 4520.3 4520.8 4011.8 4016.2 4016.6 4032.8 4064.6 5363.1 5495.4 5500.2 5509.5 5521.4 5850.5 5880.3 5880.4 5933.9 5992.4 5393.4 5426.3 5477.8 5486.5 5506.9 4922.1 5004.1 5018.6 5028.9 5033.3 6070.2 6071.4 6143.2 6148.2 6148.3 5848.6 5875.1 5884.3 5892.0 5893.1 5995.6 6036.3 6054.7 6071.5 6091.1 5773.5 5788.9 5836.9 5846.8 5872.9 5880.2 5886.1 5896.1 5902.5 5903.1 5667.2 5678.5 5732.5 5748.4 5751.5 5692.1 5716.3 5726.5 5734.5 5747.5 5557.7 5612.2 5614.0 5615.9 5620.5 5614.0 5753.1 5753.2 5764.8 5825.7 5633.7 5640.6 5651.5 5666.4 5714.9 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#1] ext.html Cycles:180 Average:45673.99 Median:36493.23 stddev:71759.37 (196.6%) stddev-sans-first:71880.60 22:35:33 INFO - PROCESS | 12662 | Values: 525.7 552.6 565.5 575.9 594.9 35315.3 35768.0 36211.1 36228.6 36309.3 35915.8 36426.3 36427.3 36479.8 36488.0 8232.5 8413.1 8444.7 8453.8 8474.1 8421.1 8724.6 8725.0 8727.1 8730.3 8705.1 8762.8 8782.6 8793.6 8806.0 8670.1 8781.0 8795.0 8796.6 8834.8 8587.8 8603.4 8648.3 8686.2 8746.3 35938.0 36059.5 36498.5 36510.8 36511.6 3327.5 3358.2 3538.0 3615.3 3846.6 30777.0 31047.8 31212.8 32246.0 32406.2 3765.9 3781.4 3938.7 3958.1 4013.0 216272.0 216990.0 218650.0 219383.0 220767.0 58715.0 59417.4 59517.7 59599.7 59601.7 61138.7 70794.6 71217.3 71544.3 71555.6 14294.4 14364.6 14441.6 14443.3 14508.1 12649.8 12721.6 12723.2 12780.0 12783.6 21047.9 21504.0 21989.0 22090.0 22225.9 8722.3 8934.1 9045.8 9081.9 9107.8 1059.6 1090.5 1120.2 1142.2 1148.6 29733.3 29798.4 30067.0 30069.1 30509.5 1120.8 1122.5 1130.8 1189.2 1199.3 15458.7 15755.1 15852.0 15866.5 15964.9 306466.0 309614.0 311150.0 311332.0 311750.0 53458.2 53654.0 53812.2 54160.7 54338.0 1282.7 1308.3 1316.1 1319.7 1326.1 29164.4 33986.8 34589.0 34718.7 34937.5 50827.0 51424.7 51720.5 51727.0 51985.2 287418.0 287651.0 289074.0 289166.0 289280.0 41890.4 42808.4 43021.0 43577.1 43763.1 43329.8 44100.3 44400.0 44407.4 45020.0 36743.8 36929.4 36998.6 37616.8 37963.6 37495.4 37544.2 37589.6 37914.0 38259.0 37642.0 37795.0 37892.6 38004.2 38209.6 31504.5 32531.8 33021.3 33048.8 33236.8 26863.0 27855.3 28072.4 28966.3 29242.3 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#2] jquery.html Cycles:180 Average:24868.90 Median:4579.68 stddev:72712.40 (1587.7%) stddev-sans-first:72893.10 22:35:33 INFO - PROCESS | 12662 | Values: 366.9 369.5 373.1 374.6 376.6 13901.4 16268.4 16996.8 17162.6 17786.8 10813.1 11309.2 14864.6 15786.3 15914.8 4869.7 4929.2 5134.1 5143.1 5154.5 5030.7 5089.4 5130.9 5143.3 5171.1 5008.9 5205.7 5220.5 5515.6 5589.2 5054.4 5136.8 5142.7 5173.8 5622.3 5325.9 5374.3 5375.4 5379.3 5406.9 13638.5 18781.1 18929.1 19045.2 19862.7 1957.1 2100.6 2182.0 2310.7 2831.0 9051.9 9184.6 9320.4 9664.0 9700.4 1733.6 1802.2 1835.9 1869.1 1880.6 58785.0 61652.0 62551.0 62864.0 63911.4 10258.4 10310.7 10475.1 10551.3 10587.2 13780.9 13926.4 13993.2 14024.9 14055.7 7891.6 7946.3 7951.6 8047.9 8065.6 7798.5 7872.8 7902.0 7975.8 7997.9 4440.8 4529.2 4538.6 4575.6 4583.8 1814.0 1814.5 1891.4 1908.3 1916.0 476.7 859.2 908.9 957.3 1047.7 10235.0 10800.6 10853.3 10972.6 11081.6 477.2 482.6 486.7 503.4 512.7 5863.8 6001.3 6053.7 6064.6 6073.2 396949.0 408336.0 411628.0 413340.0 559476.0 66631.7 79126.6 79943.6 80327.6 81686.2 1176.7 1180.5 1182.5 1208.9 1226.6 15260.8 15336.3 15486.1 15555.6 15938.3 33901.3 34066.3 34185.3 34823.1 35358.8 48743.8 49475.0 49731.5 49735.5 50113.0 7254.6 7316.6 7323.8 7345.2 7557.5 9575.7 11015.2 11202.6 11492.0 11832.5 3137.7 5749.3 9792.0 10015.7 10350.4 10275.7 10354.5 10380.0 10381.9 10441.9 10503.6 10620.9 10685.9 10804.6 10888.2 6902.2 7012.8 7057.5 7663.5 7702.8 8990.3 9640.2 9774.0 9821.3 9833.3 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#3] mootools.html Cycles:180 Average:5548.97 Median:6557.16 stddev:2839.44 (43.3%) stddev-sans-first:2831.21 22:35:33 INFO - PROCESS | 12662 | Values: 1514.1 1532.7 1699.8 1806.8 1823.1 6948.7 7693.5 7741.7 7886.4 7968.2 7799.0 7861.5 7862.9 7945.2 7963.4 2297.8 2326.2 2332.0 2332.1 2335.4 2274.3 2325.1 2360.2 2362.5 2370.2 2017.2 2257.4 2298.2 2301.4 2321.3 2270.9 2274.3 2317.1 2328.4 2328.6 2295.0 2299.2 2299.6 2302.9 2306.0 7785.3 7830.0 7855.0 7862.6 7885.8 4602.2 4660.0 4679.8 4686.2 4706.9 3025.5 3060.7 3157.4 3170.6 3174.8 984.8 994.3 1800.5 1866.5 1914.2 10517.9 10543.1 10614.0 10622.4 10642.2 4236.7 4346.5 4349.8 4351.3 4378.6 8666.7 8715.9 8756.3 8760.7 8768.5 4839.7 4851.1 4863.6 4869.3 4872.6 4516.7 4525.6 4538.3 4556.0 4571.9 3470.6 3537.3 3554.6 3565.9 3584.9 989.9 1019.6 1021.6 1022.1 1052.1 1034.1 1045.1 1048.1 1201.5 1363.3 7363.5 7368.5 7469.5 7484.4 7506.2 1121.2 1128.2 1151.4 1152.2 1169.0 5621.8 5773.0 5779.9 5790.2 5805.4 9091.3 9283.9 9450.2 9634.9 9676.1 9330.7 9452.1 9821.3 9822.9 9944.1 7542.7 7576.3 7702.3 7714.2 7719.4 7223.8 7327.6 7365.8 7396.3 7430.8 8541.2 8660.3 8820.2 8844.1 8949.3 8644.3 8849.0 8871.1 8988.6 8995.8 6474.5 6487.2 6508.2 6543.7 6570.6 7317.4 7407.4 7456.1 7487.7 7493.1 6962.9 7263.3 7367.2 7438.2 7471.4 7108.8 7115.4 7132.1 7163.1 7215.3 7070.3 7098.9 7106.5 7125.6 7163.2 6589.6 6752.3 6757.0 6803.6 6837.8 6786.8 6804.5 6830.2 6830.9 6850.4 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#4] prototype.html Cycles:180 Average:5605.01 Median:6246.13 stddev:1682.26 (26.9%) stddev-sans-first:1639.76 22:35:33 INFO - PROCESS | 12662 | Values: 331.4 337.9 348.8 352.9 359.9 6133.3 6240.3 6284.8 6339.9 6352.0 6298.6 6302.2 6313.1 6333.1 6334.6 4863.6 4870.9 4874.7 4876.0 4881.8 4846.1 4851.3 4885.1 4890.6 4892.0 4735.5 4797.0 4813.4 4814.9 4821.3 4817.8 4828.1 4831.7 4832.7 4840.7 4246.0 4247.3 4252.1 4254.7 4255.0 5898.8 5978.6 6007.2 6020.7 6023.9 5629.4 5669.3 5670.8 5671.6 5678.5 6655.1 6683.4 6701.5 6713.2 6724.0 4655.7 4690.0 4702.3 4703.6 4703.6 6870.3 6982.7 7004.8 7030.9 7045.5 4822.7 4827.4 4830.5 4835.9 4838.2 4914.7 4915.3 4920.5 4927.7 4938.7 5474.3 5621.5 5626.0 5630.2 5644.9 6735.5 6759.1 6767.7 6779.6 6783.0 1648.3 1693.6 1701.0 1735.7 1740.1 1110.6 1112.3 1148.0 1163.6 1170.5 6173.8 6225.1 6231.3 6242.7 6249.6 6698.1 6713.4 6723.7 6726.4 6740.0 6070.0 6116.4 6152.6 6188.4 6190.7 3691.0 3723.7 3724.5 3727.9 3728.1 7113.0 7126.7 7128.1 7128.5 7132.9 6820.3 6953.9 6971.3 6984.8 6987.0 7061.7 7116.7 7132.6 7134.6 7138.1 6795.0 6818.2 6825.4 6831.6 6833.1 6658.7 6716.9 6753.1 6764.5 6855.5 7312.2 7319.9 7322.3 7323.9 7326.5 4625.2 4659.8 4663.7 4668.5 4695.1 6781.8 6971.8 6992.2 7016.8 7018.3 6743.6 6755.2 6768.0 6822.7 6822.9 6778.5 6795.7 6826.3 6828.4 6836.1 6510.4 6606.4 6652.1 6670.5 6673.6 6795.4 6843.2 6849.6 6864.2 6867.8 6662.5 6663.5 6672.5 6676.4 6683.4 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - PROCESS | 12662 | [#5] yui.html Cycles:180 Average:13951.72 Median:4459.49 stddev:15888.33 (356.3%) stddev-sans-first:15902.10 22:35:33 INFO - PROCESS | 12662 | Values: 779.5 785.5 802.5 819.2 828.3 13666.7 13780.5 13804.1 13929.3 13957.5 12752.6 13156.0 13210.7 13361.2 13368.5 686.9 826.8 829.9 840.8 843.6 837.5 839.6 843.6 849.7 852.9 881.1 886.4 887.5 887.9 887.9 874.2 876.7 878.3 879.7 882.2 646.6 648.7 652.4 653.3 654.4 13108.5 13136.3 13205.0 13207.7 13208.6 13184.5 13189.9 13283.8 13343.6 13522.7 10735.4 10804.3 10842.4 10897.9 10938.7 3573.0 3585.6 3611.7 3616.1 3732.5 48343.0 48463.5 48550.0 48624.8 48804.8 10021.1 10245.6 10303.0 10303.3 10362.4 18939.2 18979.8 19013.7 19050.0 19093.9 7471.7 7512.5 7522.4 7616.2 7764.4 4336.4 4493.3 4548.7 4585.2 4775.4 3069.2 3110.3 3137.1 3146.8 3149.4 583.8 589.9 593.8 598.1 607.0 610.7 622.7 674.1 697.8 727.5 8894.8 9048.9 9067.5 9102.3 9189.8 713.5 716.3 733.4 734.3 757.4 3918.6 4023.6 4117.2 4320.0 4425.6 56758.1 57780.1 57999.0 58120.4 58207.0 50310.5 50643.5 50949.2 50961.5 51722.5 46153.5 46295.5 46327.0 46687.3 47378.8 8310.0 8315.0 8458.3 8491.2 8493.0 34712.3 35060.8 35237.3 35512.3 35791.0 39390.8 43623.6 43750.3 44004.3 45097.5 11232.4 11235.8 11354.7 11554.1 11629.4 12353.6 12364.4 12534.2 12619.9 12627.0 11605.7 11805.5 11939.5 12051.9 12301.0 10942.3 11370.8 11423.2 11609.4 11770.5 11706.2 11775.1 11870.3 12199.6 12209.6 9948.0 10000.0 10142.1 10205.7 10625.1 8643.5 9196.4 10128.9 10146.8 10180.6 22:35:33 INFO - PROCESS | 12662 | -------- Summary: end -------- 22:35:33 INFO - PROCESS | 12662 | 22:35:33 INFO - TEST-INFO | 12662: exit 0 22:35:34 INFO - TEST-OK | dromaeo_css | took 1109639ms 22:35:34 INFO - TEST-START | kraken 22:35:34 INFO - operating with platform_type : linux_ 22:35:34 INFO - Initialising browser for kraken test... 22:35:34 INFO - TEST-INFO | started process 12904 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuP6WnN/profile http://localhost:60048/getInfo.html) 22:35:37 INFO - PROCESS | 12904 | 22:35:37 INFO - PROCESS | 12904 | (process:12978): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:35:38 INFO - PROCESS | 12904 | __metrics Screen width/height:1600/1200 22:35:38 INFO - PROCESS | 12904 | colorDepth:24 22:35:38 INFO - PROCESS | 12904 | Browser inner width/height: 1024/697 22:35:38 INFO - PROCESS | 12904 | __metrics 22:35:39 INFO - TEST-INFO | 12904: exit 0 22:35:39 INFO - Browser initialized. 22:35:39 INFO - Running cycle 1/1 for kraken test... 22:35:39 INFO - TEST-INFO | started process 13027 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuP6WnN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:35:40 INFO - PROCESS | 13027 | 22:35:40 INFO - PROCESS | 13027 | (process:13083): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:35:51 INFO - PROCESS | 13027 | RSS: Main: 155389952 22:35:51 INFO - PROCESS | 13027 | 22:35:53 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60048/tests/kraken/driver.html?testName=audio-beat-detection) 22:35:54 INFO - PROCESS | 13027 | RSS: Main: 159637504 22:35:54 INFO - PROCESS | 13027 | 22:35:56 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60048/tests/kraken/driver.html?testName=audio-dft) 22:35:57 INFO - PROCESS | 13027 | RSS: Main: 162324480 22:35:57 INFO - PROCESS | 13027 | 22:36:00 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60048/tests/kraken/driver.html?testName=audio-fft) 22:36:00 INFO - PROCESS | 13027 | RSS: Main: 155308032 22:36:00 INFO - PROCESS | 13027 | 22:36:03 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60048/tests/kraken/driver.html?testName=audio-oscillator) 22:36:03 INFO - PROCESS | 13027 | RSS: Main: 154095616 22:36:03 INFO - PROCESS | 13027 | 22:36:05 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60048/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:36:06 INFO - PROCESS | 13027 | RSS: Main: 154406912 22:36:06 INFO - PROCESS | 13027 | 22:36:09 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60048/tests/kraken/driver.html?testName=imaging-darkroom) 22:36:10 INFO - PROCESS | 13027 | RSS: Main: 155815936 22:36:10 INFO - PROCESS | 13027 | 22:36:13 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60048/tests/kraken/driver.html?testName=imaging-desaturate) 22:36:14 INFO - PROCESS | 13027 | RSS: Main: 156049408 22:36:14 INFO - PROCESS | 13027 | 22:36:16 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60048/tests/kraken/driver.html?testName=json-parse-financial) 22:36:17 INFO - PROCESS | 13027 | RSS: Main: 158904320 22:36:17 INFO - PROCESS | 13027 | 22:36:19 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60048/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:36:19 INFO - PROCESS | 13027 | RSS: Main: 158982144 22:36:19 INFO - PROCESS | 13027 | 22:36:21 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:36:22 INFO - PROCESS | 13027 | RSS: Main: 157360128 22:36:22 INFO - PROCESS | 13027 | 22:36:24 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:36:24 INFO - PROCESS | 13027 | RSS: Main: 159145984 22:36:24 INFO - PROCESS | 13027 | 22:36:27 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:36:27 INFO - PROCESS | 13027 | RSS: Main: 159338496 22:36:27 INFO - PROCESS | 13027 | 22:36:30 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:36:31 INFO - PROCESS | 13027 | RSS: Main: 157298688 22:36:31 INFO - PROCESS | 13027 | 22:36:32 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:60048/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60048/tests/kraken/driver.html?testName=ai-astar) 22:36:33 INFO - PROCESS | 13027 | RSS: Main: 160329728 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | __start_tp_report 22:36:33 INFO - PROCESS | 13027 | _x_x_mozilla_page_load 22:36:33 INFO - PROCESS | 13027 | _x_x_mozilla_page_load_details 22:36:33 INFO - PROCESS | 13027 | |i|pagename|runs| 22:36:33 INFO - PROCESS | 13027 | |0;ai-astar;111;107;111;112;111;122;113;112;113;111 22:36:33 INFO - PROCESS | 13027 | |1;audio-beat-detection;158;127;153;163;129;154;149;132;175;127 22:36:33 INFO - PROCESS | 13027 | |2;audio-dft;165;162;162;161;162;162;163;173;166;162 22:36:33 INFO - PROCESS | 13027 | |3;audio-fft;75;75;75;153;73;73;73;73;168;73 22:36:33 INFO - PROCESS | 13027 | |4;audio-oscillator;96;97;146;96;95;96;145;97;97;136 22:36:33 INFO - PROCESS | 13027 | |5;imaging-gaussian-blur;121;116;115;115;116;116;115;115;116;116 22:36:33 INFO - PROCESS | 13027 | |6;imaging-darkroom;146;147;146;146;146;146;147;147;146;147 22:36:33 INFO - PROCESS | 13027 | |7;imaging-desaturate;96;95;97;96;97;97;97;97;97;97 22:36:33 INFO - PROCESS | 13027 | |8;json-parse-financial;59;59;62;57;59;60;58;66;58;55 22:36:33 INFO - PROCESS | 13027 | |9;json-stringify-tinderbox;66;66;66;66;67;67;68;66;67;67 22:36:33 INFO - PROCESS | 13027 | |10;stanford-crypto-aes;85;85;93;85;86;86;86;87;86;85 22:36:33 INFO - PROCESS | 13027 | |11;stanford-crypto-ccm;126;123;122;117;120;134;126;117;121;121 22:36:33 INFO - PROCESS | 13027 | |12;stanford-crypto-pbkdf2;146;171;155;154;165;148;155;156;154;141 22:36:33 INFO - PROCESS | 13027 | |13;stanford-crypto-sha256-iterative;68;71;72;68;67;69;67;69;69;69 22:36:33 INFO - PROCESS | 13027 | __end_tp_report 22:36:33 INFO - PROCESS | 13027 | __start_cc_report 22:36:33 INFO - PROCESS | 13027 | _x_x_mozilla_cycle_collect,778 22:36:33 INFO - PROCESS | 13027 | __end_cc_report 22:36:33 INFO - PROCESS | 13027 | __startTimestamp1454826993066__endTimestamp 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | ------- Summary: start ------- 22:36:33 INFO - PROCESS | 13027 | Number of tests: 14 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.80 (3.4%) stddev-sans-first:4.00 22:36:33 INFO - PROCESS | 13027 | Values: 111.0 107.0 111.0 112.0 111.0 122.0 113.0 112.0 113.0 111.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.50 stddev:16.99 (11.1%) stddev-sans-first:17.52 22:36:33 INFO - PROCESS | 13027 | Values: 158.0 127.0 153.0 163.0 129.0 154.0 149.0 132.0 175.0 127.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#2] audio-dft Cycles:10 Average:163.80 Median:162.50 stddev:3.58 (2.2%) stddev-sans-first:3.77 22:36:33 INFO - PROCESS | 13027 | Values: 165.0 162.0 162.0 161.0 162.0 162.0 163.0 173.0 166.0 162.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#3] audio-fft Cycles:10 Average:91.10 Median:73.00 stddev:36.76 (50.4%) stddev-sans-first:38.52 22:36:33 INFO - PROCESS | 13027 | Values: 75.0 75.0 75.0 153.0 73.0 73.0 73.0 73.0 168.0 73.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.40 (23.3%) stddev-sans-first:23.17 22:36:33 INFO - PROCESS | 13027 | Values: 96.0 97.0 146.0 96.0 95.0 96.0 145.0 97.0 97.0 136.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:1.79 (1.5%) stddev-sans-first:0.53 22:36:33 INFO - PROCESS | 13027 | Values: 121.0 116.0 115.0 115.0 116.0 116.0 115.0 115.0 116.0 116.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:36:33 INFO - PROCESS | 13027 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 22:36:33 INFO - PROCESS | 13027 | Values: 96.0 95.0 97.0 96.0 97.0 97.0 97.0 97.0 97.0 97.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.00 stddev:2.98 (5.1%) stddev-sans-first:3.16 22:36:33 INFO - PROCESS | 13027 | Values: 59.0 59.0 62.0 57.0 59.0 60.0 58.0 66.0 58.0 55.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 22:36:33 INFO - PROCESS | 13027 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 68.0 66.0 67.0 67.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.41 (2.8%) stddev-sans-first:2.51 22:36:33 INFO - PROCESS | 13027 | Values: 85.0 85.0 93.0 85.0 86.0 86.0 86.0 87.0 86.0 85.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:122.50 stddev:5.03 (4.1%) stddev-sans-first:5.20 22:36:33 INFO - PROCESS | 13027 | Values: 126.0 123.0 122.0 117.0 120.0 134.0 126.0 117.0 121.0 121.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:8.71 (5.6%) stddev-sans-first:8.68 22:36:33 INFO - PROCESS | 13027 | Values: 146.0 171.0 155.0 154.0 165.0 148.0 155.0 156.0 154.0 141.0 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - PROCESS | 13027 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.60 (2.3%) stddev-sans-first:1.66 22:36:33 INFO - PROCESS | 13027 | Values: 68.0 71.0 72.0 68.0 67.0 69.0 67.0 69.0 69.0 69.0 22:36:33 INFO - PROCESS | 13027 | -------- Summary: end -------- 22:36:33 INFO - PROCESS | 13027 | 22:36:33 INFO - TEST-INFO | 13027: exit 0 22:36:34 INFO - TEST-OK | kraken | took 60017ms 22:36:34 INFO - SUITE-END | took 1169s 22:36:34 INFO - Completed test suite (00:19:29) 22:36:34 INFO - Working with test: dromaeo_css 22:36:34 INFO - Generating results file: dromaeo_css 22:36:34 INFO - Working with test: kraken 22:36:34 INFO - Generating results file: kraken 22:36:34 INFO - javascript benchmark 22:36:34 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:36:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:36:34 INFO - process_Request line: dromaeo_css 7019.82 graph.html#tests=[[72,1,43]] 22:36:34 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:36:34 INFO - process_Request line: kraken 1541.50 graph.html#tests=[[232,1,43]] 22:36:34 INFO - RETURN: dromaeo_css: 7019.82 22:36:34 INFO - RETURN: kraken: 1541.50 22:36:34 INFO - javascript benchmark 22:36:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3236.4174448599256, 3249.1877030742316, 3256.316173603543, 3280.8195549244783, 3301.1747063234193, 5268.130758424855, 5405.54052905503, 5423.996560636285, 5426.430224826396, 5436.809711660093, 5362.973185134078, 5434.538064264542, 5476.808311709091, 5491.945080549193, 5501.312335958005, 112.80998031058799, 4945.25821126832, 4946.109700253962, 5014.197728363462, 5086.872828179306, 4869.683470574419, 4896.094222568836, 4908.386451693538, 4949.381327334083, 5013.398392192942, 4936.58039066678, 4945.678530895499, 4953.23224900141, 4965.751712414383, 5021.447640759514, 4909.165441874854, 4951.207806750903, 4963.3299504566785, 4964.776585053682, 4976.527229913152, 4891.706497610155, 4916.778744956486, 4923.926141107886, 4935.0, 4960.87597810054, 5165.276861239429, 5215.921761173548, 5225.6318590786805, 5226.085435048852, 5290.65610735301, 5739.62692424991, 5791.913121303184, 5796.304443466769, 5802.245708057968, 5815.15680226369, 5875.941240587625, 5911.586188966774, 5925.792597259118, 5955.970220148914, 5985.191999080112, 5362.973185134088, 5414.242006119146, 5437.700926449043, 5438.184272359138, 5441.211024401479, 5908.645481271137, 5909.143174239711, 5911.438413350725, 5979.641221526722, 5997.340292567814, 5597.74810133545, 5661.433856614388, 5665.433456654301, 5665.66006039639, 5665.980123577796, 5761.884762304814, 5762.337331206881, 5774.68239246837, 5776.56675749312, 5786.652800831964, 5835.153902684087, 5838.153467747238, 5846.795362162304, 5848.5321174305955, 5893.44012318829, 5780.219670344533, 5812.622179558315, 5823.417658234142, 5828.271466066742, 5862.560307976919, 4414.668899832525, 4488.483824360175, 4499.482559505634, 4520.276755719069, 4520.751358675305, 4011.7793521356607, 4016.2369149861433, 4016.638502534786, 4032.838686452568, 4064.5935406459707, 5363.141897296414, 5495.395506494282, 5500.22996780451, 5509.531689806331, 5521.420250873601, 5850.5027072699295, 5880.294364676266, 5880.382559831241, 5933.851653708605, 5992.370801065913, 5393.379761327497, 5426.34883813937, 5477.75350109246, 5486.451354864482, 5506.862328441821, 4922.064807686528, 5004.149294619923, 5018.5985121190215, 5028.899422011539, 5033.270175824485, 6070.2412198475195, 6071.362506936796, 6143.1706719592285, 6148.1699970504305, 6148.262208535004, 5848.590598658053, 5875.089361149029, 5884.264466941632, 5892.027815410495, 5893.086571581412, 5995.640261584319, 6036.305824830025, 6054.727537260922, 6071.483923866521, 6091.116788065617, 5773.4803867650435, 5788.942110578841, 5836.912446313224, 5846.824595262149, 5872.911906321494, 5880.176775251382, 5886.05823068307, 5896.086106653475, 5902.5277977762535, 5903.11453281994, 5667.206591077335, 5678.5457163426, 5732.455416735404, 5748.425157484218, 5751.482366587027, 5692.117721753135, 5716.314042314949, 5726.484616384545, 5734.541236701138, 5747.5401967841635, 5557.722113894209, 5612.158176273591, 5614.0, 5615.943840561542, 5620.522255608319, 5614.0, 5753.05074662676, 5753.165790960204, 5764.798232061858, 5825.737841797214, 5633.718314084362, 5640.633358831663, 5651.519620832275, 5666.376698563237, 5714.914276285942], "unit": "score", "name": "dojo.html", "value": 5344.771664671304}, {"lowerIsBetter": false, "replicates": [525.6714553404122, 552.5579536370907, 565.5390856451992, 575.9164921086442, 594.8869714754196, 35315.293694126136, 35768.0, 36211.09472263191, 36228.637713622855, 36309.27381452372, 35915.82042089792, 36426.271474570494, 36427.271454570895, 36479.817600911956, 36488.0, 8232.464889782175, 8413.074561798197, 8444.704435344764, 8453.788655283637, 8474.067852536216, 8421.073681894986, 8724.563771811416, 8725.040245572982, 8727.0836562161, 8730.25792807609, 8705.129487051308, 8762.824743505158, 8782.60478278479, 8793.648254069862, 8805.95597022014, 8670.132986701343, 8780.956095219546, 8794.956025219897, 8796.560171991376, 8834.779130521723, 8587.785305367353, 8603.354748393895, 8648.308135349156, 8686.218240358336, 8746.256568191711, 35938.0, 36059.4591081134, 36498.452523212174, 36510.817445912864, 36511.63488365109, 3327.4842399427885, 3358.1772465745803, 3538.0093573799377, 3615.349237137314, 3846.615338466159, 30777.0, 31047.84476077628, 31212.8439357804, 32246.0, 32406.189845253823, 3765.924681506382, 3781.4327850822324, 3938.743981641213, 3958.129211573449, 4012.9799351003057, 216272.0, 216990.0, 218650.0, 219383.0, 220767.0, 58715.0, 59417.40582594119, 59517.72652504154, 59599.70200148971, 59601.701991490634, 61138.69430652818, 70794.64602676954, 71217.2878271221, 71544.28455715376, 71555.64222178856, 14294.356753946098, 14364.569062928129, 14441.638959026108, 14443.277836108153, 14508.129512229089, 12649.810252846215, 12721.554745584046, 12723.172993755376, 12780.041496887585, 12783.61649150527, 21047.8947605261, 21504.0, 21989.041972444793, 22090.0, 22225.888870555544, 8722.30221582272, 8934.06192349807, 9045.77385565366, 9081.909180908238, 9107.772305692411, 1059.586761163147, 1090.5092708281147, 1120.176670147441, 1142.2118738070706, 1148.6324376199702, 29733.256668583024, 29798.40403191924, 30067.0, 30069.0848863754, 30509.542356864666, 1120.8486854274731, 1122.4892673833385, 1130.8416821644976, 1189.2091758980182, 1199.3343694249775, 15458.690826183638, 15755.13346765916, 15852.0, 15866.473120730048, 15964.92017539905, 306466.0, 309614.0, 311150.0, 311332.0, 311750.0, 53458.198127028125, 53654.0, 53812.192817107774, 54160.729196353765, 54338.0, 1282.6985658370274, 1308.2739079810606, 1316.1182008054627, 1319.6832760137497, 1326.111505291457, 29164.416711665224, 33986.83006584951, 34589.0, 34718.65281347154, 34937.47593786146, 50827.0, 51424.74287628687, 51720.48279517156, 51727.0, 51985.22022169746, 287418.0, 287651.0, 289074.0, 289166.0, 289280.0, 41890.37164442475, 42808.357874631285, 43021.02392549648, 43577.12845743131, 43763.12473750571, 43329.783351083046, 44100.33849492196, 44400.0, 44407.445739398965, 45020.0, 36743.81628091842, 36929.44605830861, 36998.63001369952, 37616.81191594025, 37963.620363796006, 37495.43756843704, 37544.249115017, 37589.624103758615, 37914.0, 38259.0, 37642.0, 37795.0, 37892.62107378891, 38004.239915202095, 38209.6179038206, 31504.527432088078, 32531.837340813145, 33021.33957320888, 33048.834755827025, 33236.83381583077, 26863.0, 27855.303617409725, 28072.43855122927, 28966.27584310409, 29242.268943276587], "unit": "score", "name": "ext.html", "value": 19020.213469181832}, {"lowerIsBetter": false, "replicates": [366.9321175582516, 369.48825876161516, 373.1064101476962, 374.6141474281491, 376.5631867034239, 13901.443942242324, 16268.43060492883, 16996.83003169968, 17162.570935726613, 17786.822131778677, 10813.08088812452, 11309.208355415103, 14864.55406337809, 15786.289616967235, 15914.761278580801, 4869.732164730947, 4929.186684197103, 5134.0758663440565, 5143.12566863634, 5154.510321519469, 5030.748462576875, 5089.440161582223, 5130.897382052357, 5143.305653736735, 5171.146760784485, 5008.924866127011, 5205.713685747282, 5220.530152286294, 5515.558755299567, 5589.189567512708, 5054.418741844698, 5136.845894623168, 5142.717150556718, 5173.767180476888, 5622.269105016322, 5325.946740532584, 5374.274472946141, 5375.354957405098, 5379.300690910196, 5406.864828379283, 13638.454461821515, 18781.0609469526, 18929.148188331557, 19045.238190472504, 19862.708923920043, 1957.1290775604862, 2100.6428907085833, 2182.0, 2310.7111611048617, 2831.0, 9051.909480905239, 9184.586693598803, 9320.44077355354, 9664.0, 9700.369475984038, 1733.566608347913, 1802.1980218802637, 1835.9357422490148, 1869.1121717184365, 1880.5956719305277, 58785.0, 61652.0, 62551.0, 62864.0, 63911.36088639147, 10258.43578603169, 10310.690679279634, 10475.109615682752, 10551.314164579278, 10587.205959553065, 13780.931095344458, 13926.373313200931, 13993.230372329619, 14024.929875350557, 14055.718885622435, 7891.64487598048, 7946.284834364935, 7951.562664053533, 8047.919520804717, 8065.6370463329295, 7798.454108212484, 7872.763817085496, 7901.960490197513, 7975.7607271781935, 7997.880031799527, 4440.78043418519, 4529.23003089469, 4538.614217791459, 4575.58819706228, 4583.770811459413, 1814.0, 1814.528222662091, 1891.394753678837, 1908.2653178526368, 1915.9712604310946, 476.71635376951355, 859.2309882654989, 908.8505684057158, 957.2820384711466, 1047.738065483629, 10235.0, 10800.567977280978, 10853.34879907208, 10972.615958441416, 11081.612143574936, 477.23880410744806, 482.5777444735856, 486.67636022044945, 503.44620916991016, 512.7231295100678, 5863.7947671832135, 6001.279846418458, 6053.697315134225, 6064.575479716377, 6073.18012068374, 396949.0, 408336.0, 411628.0, 413340.0, 559476.0, 66631.66684166645, 79126.60436697895, 79943.60028199822, 80327.59836200898, 81686.18313816786, 1176.7352345722315, 1180.4805885410392, 1182.5447202826974, 1208.891199792023, 1226.6013545597716, 15260.771088433461, 15336.309866055832, 15486.148261845707, 15555.611109722347, 15938.282777275283, 33901.32197356089, 34066.318673625894, 34185.316293674485, 34823.12942176466, 35358.823205883804, 48743.75628121837, 49475.02099915963, 49731.502684972686, 49735.50264497309, 50113.0, 7254.637268136466, 7316.597587132759, 7323.780286591411, 7345.192028876712, 7557.508761930457, 9575.664851730156, 11015.228933974546, 11202.551897923991, 11492.0, 11832.467538960595, 3137.654857965668, 5749.252597162509, 9791.971842956673, 10015.69952901414, 10350.378977261389, 10275.7431064224, 10354.5340459678, 10380.0, 10381.9480902595, 10441.895581044093, 10503.579856805642, 10620.89379106199, 10685.893141068489, 10804.621838235624, 10888.18338624622, 6902.240753517009, 7012.789616311519, 7057.505974581935, 7663.540187588763, 7702.768916932501, 8990.32572557074, 9640.180584650383, 9773.951130244588, 9821.263405244492, 9833.262505311986], "unit": "score", "name": "jquery.html", "value": 7841.897411712384}, {"lowerIsBetter": false, "replicates": [1514.0991110289378, 1532.6628141808806, 1699.7620333153352, 1806.810284920084, 1823.1066777279136, 6948.6873090710915, 7693.499922505033, 7741.729039483619, 7886.44794864359, 7968.243016913399, 7798.96100519498, 7861.528308301492, 7862.882056769139, 7945.165757595441, 7963.402744794134, 2297.7702229777015, 2326.2323433267065, 2331.976680233193, 2332.125452955142, 2335.381124002141, 2274.2949685597437, 2325.104834638659, 2360.1857359211044, 2362.515684284726, 2370.2178281167257, 2017.1527958257493, 2257.4356410897276, 2298.230092918874, 2301.413139649387, 2321.292005938188, 2270.8523945943543, 2274.329072923475, 2317.0615900560215, 2328.429534763985, 2328.639060945556, 2294.977050229493, 2299.2182657896396, 2299.5630830142386, 2302.873341966191, 2306.031466783955, 7785.260400261966, 7830.0, 7855.018122734658, 7862.567558784264, 7885.763427097197, 4602.217623004098, 4660.044690838404, 4679.789409476582, 4686.156491831469, 4706.905861882743, 3025.4705426550267, 3060.6786287439722, 3157.3527426877436, 3170.556122142902, 3174.761892858022, 984.8375018122001, 994.2543092680489, 1800.5498625343664, 1866.5333666583354, 1914.2056046740586, 10517.9474102629, 10543.103836173934, 10614.0, 10622.362658240452, 10642.201834862417, 4236.724612900151, 4346.456692913386, 4349.826006959686, 4351.325544540601, 4378.584034516716, 8666.653333866701, 8715.869261961076, 8756.25571826402, 8760.693375731818, 8768.517731524827, 4839.685420447659, 4851.078295123985, 4863.586595139382, 4869.318295438641, 4872.585830204402, 4516.683832131785, 4525.570070843265, 4538.251188553918, 4556.0432309214775, 4571.862844114682, 3470.583529976419, 3537.25717599307, 3554.573451185874, 3565.8751943682364, 3584.8924532264073, 989.8861630912537, 1019.5870672377699, 1021.6322124035341, 1022.0648106982177, 1052.074174726236, 1034.1261633919326, 1045.1220974381556, 1048.130052056791, 1201.4653479201672, 1363.2638375277238, 7363.521371110861, 7368.521046131984, 7469.477136600386, 7484.401247900155, 7506.211847755907, 1121.1983431846106, 1128.2271643923775, 1151.3609946479617, 1152.2280072351546, 1168.9532418703157, 5621.831345059655, 5773.018586840247, 5779.913301300484, 5790.160426738099, 5805.390434004453, 9091.31815113869, 9283.860742088875, 9450.243980481546, 9634.855477167848, 9676.080772326617, 9330.720078397659, 9452.054794520493, 9821.312508124505, 9822.852657210147, 9944.105030547285, 7542.736004239825, 7576.3181313682035, 7702.306792388712, 7714.228577142353, 7719.382449404035, 7223.783286501413, 7327.596982166032, 7365.815854603464, 7396.297351751575, 7430.777076687708, 8541.231289184003, 8660.263877570225, 8820.2061814437, 8844.115588441362, 8949.284057275532, 8644.308455323433, 8848.955755221441, 8871.112888711077, 8988.55057247122, 8995.82008359816, 6474.546781725234, 6487.221533415832, 6508.186476690414, 6543.672816359068, 6570.638614876228, 7317.414606831334, 7407.444441666788, 7456.142543607554, 7487.700491980478, 7493.063367079115, 6962.860742785218, 7263.309985551364, 7367.1527774304495, 7438.218987006287, 7471.40228781707, 7108.822279443055, 7115.359617634438, 7132.072830531998, 7163.06880105583, 7215.314545118205, 7070.292970702889, 7098.929010709827, 7106.538075025107, 7125.608091554807, 7163.2478589747325, 6589.571677840925, 6752.291009444134, 6757.0, 6803.625800581016, 6837.760678376233, 6786.796396108125, 6804.523683342119, 6830.248672645906, 6830.93169068303, 6850.38346548813], "unit": "score", "name": "mootools.html", "value": 4588.930470567998}, {"lowerIsBetter": false, "replicates": [331.40347374725496, 337.9138319728468, 348.80292634661413, 352.8976596786932, 359.85785614682203, 6133.325334213233, 6240.251169859612, 6284.842878928023, 6339.9049014264765, 6352.015437607172, 6298.622082675042, 6302.180716506848, 6313.116163737069, 6333.081703153051, 6334.588251763632, 4863.562279394854, 4870.902581948359, 4874.707517548958, 4876.0, 4881.755912204393, 4846.055019271226, 4851.320815085891, 4885.071836351082, 4890.633202509808, 4892.046051020053, 4735.479097299294, 4797.0, 4813.37426134602, 4814.879628009293, 4821.30091136785, 4817.759112044401, 4828.106800241966, 4831.734254615994, 4832.710037397767, 4840.70955742653, 4246.002189485468, 4247.320428731388, 4252.128313695685, 4254.723442976197, 4255.0, 5898.758471780739, 5978.611390259663, 6007.189029481008, 6020.6989650517735, 6023.939760602381, 5629.437056294338, 5669.31968163823, 5670.773169073233, 5671.63134396267, 5678.517326027292, 6655.134832471747, 6683.365080317362, 6701.463882889358, 6713.194416669982, 6723.966380168117, 4655.674102812804, 4689.95310046902, 4702.31816386622, 4703.600193983515, 4703.64722645803, 6870.31296870314, 6982.6857791399, 7004.824879378057, 7030.859382812367, 7045.542039767399, 4822.662413631082, 4827.372441582642, 4830.468648448667, 4835.879103022382, 4838.225883858566, 4914.680545764514, 4915.336429582032, 4920.483349248278, 4927.704337739747, 4938.678985865908, 5474.343078830566, 5621.4659607337235, 5626.015447296707, 5630.23991761107, 5644.85887852807, 6735.461163106939, 6759.087523184406, 6767.695453704497, 6779.559328643622, 6783.0, 1648.2665213979903, 1693.6274019715643, 1700.9744853826955, 1735.6875762362895, 1740.0603674016143, 1110.6001839337832, 1112.3492756737398, 1147.9713007174887, 1163.6160067177811, 1170.5142365918218, 6173.81478555644, 6225.066240063936, 6231.283402408781, 6242.65665388408, 6249.593776404519, 6698.062271282024, 6713.429358504484, 6723.66381680914, 6726.428253598499, 6739.966300168566, 6069.998450255746, 6116.449519543263, 6152.630842149485, 6188.381161883775, 6190.659513726789, 3691.0, 3723.6834869035893, 3724.515812944354, 3727.9440808387353, 3728.142527218755, 7113.0, 7126.679299431538, 7128.144622645315, 7128.536645118154, 7132.928670713331, 6820.31796820324, 6953.89569156463, 6971.268016858258, 6984.755533556301, 6987.0, 7061.682224299816, 7116.679749411289, 7132.643367831588, 7134.607596582237, 7138.143422789299, 6795.0, 6818.18181818185, 6825.419839313714, 6831.624260665512, 6833.077534532973, 6658.700358483977, 6716.932830671631, 6753.1220941277315, 6764.526483146133, 6855.520113592001, 7312.15910170316, 7319.853602927805, 7322.267773222635, 7323.890141647986, 7326.487145899736, 4625.236835922035, 4659.790309436015, 4663.743494107856, 4668.486466488752, 4695.084458530554, 6781.762638307636, 6971.825704357431, 6992.1958974718555, 7016.7544135954995, 7018.33325834045, 6743.561668491532, 6755.1556055493065, 6768.018637297663, 6822.692978815866, 6822.897656535255, 6778.525503214728, 6795.72817087311, 6826.283240259701, 6828.351306626061, 6836.111305530249, 6510.44661203803, 6606.4384527315715, 6652.101966234496, 6670.466362690876, 6673.566218195801, 6795.38841504267, 6843.213030501556, 6849.623270719959, 6864.176298844171, 6867.759628413181, 6662.467002639681, 6663.5002374821115, 6672.499562532732, 6676.399124078856, 6683.398494135551], "unit": "score", "name": "prototype.html", "value": 5054.773867776323}, {"lowerIsBetter": false, "replicates": [779.4621711019396, 785.4580339565699, 802.5224991130277, 819.2135549872122, 828.2752591482453, 13666.658333541667, 13780.517681881136, 13804.102733322326, 13929.30353482327, 13957.511487097954, 12752.55366062188, 13155.999999999976, 13210.735785284289, 13361.198328100321, 13368.465261389532, 686.9210040845292, 826.8470332988386, 829.8838162657232, 840.8318336332727, 843.641452382738, 837.5351679817699, 839.6179738219096, 843.5908584336592, 849.7238397520799, 852.86780549015, 881.1364862434785, 886.4415418286503, 887.4896934262792, 887.8756974023642, 887.9334049946248, 874.1870060843413, 876.7238319929202, 878.2841983783228, 879.7404765594165, 882.1839798186716, 646.612032780328, 648.6724204276857, 652.4486808646686, 653.3270731146927, 654.4437228355907, 13108.47566097355, 13136.277504737236, 13205.0, 13207.669808254774, 13208.603741887759, 13184.538541151014, 13189.868101319056, 13283.800742988862, 13343.599692009158, 13522.661933451644, 10735.355878647228, 10804.297720648132, 10842.403667798268, 10897.945510272399, 10938.671839844817, 3572.982135089334, 3585.551806024247, 3611.6749492545796, 3616.077900135475, 3732.458793474958, 48343.0, 48463.51536484625, 48550.0, 48624.756876215746, 48804.75597622024, 10021.148202402732, 10245.641402550875, 10303.0, 10303.278770485995, 10362.430066346273, 18939.242430302635, 18979.81020189808, 19013.669043167123, 19050.0, 19093.904530477535, 7471.701131954661, 7512.5492470451945, 7522.360599349007, 7616.23837616234, 7764.3788496920115, 4336.392904993303, 4493.326001099861, 4548.658850586219, 4585.1746685596245, 4775.355327030807, 3069.1559821048945, 3110.2535391505876, 3137.0588823352905, 3146.8426578670974, 3149.4488464518618, 583.804425517448, 589.8613825750945, 593.8070127208674, 598.1237487081446, 606.9863328241759, 610.6610830988844, 622.6668732228236, 674.1438373265925, 697.822055375876, 727.4616783580112, 8894.777630559287, 9048.864267036, 9067.54662266884, 9102.271818254523, 9189.77025574366, 713.5255055388212, 716.3087620446295, 733.398613137233, 734.3317581001263, 757.4205732614554, 3918.5885482024546, 4023.6378725914224, 4117.236220979505, 4319.9784001080425, 4425.645948324191, 56758.14862777061, 57780.13329800056, 57999.0, 58120.4187958115, 58207.0, 50310.49689503131, 50643.49356506388, 50949.235761463606, 50961.490385095676, 51722.48277517252, 46153.538464615594, 46295.53704462912, 46327.0, 46687.29969050467, 47378.76310618425, 8310.0, 8315.0, 8458.28104611115, 8491.19333663301, 8493.0, 34712.30575388529, 35060.824695877374, 35237.295254094264, 35512.28975420529, 35791.0, 39390.80304598458, 43623.56376436195, 43750.343744843216, 44004.33993490036, 45097.54902450933, 11232.438378081226, 11235.775284494428, 11354.72905418936, 11554.133439992202, 11629.418529073344, 12353.567625133077, 12364.381780910739, 12534.247945123321, 12619.87380126187, 12627.0, 11605.709857253636, 11805.468753905923, 11939.46272417726, 12051.935081148564, 12301.0, 10942.343459392461, 11370.829437558608, 11423.200375973602, 11609.3614851184, 11770.52917883275, 11706.239094458833, 11775.057995360521, 11870.347130907883, 12199.573014944433, 12209.633710988684, 9947.950260248652, 9999.950000249952, 10142.073006128812, 10205.74485637865, 10625.149988001096, 8643.524606146722, 9196.448213107235, 10128.949355253177, 10146.768064623802, 10180.592776288866], "unit": "score", "name": "yui.html", "value": 6470.554515228256}], "name": "dromaeo_css", "value": 7019.821314090799}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 112.0, 111.0, 122.0, 113.0, 112.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 153.0, 163.0, 129.0, 154.0, 149.0, 132.0, 175.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [165.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 173.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 75.0, 153.0, 73.0, 73.0, 73.0, 73.0, 168.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 146.0, 96.0, 95.0, 96.0, 145.0, 97.0, 97.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 62.0, 57.0, 59.0, 60.0, 58.0, 66.0, 58.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 93.0, 85.0, 86.0, 86.0, 86.0, 87.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [126.0, 123.0, 122.0, 117.0, 120.0, 134.0, 126.0, 117.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [146.0, 171.0, 155.0, 154.0, 165.0, 148.0, 155.0, 156.0, 154.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.5}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 72.0, 68.0, 67.0, 69.0, 67.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1541.5000000000002}]} 22:36:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1541.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7019.82"}}} 22:36:34 INFO - Return code: 0 22:36:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:36:34 INFO - # TBPL SUCCESS # 22:36:34 INFO - Running post-action listener: _resource_record_post_action 22:36:34 INFO - Running post-run listener: _resource_record_post_run 22:36:35 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 551514112; Read time: 0; Write time: 448088 22:36:35 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244768768; Read time: 0; Write time: 226016 22:36:35 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 298446848; Read time: 0; Write time: 221632 22:36:35 INFO - Running post-run listener: _upload_blobber_files 22:36:35 INFO - Blob upload gear active. 22:36:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:36:35 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:36:35 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:36:35 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:36:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:36:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:36:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:36:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:36:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:36:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:36:36 INFO - (blobuploader) - INFO - Done attempting. 22:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:36:37 INFO - (blobuploader) - INFO - Done attempting. 22:36:37 INFO - (blobuploader) - INFO - Iteration through files over. 22:36:37 INFO - Return code: 0 22:36:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:36:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:36:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d6e1fc71720431ea076f0e9336cdec5469f897fe2d9870b848c233a93e389b6cd35871d9b73224682d787ffe5d52cfbe136925c29c23812bf454c33d704e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd641773ee97031e62ad35b791478fa7b8b0fd72445cb87ea1e96e82100ad6f4ed129a89efeee83ae9389ce536582184fda3d563b0118fd9306316b6462a19a"} 22:36:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:36:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:36:37 INFO - Contents: 22:36:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d6e1fc71720431ea076f0e9336cdec5469f897fe2d9870b848c233a93e389b6cd35871d9b73224682d787ffe5d52cfbe136925c29c23812bf454c33d704e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd641773ee97031e62ad35b791478fa7b8b0fd72445cb87ea1e96e82100ad6f4ed129a89efeee83ae9389ce536582184fda3d563b0118fd9306316b6462a19a"} 22:36:37 INFO - Running post-run listener: copy_logs_to_upload_dir 22:36:37 INFO - Copying logs to upload dir... 22:36:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:36:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.296286 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-06 22:36:37.425794) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 22:36:37.429724) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d6e1fc71720431ea076f0e9336cdec5469f897fe2d9870b848c233a93e389b6cd35871d9b73224682d787ffe5d52cfbe136925c29c23812bf454c33d704e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd641773ee97031e62ad35b791478fa7b8b0fd72445cb87ea1e96e82100ad6f4ed129a89efeee83ae9389ce536582184fda3d563b0118fd9306316b6462a19a"} 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.011506 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84d6e1fc71720431ea076f0e9336cdec5469f897fe2d9870b848c233a93e389b6cd35871d9b73224682d787ffe5d52cfbe136925c29c23812bf454c33d704e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fd641773ee97031e62ad35b791478fa7b8b0fd72445cb87ea1e96e82100ad6f4ed129a89efeee83ae9389ce536582184fda3d563b0118fd9306316b6462a19a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 22:36:37.455194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:36:37.455575) ========= 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=6dbc10da6d83fee962c624be000001a8-1454825421.557152-106602175 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 22:36:37.539489) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 22:36:37.539917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 22:36:37.540258) ========= ========= Total master_lag: 0.33 =========