builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1455729409.88 results: success (0) buildid: 20160217062621 builduid: 5c4934cf3bf14d6d857a2825a8c30480 revision: 709f559b5406 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.882997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.883456) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.883763) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004921 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.904706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.905013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.927341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.927648) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020565 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.976374) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.976701) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.977095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:49.977439) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 09:16:49-- 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% 213M=0s 2016-02-17 09:16:50 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:50.152976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:50.153287) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.076209 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:50.241164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:50.241544) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 709f559b5406 --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 709f559b5406 --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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 09:16:50,250 Setting DEBUG logging. 2016-02-17 09:16:50,250 attempt 1/10 2016-02-17 09:16:50,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/709f559b5406?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 09:16:50,786 unpacking tar archive at: mozilla-central-709f559b5406/testing/mozharness/ program finished with exit code 0 elapsedTime=0.818691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:51.073532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:51.073887) ========= echo 709f559b5406 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'709f559b5406'] 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 709f559b5406 program finished with exit code 0 elapsedTime=0.003528 script_repo_revision: '709f559b5406' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:51.124714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:51.125030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 09:16:51.134755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-17 09:16:51.135072) ========= /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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:51 INFO - MultiFileLogger online at 20160217 09:16:51 in /builds/slave/test-pgo 09:16:51 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 09:16:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:16:51 INFO - {'append_to_log': False, 09:16:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:16:51 INFO - 'blob_upload_branch': 'Firefox', 09:16:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:16:51 INFO - 'branch': 'Firefox', 09:16:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:51 INFO - 'config_files': ('talos/linux_config.py',), 09:16:51 INFO - 'default_actions': ('clobber', 09:16:51 INFO - 'read-buildbot-config', 09:16:51 INFO - 'download-and-extract', 09:16:51 INFO - 'populate-webroot', 09:16:51 INFO - 'create-virtualenv', 09:16:51 INFO - 'install', 09:16:51 INFO - 'run-tests'), 09:16:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:51 INFO - 'download_minidump_stackwalk': True, 09:16:51 INFO - 'download_symbols': 'ondemand', 09:16:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:51 INFO - 'installer_path': 'installer.exe', 09:16:51 INFO - 'log_level': 'info', 09:16:51 INFO - 'log_name': 'talos', 09:16:51 INFO - 'log_to_console': True, 09:16:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:51 INFO - 'opt_config_files': (), 09:16:51 INFO - 'pip_index': False, 09:16:51 INFO - 'sps_profile': False, 09:16:51 INFO - 'sps_profile_interval': 0, 09:16:51 INFO - 'suite': 'dromaeojs-e10s', 09:16:51 INFO - 'system_bits': '32', 09:16:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:51 INFO - 'title': 'talos-linux64-ix-020', 09:16:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:51 INFO - 'use_talos_json': True, 09:16:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:16:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:51 INFO - 'work_dir': 'build'} 09:16:51 INFO - ##### 09:16:51 INFO - ##### Running clobber step. 09:16:51 INFO - ##### 09:16:51 INFO - Running pre-action listener: _resource_record_pre_action 09:16:51 INFO - Running main action method: clobber 09:16:51 INFO - rmtree: /builds/slave/test-pgo/build 09:16:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:16:52 INFO - Running post-action listener: _resource_record_post_action 09:16:52 INFO - ##### 09:16:52 INFO - ##### Running read-buildbot-config step. 09:16:52 INFO - ##### 09:16:52 INFO - Running pre-action listener: _resource_record_pre_action 09:16:52 INFO - Running main action method: read_buildbot_config 09:16:52 INFO - Using buildbot properties: 09:16:52 INFO - { 09:16:52 INFO - "project": "", 09:16:52 INFO - "product": "firefox", 09:16:52 INFO - "script_repo_revision": "production", 09:16:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:16:52 INFO - "repository": "", 09:16:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:16:52 INFO - "buildid": "20160217062621", 09:16:52 INFO - "stage_platform": "linux64-pgo", 09:16:52 INFO - "basedir": "/builds/slave/test-pgo", 09:16:52 INFO - "nightly_build": "True", 09:16:52 INFO - "buildnumber": 643, 09:16:52 INFO - "slavename": "talos-linux64-ix-020", 09:16:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:52 INFO - "platform": "ubuntu64_hw", 09:16:52 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 09:16:52 INFO - "branch": "mozilla-central", 09:16:52 INFO - "repo_path": "mozilla-central", 09:16:52 INFO - "revision": "709f559b5406", 09:16:52 INFO - "pgo_build": "True", 09:16:52 INFO - "builduid": "5c4934cf3bf14d6d857a2825a8c30480", 09:16:52 INFO - "slavebuilddir": "test" 09:16:52 INFO - } 09:16:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 09:16:52 INFO - Running post-action listener: _resource_record_post_action 09:16:52 INFO - ##### 09:16:52 INFO - ##### Running download-and-extract step. 09:16:52 INFO - ##### 09:16:52 INFO - Running pre-action listener: _resource_record_pre_action 09:16:52 INFO - Running main action method: download_and_extract 09:16:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:16:52 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')]} 09:16:52 INFO - https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/test_packages.json 09:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/test_packages.json 09:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:16:53 INFO - Downloaded 1448 bytes. 09:16:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:16:53 INFO - Using the following test package requirements: 09:16:53 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:16:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:16:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:16:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'jsshell-linux-x86_64.zip'], 09:16:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:16:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:16:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:16:53 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:16:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:16:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 09:16:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 09:16:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:16:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:53 INFO - https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:54 INFO - Downloaded 23346301 bytes. 09:16:54 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'] 09:16:54 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 09:16:55 INFO - Return code: 0 09:16:55 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 09:16:55 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')]} 09:16:55 INFO - https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 09:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:56 INFO - Downloaded 23346301 bytes. 09:16:56 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'] 09:16:56 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 09:16:57 INFO - Return code: 0 09:16:57 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')]} 09:16:57 INFO - https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 09:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:58 INFO - Downloaded 10707071 bytes. 09:16:58 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'] 09:16:58 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 09:16:59 INFO - Return code: 0 09:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:59 INFO - https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:16:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:16:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:16:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EZ18rKgeTVC8yZLPllZpKg/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 09:17:00 INFO - Downloaded 56529481 bytes. 09:17:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:00 INFO - mkdir: /builds/slave/test-pgo/properties 09:17:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:17:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:17:00 INFO - Contents: 09:17:00 INFO - build_url:https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 09:17:01 INFO - Running post-action listener: _resource_record_post_action 09:17:01 INFO - Running post-action listener: set_extra_try_arguments 09:17:01 INFO - ##### 09:17:01 INFO - ##### Running populate-webroot step. 09:17:01 INFO - ##### 09:17:01 INFO - Running pre-action listener: _resource_record_pre_action 09:17:01 INFO - Running main action method: populate_webroot 09:17:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:17:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:17:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:17:01 INFO - '--tppagecycles', 09:17:01 INFO - '7'], 09:17:01 INFO - 'tests': ['tsvgm']}}, 09:17:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:17:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:17:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:17:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:17:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:17:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'tests': ['damp', 'tps']}, 09:17:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['damp', 'tps']}, 09:17:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:17:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:17:01 INFO - 'other': {'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'other_l64': {'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'other_nol64': {'tests': ['a11yr', 09:17:01 INFO - 'ts_paint', 09:17:01 INFO - 'tpaint', 09:17:01 INFO - 'sessionrestore', 09:17:01 INFO - 'sessionrestore_no_auto_restore']}, 09:17:01 INFO - 'svgr': {'tests': ['tsvgx', 09:17:01 INFO - 'tsvgr_opacity', 09:17:01 INFO - 'tart', 09:17:01 INFO - 'tscrollx', 09:17:01 INFO - 'cart']}, 09:17:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['tsvgx', 09:17:01 INFO - 'tsvgr_opacity', 09:17:01 INFO - 'tart', 09:17:01 INFO - 'tscrollx', 09:17:01 INFO - 'cart']}, 09:17:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'tests': ['tp5o']}, 09:17:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'talos_options': ['--e10s'], 09:17:01 INFO - 'tests': ['tp5o']}, 09:17:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'talos_options': ['--xperf_path', 09:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:01 INFO - 'tests': ['tp5n']}, 09:17:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:17:01 INFO - 'talos_options': ['--e10s', 09:17:01 INFO - '--xperf_path', 09:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:17:01 INFO - 'tests': ['tp5n']}}, 09:17:01 INFO - 'talos.zip': {'path': '', 09:17:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:17:01 INFO - Running post-action listener: _resource_record_post_action 09:17:01 INFO - ##### 09:17:01 INFO - ##### Running create-virtualenv step. 09:17:01 INFO - ##### 09:17:01 INFO - Running pre-action listener: _resource_record_pre_action 09:17:01 INFO - Running main action method: create_virtualenv 09:17:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:17:01 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 09:17:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:17:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:17:02 INFO - Using real prefix '/usr' 09:17:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:17:03 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:05 INFO - Installing pip.................done. 09:17:05 INFO - Return code: 0 09:17:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:17:05 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')]} 09:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:05 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')]} 09:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:05 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:05 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 09:17:05 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 09:17:05 INFO - Using env: {'DISPLAY': ':0', 09:17:05 INFO - 'HOME': '/home/cltbld', 09:17:05 INFO - 'LANG': 'en_US.UTF-8', 09:17:05 INFO - 'LANGUAGE': 'en_US:en', 09:17:05 INFO - 'LOGNAME': 'cltbld', 09:17:05 INFO - 'MAIL': '/var/mail/cltbld', 09:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:05 INFO - 'MOZ_NO_REMOTE': '1', 09:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:05 INFO - 'NO_EM_RESTART': '1', 09:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:05 INFO - 'SHELL': '/bin/bash', 09:17:05 INFO - 'SHLVL': '1', 09:17:05 INFO - 'TERM': 'linux', 09:17:05 INFO - 'TMOUT': '86400', 09:17:05 INFO - 'USER': 'cltbld', 09:17:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:05 INFO - '_': '/tools/buildbot/bin/python'} 09:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:05 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 09:17:05 INFO - Cleaning up... 09:17:05 INFO - Return code: 0 09:17:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:17:05 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')]} 09:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:05 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')]} 09:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:05 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:05 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 09:17:05 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 09:17:05 INFO - Using env: {'DISPLAY': ':0', 09:17:05 INFO - 'HOME': '/home/cltbld', 09:17:05 INFO - 'LANG': 'en_US.UTF-8', 09:17:05 INFO - 'LANGUAGE': 'en_US:en', 09:17:05 INFO - 'LOGNAME': 'cltbld', 09:17:05 INFO - 'MAIL': '/var/mail/cltbld', 09:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:05 INFO - 'MOZ_NO_REMOTE': '1', 09:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:05 INFO - 'NO_EM_RESTART': '1', 09:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:05 INFO - 'SHELL': '/bin/bash', 09:17:05 INFO - 'SHLVL': '1', 09:17:05 INFO - 'TERM': 'linux', 09:17:05 INFO - 'TMOUT': '86400', 09:17:05 INFO - 'USER': 'cltbld', 09:17:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:05 INFO - '_': '/tools/buildbot/bin/python'} 09:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:05 INFO - Downloading/unpacking psutil>=0.7.1 09:17:05 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 09:17:05 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 09:17:05 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 09:17:05 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 09:17:05 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 09:17:05 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 09:17:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:07 INFO - Installing collected packages: psutil 09:17:07 INFO - Running setup.py install for psutil 09:17:07 INFO - building 'psutil._psutil_linux' extension 09:17:07 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 09:17:07 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 09:17:07 INFO - building 'psutil._psutil_posix' extension 09:17:07 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 09:17:07 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 09:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:07 INFO - Successfully installed psutil 09:17:07 INFO - Cleaning up... 09:17:08 INFO - Return code: 0 09:17:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:17:08 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')]} 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:08 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')]} 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:08 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:08 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 09:17:08 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 09:17:08 INFO - Using env: {'DISPLAY': ':0', 09:17:08 INFO - 'HOME': '/home/cltbld', 09:17:08 INFO - 'LANG': 'en_US.UTF-8', 09:17:08 INFO - 'LANGUAGE': 'en_US:en', 09:17:08 INFO - 'LOGNAME': 'cltbld', 09:17:08 INFO - 'MAIL': '/var/mail/cltbld', 09:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:08 INFO - 'MOZ_NO_REMOTE': '1', 09:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:08 INFO - 'NO_EM_RESTART': '1', 09:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:08 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:08 INFO - 'SHELL': '/bin/bash', 09:17:08 INFO - 'SHLVL': '1', 09:17:08 INFO - 'TERM': 'linux', 09:17:08 INFO - 'TMOUT': '86400', 09:17:08 INFO - 'USER': 'cltbld', 09:17:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:08 INFO - '_': '/tools/buildbot/bin/python'} 09:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:17:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:17:10 INFO - Installing collected packages: mozsystemmonitor 09:17:10 INFO - Running setup.py install for mozsystemmonitor 09:17:11 INFO - Successfully installed mozsystemmonitor 09:17:11 INFO - Cleaning up... 09:17:11 INFO - Return code: 0 09:17:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:11 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:11 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 09:17:11 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 09:17:11 INFO - Using env: {'DISPLAY': ':0', 09:17:11 INFO - 'HOME': '/home/cltbld', 09:17:11 INFO - 'LANG': 'en_US.UTF-8', 09:17:11 INFO - 'LANGUAGE': 'en_US:en', 09:17:11 INFO - 'LOGNAME': 'cltbld', 09:17:11 INFO - 'MAIL': '/var/mail/cltbld', 09:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:11 INFO - 'MOZ_NO_REMOTE': '1', 09:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:11 INFO - 'NO_EM_RESTART': '1', 09:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:11 INFO - 'SHELL': '/bin/bash', 09:17:11 INFO - 'SHLVL': '1', 09:17:11 INFO - 'TERM': 'linux', 09:17:11 INFO - 'TMOUT': '86400', 09:17:11 INFO - 'USER': 'cltbld', 09:17:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:11 INFO - '_': '/tools/buildbot/bin/python'} 09:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:17:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 INFO - Downloading docopt-0.6.1.tar.gz 09:17:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:13 INFO - Running setup.py install for blobuploader 09:17:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:17:14 INFO - Running setup.py install for requests 09:17:14 INFO - Running setup.py install for docopt 09:17:14 INFO - Successfully installed blobuploader requests docopt 09:17:14 INFO - Cleaning up... 09:17:14 INFO - Return code: 0 09:17:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17:14 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')]} 09:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 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')]} 09:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:14 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:14 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 09:17:14 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 09:17:14 INFO - Using env: {'DISPLAY': ':0', 09:17:14 INFO - 'HOME': '/home/cltbld', 09:17:14 INFO - 'LANG': 'en_US.UTF-8', 09:17:14 INFO - 'LANGUAGE': 'en_US:en', 09:17:14 INFO - 'LOGNAME': 'cltbld', 09:17:14 INFO - 'MAIL': '/var/mail/cltbld', 09:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:14 INFO - 'MOZ_NO_REMOTE': '1', 09:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:14 INFO - 'NO_EM_RESTART': '1', 09:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:14 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:14 INFO - 'SHELL': '/bin/bash', 09:17:14 INFO - 'SHLVL': '1', 09:17:14 INFO - 'TERM': 'linux', 09:17:14 INFO - 'TMOUT': '86400', 09:17:14 INFO - 'USER': 'cltbld', 09:17:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:14 INFO - '_': '/tools/buildbot/bin/python'} 09:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:14 INFO - Running setup.py (path:/tmp/pip-T71nSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:14 INFO - Running setup.py (path:/tmp/pip-om_AJi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:14 INFO - Running setup.py (path:/tmp/pip-oZFkKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:14 INFO - Running setup.py (path:/tmp/pip-6jW0xO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:15 INFO - Running setup.py (path:/tmp/pip-qumlEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:15 INFO - Running setup.py (path:/tmp/pip-yUWzZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:15 INFO - Running setup.py (path:/tmp/pip-PAljdK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:15 INFO - Running setup.py (path:/tmp/pip-x7muRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:15 INFO - Running setup.py (path:/tmp/pip-atCcVT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:15 INFO - Running setup.py (path:/tmp/pip-fT4zSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:15 INFO - Running setup.py (path:/tmp/pip-Z7wQl8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:15 INFO - Running setup.py (path:/tmp/pip-fIomBB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:15 INFO - Running setup.py (path:/tmp/pip-bYOHIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:15 INFO - Running setup.py (path:/tmp/pip-PdXZ62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:15 INFO - Running setup.py (path:/tmp/pip-sF3hTr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:15 INFO - Running setup.py (path:/tmp/pip-WWuIBy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:15 INFO - Running setup.py (path:/tmp/pip-kYI5M9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:15 INFO - Running setup.py install for manifestparser 09:17:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozcrash 09:17:16 INFO - Running setup.py install for mozdebug 09:17:16 INFO - Running setup.py install for mozdevice 09:17:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozfile 09:17:16 INFO - Running setup.py install for mozhttpd 09:17:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozinfo 09:17:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozInstall 09:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for mozleak 09:17:16 INFO - Running setup.py install for mozlog 09:17:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:17:16 INFO - Running setup.py install for moznetwork 09:17:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Running setup.py install for mozprocess 09:17:17 INFO - Running setup.py install for mozprofile 09:17:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Running setup.py install for mozrunner 09:17:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Running setup.py install for mozscreenshot 09:17:17 INFO - Running setup.py install for moztest 09:17:17 INFO - Running setup.py install for mozversion 09:17:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:17:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:17 INFO - Cleaning up... 09:17:17 INFO - Return code: 0 09:17:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17:17 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')]} 09:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:17 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')]} 09:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:17 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:17 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 09:17:17 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 09:17:17 INFO - Using env: {'DISPLAY': ':0', 09:17:17 INFO - 'HOME': '/home/cltbld', 09:17:17 INFO - 'LANG': 'en_US.UTF-8', 09:17:17 INFO - 'LANGUAGE': 'en_US:en', 09:17:17 INFO - 'LOGNAME': 'cltbld', 09:17:17 INFO - 'MAIL': '/var/mail/cltbld', 09:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:17 INFO - 'MOZ_NO_REMOTE': '1', 09:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:17 INFO - 'NO_EM_RESTART': '1', 09:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:17 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:17 INFO - 'SHELL': '/bin/bash', 09:17:17 INFO - 'SHLVL': '1', 09:17:17 INFO - 'TERM': 'linux', 09:17:17 INFO - 'TMOUT': '86400', 09:17:17 INFO - 'USER': 'cltbld', 09:17:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:17 INFO - '_': '/tools/buildbot/bin/python'} 09:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:17 INFO - Running setup.py (path:/tmp/pip-M7Yops-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:18 INFO - Running setup.py (path:/tmp/pip-9QQH5n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:18 INFO - Running setup.py (path:/tmp/pip-mGtmz0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:18 INFO - Running setup.py (path:/tmp/pip-sNnme5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:18 INFO - Running setup.py (path:/tmp/pip-tc3b6A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:18 INFO - Running setup.py (path:/tmp/pip-cgLvqK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:18 INFO - Running setup.py (path:/tmp/pip-uSjJGo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:18 INFO - Running setup.py (path:/tmp/pip-ULuqEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:18 INFO - Running setup.py (path:/tmp/pip-tve3Eq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:18 INFO - Running setup.py (path:/tmp/pip-KtyV4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:18 INFO - Running setup.py (path:/tmp/pip-wK2QBO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:18 INFO - Running setup.py (path:/tmp/pip-Ln1A3_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:18 INFO - Running setup.py (path:/tmp/pip-cuLLD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:18 INFO - Running setup.py (path:/tmp/pip-hZAOyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:17:18 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)) 09:17:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:18 INFO - Running setup.py (path:/tmp/pip-IHHTKr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:17:19 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)) 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:19 INFO - Running setup.py (path:/tmp/pip-x4J8Y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:17:19 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)) 09:17:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:19 INFO - Running setup.py (path:/tmp/pip-IvilL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:17:19 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)) 09:17:19 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)) 09:17:19 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)) 09:17:19 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)) 09:17:19 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)) 09:17:19 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)) 09:17:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:20 INFO - Downloading blessings-1.6.tar.gz 09:17:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:21 INFO - Installing collected packages: blessings 09:17:21 INFO - Running setup.py install for blessings 09:17:21 INFO - Successfully installed blessings 09:17:21 INFO - Cleaning up... 09:17:21 INFO - Return code: 0 09:17:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:21 INFO - Reading from file tmpfile_stdout 09:17:21 INFO - Current package versions: 09:17:21 INFO - argparse == 1.2.1 09:17:21 INFO - blessings == 1.6 09:17:21 INFO - blobuploader == 1.2.4 09:17:21 INFO - docopt == 0.6.1 09:17:21 INFO - manifestparser == 1.1 09:17:21 INFO - mozInstall == 1.12 09:17:21 INFO - mozcrash == 0.16 09:17:21 INFO - mozdebug == 0.1 09:17:21 INFO - mozdevice == 0.48 09:17:21 INFO - mozfile == 1.2 09:17:21 INFO - mozhttpd == 0.7 09:17:21 INFO - mozinfo == 0.9 09:17:21 INFO - mozleak == 0.1 09:17:21 INFO - mozlog == 3.1 09:17:21 INFO - moznetwork == 0.27 09:17:21 INFO - mozprocess == 0.22 09:17:21 INFO - mozprofile == 0.28 09:17:21 INFO - mozrunner == 6.11 09:17:21 INFO - mozscreenshot == 0.1 09:17:21 INFO - mozsystemmonitor == 0.0 09:17:21 INFO - moztest == 0.7 09:17:21 INFO - mozversion == 1.4 09:17:21 INFO - psutil == 3.1.1 09:17:21 INFO - requests == 1.2.3 09:17:21 INFO - wsgiref == 0.1.2 09:17:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:21 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 09:17:21 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 09:17:21 INFO - Using env: {'DISPLAY': ':0', 09:17:21 INFO - 'HOME': '/home/cltbld', 09:17:21 INFO - 'LANG': 'en_US.UTF-8', 09:17:21 INFO - 'LANGUAGE': 'en_US:en', 09:17:21 INFO - 'LOGNAME': 'cltbld', 09:17:21 INFO - 'MAIL': '/var/mail/cltbld', 09:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:21 INFO - 'MOZ_NO_REMOTE': '1', 09:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:21 INFO - 'NO_EM_RESTART': '1', 09:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:21 INFO - 'SHELL': '/bin/bash', 09:17:21 INFO - 'SHLVL': '1', 09:17:21 INFO - 'TERM': 'linux', 09:17:21 INFO - 'TMOUT': '86400', 09:17:21 INFO - 'USER': 'cltbld', 09:17:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:21 INFO - '_': '/tools/buildbot/bin/python'} 09:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 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)) 09:17:21 INFO - Cleaning up... 09:17:21 INFO - Return code: 0 09:17:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:17:21 INFO - Using env: {'DISPLAY': ':0', 09:17:21 INFO - 'HOME': '/home/cltbld', 09:17:21 INFO - 'LANG': 'en_US.UTF-8', 09:17:21 INFO - 'LANGUAGE': 'en_US:en', 09:17:21 INFO - 'LOGNAME': 'cltbld', 09:17:21 INFO - 'MAIL': '/var/mail/cltbld', 09:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:21 INFO - 'MOZ_NO_REMOTE': '1', 09:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:21 INFO - 'NO_EM_RESTART': '1', 09:17:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:21 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:21 INFO - 'SHELL': '/bin/bash', 09:17:21 INFO - 'SHLVL': '1', 09:17:21 INFO - 'TERM': 'linux', 09:17:21 INFO - 'TMOUT': '86400', 09:17:21 INFO - 'USER': 'cltbld', 09:17:21 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:21 INFO - '_': '/tools/buildbot/bin/python'} 09:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:21 INFO - Downloading/unpacking jsonschema 09:17:21 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 09:17:21 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 09:17:21 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 09:17:21 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 09:17:21 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 09:17:21 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 09:17:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:23 INFO - Downloading/unpacking functools32 (from jsonschema) 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 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 09:17:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:23 INFO - warning: no files found matching '*.txt' 09:17:23 INFO - no previously-included directories found matching 'build' 09:17:23 INFO - no previously-included directories found matching 'dist' 09:17:23 INFO - no previously-included directories found matching '.git*' 09:17:23 INFO - Installing collected packages: jsonschema, functools32 09:17:24 INFO - Running setup.py install for functools32 09:17:24 INFO - warning: no files found matching '*.txt' 09:17:24 INFO - no previously-included directories found matching 'build' 09:17:24 INFO - no previously-included directories found matching 'dist' 09:17:24 INFO - no previously-included directories found matching '.git*' 09:17:24 INFO - Successfully installed jsonschema functools32 09:17:24 INFO - Cleaning up... 09:17:24 INFO - Return code: 0 09:17:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:24 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 0x7f8ebb06df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265d670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', '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 09:17:24 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 09:17:24 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 09:17:24 INFO - Using env: {'DISPLAY': ':0', 09:17:24 INFO - 'HOME': '/home/cltbld', 09:17:24 INFO - 'LANG': 'en_US.UTF-8', 09:17:24 INFO - 'LANGUAGE': 'en_US:en', 09:17:24 INFO - 'LOGNAME': 'cltbld', 09:17:24 INFO - 'MAIL': '/var/mail/cltbld', 09:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:24 INFO - 'MOZ_NO_REMOTE': '1', 09:17:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:24 INFO - 'NO_EM_RESTART': '1', 09:17:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:24 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:24 INFO - 'SHELL': '/bin/bash', 09:17:24 INFO - 'SHLVL': '1', 09:17:24 INFO - 'TERM': 'linux', 09:17:24 INFO - 'TMOUT': '86400', 09:17:24 INFO - 'USER': 'cltbld', 09:17:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:24 INFO - '_': '/tools/buildbot/bin/python'} 09:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:24 INFO - Downloading/unpacking flake8 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:17:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:17:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 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 09:17:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:26 INFO - no previously-included directories found matching 'docs/_build' 09:17:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:17:26 INFO - Running setup.py install for pep8 09:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:17:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:17:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:17:27 INFO - no previously-included directories found matching 'docs/_build' 09:17:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:17:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:17:27 INFO - Cleaning up... 09:17:27 INFO - Return code: 0 09:17:27 INFO - Running post-action listener: _resource_record_post_action 09:17:27 INFO - Running post-action listener: _start_resource_monitoring 09:17:27 INFO - Starting resource monitoring. 09:17:27 INFO - ##### 09:17:27 INFO - ##### Running install step. 09:17:27 INFO - ##### 09:17:27 INFO - Running pre-action listener: _resource_record_pre_action 09:17:27 INFO - Running main action method: install 09:17:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:17:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:17:27 INFO - Reading from file tmpfile_stdout 09:17:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:17:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:17:27 INFO - Reading from file tmpfile_stdout 09:17:27 INFO - Output received: 09:17:27 INFO - Usage: mozinstall [options] installer 09:17:27 INFO - Options: 09:17:27 INFO - -h, --help show this help message and exit 09:17:27 INFO - -d DEST, --destination=DEST 09:17:27 INFO - Directory to install application into. [default: 09:17:27 INFO - "/builds/slave/test-pgo"] 09:17:27 INFO - --app=APP Application being installed. [default: firefox] 09:17:27 INFO - mkdir: /builds/slave/test-pgo/build/application 09:17:27 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'] 09:17:27 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 09:17:43 INFO - Reading from file tmpfile_stdout 09:17:43 INFO - Output received: 09:17:43 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:17:43 INFO - Running post-action listener: _resource_record_post_action 09:17:43 INFO - ##### 09:17:43 INFO - ##### Running run-tests step. 09:17:43 INFO - ##### 09:17:43 INFO - Running pre-action listener: _resource_record_pre_action 09:17:43 INFO - Running main action method: run_tests 09:17:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:17:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:17:43 INFO - Python 2.7.3 09:17:43 INFO - Return code: 0 09:17:43 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:43 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 0x26ec8c0>, '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 0x26ed7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26edc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:17:43 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 09:17:43 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 09:17:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:43 INFO - Return code: 0 09:17:43 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:17:43 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:17:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:17:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:17:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:17:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:17:44 INFO - Return code: 0 09:17:44 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/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 09:17:44 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/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 09:17:44 INFO - Using env: {'DISPLAY': ':0', 09:17:44 INFO - 'HOME': '/home/cltbld', 09:17:44 INFO - 'LANG': 'en_US.UTF-8', 09:17:44 INFO - 'LANGUAGE': 'en_US:en', 09:17:44 INFO - 'LOGNAME': 'cltbld', 09:17:44 INFO - 'MAIL': '/var/mail/cltbld', 09:17:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:44 INFO - 'MOZ_NO_REMOTE': '1', 09:17:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:44 INFO - 'NO_EM_RESTART': '1', 09:17:44 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:17:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:17:44 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:17:44 INFO - 'SHELL': '/bin/bash', 09:17:44 INFO - 'SHLVL': '1', 09:17:44 INFO - 'TERM': 'linux', 09:17:44 INFO - 'TMOUT': '86400', 09:17:44 INFO - 'USER': 'cltbld', 09:17:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423', 09:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:44 INFO - '_': '/tools/buildbot/bin/python'} 09:17:44 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/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 09:17:45 INFO - mozversion application_buildid: 20160217062621 09:17:45 INFO - mozversion application_changeset: 709f559b5406e8555cf84dd09bdc747b076f142c 09:17:45 INFO - mozversion application_display_name: Nightly 09:17:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:45 INFO - mozversion application_name: Firefox 09:17:45 INFO - mozversion application_remotingname: firefox 09:17:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:17:45 INFO - mozversion application_vendor: Mozilla 09:17:45 INFO - mozversion application_version: 47.0a1 09:17:45 INFO - mozversion platform_buildid: 20160217062621 09:17:45 INFO - mozversion platform_changeset: 709f559b5406e8555cf84dd09bdc747b076f142c 09:17:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:17:45 INFO - mozversion platform_version: 47.0a1 09:17:45 INFO - using testdate: 1455729465 09:17:45 INFO - actual date: 1455729465 09:17:45 INFO - starting webserver on 'localhost:57354' 09:17:45 INFO - SUITE-START | Running 2 tests 09:17:45 INFO - TEST-START | dromaeo_css 09:17:45 INFO - operating with platform_type : linux_ 09:17:45 INFO - Initialising browser for dromaeo_css test... 09:17:45 INFO - TEST-INFO | started process 4216 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph7uc5_/profile http://localhost:57354/getInfo.html) 09:17:49 INFO - PROCESS | 4216 | 09:17:49 INFO - PROCESS | 4216 | (process:4298): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:17:50 INFO - PROCESS | 4216 | __metrics Screen width/height:1600/1200 09:17:50 INFO - PROCESS | 4216 | colorDepth:24 09:17:50 INFO - PROCESS | 4216 | Browser inner width/height: 1024/697 09:17:50 INFO - PROCESS | 4216 | __metrics 09:17:50 ERROR - PROCESS | 4216 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 09:17:51 INFO - TEST-INFO | 4216: exit 0 09:17:51 INFO - Browser initialized. 09:17:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:51 INFO - TEST-INFO | started process 4349 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph7uc5_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:53 INFO - PROCESS | 4349 | 09:17:53 INFO - PROCESS | 4349 | (process:4406): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:03 INFO - PROCESS | 4349 | RSS: Main: 155164672 09:18:03 INFO - PROCESS | 4349 | 09:18:53 INFO - PROCESS | 4349 | 1455729533287 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] 09:21:02 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57354/tests/dromaeo/cssquery-ext.html) 09:21:03 INFO - PROCESS | 4349 | RSS: Main: 164315136 09:21:03 INFO - PROCESS | 4349 | 09:24:06 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-ext.html (next: http://localhost:57354/tests/dromaeo/cssquery-jquery.html) 09:24:06 INFO - PROCESS | 4349 | RSS: Main: 159174656 09:24:06 INFO - PROCESS | 4349 | 09:27:08 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57354/tests/dromaeo/cssquery-mootools.html) 09:27:09 INFO - PROCESS | 4349 | RSS: Main: 161288192 09:27:09 INFO - PROCESS | 4349 | 09:30:10 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57354/tests/dromaeo/cssquery-prototype.html) 09:30:11 INFO - PROCESS | 4349 | RSS: Main: 159035392 09:30:11 INFO - PROCESS | 4349 | 09:33:13 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57354/tests/dromaeo/cssquery-yui.html) 09:33:14 INFO - PROCESS | 4349 | RSS: Main: 158928896 09:33:14 INFO - PROCESS | 4349 | 09:36:16 INFO - PROCESS | 4349 | Cycle 1(1): loaded http://localhost:57354/tests/dromaeo/cssquery-yui.html (next: http://localhost:57354/tests/dromaeo/cssquery-dojo.html) 09:36:17 INFO - PROCESS | 4349 | RSS: Main: 162992128 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | __start_tp_report 09:36:17 INFO - PROCESS | 4349 | _x_x_mozilla_page_load 09:36:17 INFO - PROCESS | 4349 | _x_x_mozilla_page_load_details 09:36:17 INFO - PROCESS | 4349 | |i|pagename|runs| 09:36:17 INFO - PROCESS | 4349 | |0;dojo.html;3203.7597180211483;3291.2594666200093;3307.6526964668724;3334.416477116504;3346.41437748394;5270.235815806705;5370.462953704632;5379.139337705968;5386.973065134679;5398;5338.252644629755;5393.352797664276;5398.109311963522;5433.972830135844;5467.726613669311;4896.290037944496;4939.407271127469;4975.676581022222;5071.3407257056715;5125.718085505315;4796.448408433022;5000.699958002513;5021.422536408305;5030.346055012843;5082.034413461449;4864.343313652647;4918.163912134945;4922.704637721748;4947;4953.727544985024;4956.157453232959;4964.081644895706;4973.179425394806;4994.076095922266;5001.049800537886;4792.760361981887;4881.048195601859;4962.255661650745;4964.627652926045;5010.223415370623;5213.3743950725775;5222.32109825724;5223.059849227137;5226.52961233487;5258.447862974409;5763.510101641324;5778.191053252548;5802.65184088956;5804.303483581955;5826.533877289807;5617.859553511195;5824.359320474744;5846;5870;5953.940460595382;5479.6164268501225;5484.451554844523;5487.039768040617;5489.972550137224;5494.340679118492;5774.133879918046;5976.7908123215475;5980.401959803985;5994.37059108796;6002.159697642333;5729.4843464088435;5745.540356771448;5746.770129194869;5759.2512973313205;5786.623869448473;5849.327327357323;5849.590528662953;5852.502537284378;5862.501687356537;5867.266591676041;5663.178839068312;5775.971120144372;5788.27646544182;5848.912266316009;5909.320428150818;5768.7980920668415;5814.854628634233;5833.416658334133;5838.5037271831525;5839.591228613956;4337.175936572041;4442.844500442534;4461.397711308931;4465.218586747371;4523.570260825217;3972;3980.2238563479846;3990.580988996114;4011.2579172853116;4018.959810401917;5434.402215756264;5498.367687715964;5498.890022199534;5526.364468086222;5541.5289700375115;5594.104943209067;5805.042168042311;5918.378570250062;5923.229980102559;5925.4074592541265;5437.075697131418;5449.891002179934;5455.8363249102595;5460.781568737206;5485.286912701324;4975.751212439363;4978.203487442064;4985.975070124626;5005.674631148963;5014.6991180529285;5938.910916336258;6033.456988871023;6092.855796792335;6129.114290130661;6131.877362452726;5777.364489906023;5791.53667706574;5801.941980580309;5806.854828629318;5833.912491312719;5856.209411729362;6013.699315034319;6029.758809647565;6042.879142417215;6046;5768.94231057684;5806.2451881255165;5806.9419305806405;5813.244278243801;5836.066229403275;5785.30576330843;5798.768049277982;5838.532917366516;5847.766089356378;5847.853803654943;5550.75021624036;5649.265595472562;5649.915251271316;5674.57440691958;5716.942830571641;5580.358258800127;5639.097744360883;5642.379338272704;5647.322321321468;5670.489655930986;5520.309961254843;5547.084731019337;5552.944470555242;5563;5566.415526369673;5520.1443776214755;5568.248286481273;5572.3034620672415;5638.2670252866865;5638.4925356718095;5444.918326225031;5507.807226747044;5570;5588.916166257591;5627.184058311604 09:36:17 INFO - PROCESS | 4349 | |1;ext.html;526.252721135987;526.4367127173923;534.516262782182;547.4416095582508;550.6751016900029;34928.301433971305;35618.46572301411;35651.82174089126;35859.64140358599;35983.64016359836;36857.44713829295;37315.62684373155;37404.251914961686;37476;37476.06309842255;8237.135100814403;8358.373122015842;8434.704785332484;8454.28138608219;8454.87317690232;8213.137620549845;8553.74338769838;8578.699745508908;8581.39930204886;8630.136986301351;8544.957275213616;8630.266427353683;8664.306855451548;8716.346274029442;8717.476951382905;8516.914830851705;8525.786855328604;8592.8711069334;8610.311175105977;8637.65449382024;8453.873191902127;8589.355798315151;8599.656013759442;8605.225529702357;8625.525596092213;36661;37061.81469092664;37062;37172;37309.44035839465;3333.2666813301034;3404.710599599037;3463.619001909788;3498.8803582853498;3571.8035508047046;30262.394752104836;31078.844605777052;31310.530342044887;31356;32002;3752.3245815753426;3847.2882516734494;3954.189391174831;3982.38273067675;4010.3984402339593;214674;215948;216758.66482670416;219944;220562;42182.57817421848;42602.78698606549;42777.78611106925;62766;62977.370226298066;40933.59066409357;40944.79527602402;41095.7945210272;41125.177496449905;41189.176216475505;14380.712385752226;14594.927025364805;14635.195064271567;14684.118952862862;14689.92655036718;11799.705007374712;11865.466054027589;11878.88121118795;11880.108991825648;11931.284122952651;14450;14502.709945801236;14603.342849571794;14631.341589628491;14659.92670036643;5745.13822926556;5795.623284486495;5805.82582522525;5812.82561523155;5854.268216472941;854.1287886355882;893.41927746965;895.2077411490748;939.4832841936908;939.6053657463882;29548.556771648444;29935.70064299329;29996.037642397227;30102.69897301043;30931.381372372878;1020.3062915560283;1061.1139698351808;1061.6708820265742;1064.8189807732704;1123.8145705958425;15076.24618769057;15156.469523566842;15198.985602747633;15530.689386212212;15616.219189040503;391181;391759;392175;392470;394371;54074.72962635162;54183;54462.45537544653;54600.72699636476;54750.72624636851;1322.6296636941672;1358.1783021272186;1360.4762166565943;1362.3188405796902;1364.9249291288875;28106;28793;28825.279368015967;29419.264518387212;29727;46425.76787116043;47616.7619161902;47841.28238076362;47860.760696196296;47891.28163077487;297433;298748;298931;298951;299066;28053.719462805926;31597;31747.20631984219;32242.193945151557;33000;37199.628003720696;37488.812555937046;37523.06192345213;38592.6140738589;38706.6129338703;34597.82701086579;35155.824220878734;35408.64591354054;35534.644653553136;35763.64236357603;36014.639853601126;36238.818805906856;36295.63704363028;38681;40308.992275192184;33479.66520334766;38050.048748781504;39060.609393905695;39295.60704393034;39526;27698.89397122425;33171.83414082914;33900.83049584736;33983.83008084944;34086;25668.229953101436;26103.608445872946;26117.869410652824;26380.604290936037;26516.867415662797 09:36:17 INFO - PROCESS | 4349 | |2;jquery.html;353.9805310707912;355.7918617608699;360.3441736040406;361.6564263949247;363.96542328478785;16376;16636.91681541592;17174.74237886433;17499.212535435905;18032.18855151518;15273.465428709997;15281.235938203074;15313.387464501406;15673.608159796011;15674.843251567481;4871.756412179386;5019.347484826967;5112.693238405689;5120.718360490171;5127.820526281581;5063.670861393997;5157.6131790115705;5178.300929374543;5208.661437006602;5390.056740070472;5157.071727089123;5360.437154098822;5377.7580008899695;5383.81156659517;5418.810341638044;5036.924446133311;5210.5310522053005;5242.501962313574;5247.47525247476;5255.842324730264;5048.343715317022;5051.520105589963;5053.5957123430035;5057.5448209660935;5088.949110508885;13040.80438793419;13151.671208219776;13173.802392964113;13189.340532973312;15690.058596484247;2258.5934531784274;2286.371247906839;2296.712910886139;2618.201448558189;2687.4625074985083;9192.586333615003;9254.583543740548;9535.380200287029;9559.713208603753;9733.124018838267;1793.4709260767975;1851.6666999940005;1865.8600604954547;1882.6234753049307;1890.2816929566814;61091.38908610901;61857;64424.355756442776;64851.351486485;65118;10005.249606279413;10262.281640285108;10398.168146548258;10443.530041148166;10475.94762026185;13597.932010340082;13613.795793063113;13621.863781362059;13767.793483097761;13789.586312410644;7681.116671582728;7696.6536505857375;7734.961325193451;7745.302922736981;7793.2596403341595;7474.775756727198;7479.588622625808;7572.734954276574;7593.810154746176;7596.962015189999;4403.581659742319;4436.711613745097;4444.533324000933;4454.1982443159895;4498.482674492475;1779.5817982774038;1796.2725096336005;1890.782560005617;1901.2585091814203;1907.6661584222707;918.4856480371013;945.5981207986579;955.6559638530124;993.3046867192994;1061.7557961668706;15406.768898466533;15865.762013569805;15893.205339732967;16225.837741622432;16707.164641767864;843.2284459719289;881.6517475597103;903.5572569440926;932.021377553566;947.516766449116;9136.908630913606;9718.854217186748;9819.852702209473;9895.851562226573;9965.302428829913;526576;541818;551457;556707;560596;50554.74722626437;50672.74663626658;51622.74188629033;68589.3141068593;76871.23128768752;1158.7219067423757;1177.381874515886;1177.3877583656451;1181.3620644851856;1211.2792888231488;14926.179060151795;15269.847301527287;15375.461858834888;15469.690606188038;15820.92089539545;34634.48048279227;35043.29913401769;35404.64595354014;35543.82228088843;35652.64347356493;43933.78033109814;44824.32763508615;45208.77395613001;50519.24221136612;50681;7771.37828973692;7884.645190966306;7910.169432209766;7922.0889597694695;8003.719869804761;10985.670429887115;11143.72140696489;12313.507459701512;12395.566155184526;12598.307093109966;10696.465176740976;10767.6231331903;10931;11012.889871101186;11234.719132021764;10715.785684286426;11045.447727613748;11110.222284440011;11285.492152852978;11365.54537818511;6059.151718759289;8704.434211776213;10518.368897866152;10814.35113893169;11480.311181329147;7140.857182856417;7501.662425190989;7571.129320128035;7820.45256832039;8005.8398832024195;9625.56684949193;10019.098281154731;10214.948925255327;10377.11794497446;10464.476776161313 09:36:17 INFO - PROCESS | 4349 | |3;mootools.html;1480.1193289992455;1495.4616338118278;1677.7735005774216;1773.866959978002;1813.4831573001698;7616.086069671634;7683.731069412572;7783.610819459032;7872.763817085496;7874.055113386395;7860.096088949773;7887.60561971902;7902.802429939255;7936.642851071701;7977.0826354969195;2338.649202619608;2360.527894421114;2360.9645855312097;2363.6690863279155;2367.029517897662;2349.530093981202;2361.8464799787957;2364.0780095762666;2373.347329484397;2381.1427885961125;2224.955500889981;2274.8066414354716;2283.748787633359;2307.215546714117;2330.8951097200666;2285.04028308111;2295.7359903610964;2308.3998160478227;2322.4077860145553;2325.744168141503;2411.4333131714034;2433.4889673168655;2434.732179460258;2437.390652336916;2450.840695354814;7795.961020194863;8052.074011488695;8066.677332906676;8069.556174410405;8071.878921816177;4813.494583068762;4912.238603016538;4953.826616068456;4961.404631444214;4987.376577927759;3078.5536097265995;3166.62000559932;3171.20719820045;3182.427163110639;3188.2666986593213;935.088288918306;941.8587211918199;958.7171784323572;974.488393593362;974.8976357482433;10915.454227288605;11018.11855051602;11026.614068507564;11027.117830573536;11041;4214.262504061777;4256.70203085781;4289.335153051282;4353.760543170093;4359.411479450297;8849.823003539894;8858.86711699325;8861.202491775643;8861.379703420827;8909.242714369222;4828.903421931542;4843.104025755247;4852.514748525119;4860.027994401064;4896.510348965075;4442.089371678798;4448.5773851484055;4466.062126953311;4468.865934021985;4479.193745125844;3449.068751437098;3479.8782042628386;3486.4073107571776;3488.7732297401094;3536.6463353664426;1033.2921948465325;1037.4138611684375;1044.6970378590124;1049.4070849969742;1073.5239046311322;982.7002764157;1033.1373303291834;1033.2508931025097;1125.392288164382;1258.5028913579267;7066.611336376446;7185.173705023884;7216.494845360774;7230.2046774854725;7239.565626062348;625.0530446373748;637.5473413876107;641.1696852575925;641.6695401868042;777.362562698593;5524.502794748492;5541.944580554224;5644.096944488862;5710.65736055838;5790.334111577138;9397.154256116983;9639.951800241095;9658.71023869285;9687.17658998979;9716.61133554664;9408.529573521297;9578.616855325708;9622.711318660311;9629;9643.324967252225;7340.302671246223;7467.1039475263315;7502.587357695379;7556.168821429638;7566.2433756625;7078.575285482888;7121.359077682826;7144.67848946809;7153.105861767279;7179.353858152791;8397.118302578141;8584.055753866945;8584.141585841366;8712.21590056898;8714.91285087141;8734.56327183651;8748.956255218684;8777.91222087771;8824.161704638049;8831.64673413082;6585.769498067544;6661.866762664623;6694.129763130762;6697.162854643169;6712.798616041527;7456.254374562717;7597.810054748676;7635.809104772425;7642.923570764221;7650.1584825668015;6311.936880631135;7148.821279467847;7168.53404528704;7170.784876453715;7193.568385896863;6727.529072964846;6764.695588698619;6828.9658551706925;6865.931340686729;6871.931280687129;6736.292689267556;6837.692303846438;6848.623325717133;6866.382025617719;6908.1019467468905;6369.49044076482;6371.49028077762;6406.583572067801;6420.839479012875;6421.357864213728;6301.873962520815;6310.5898116622275;6370.904436433365;6580.605163690194;6598.439132673777 09:36:17 INFO - PROCESS | 4349 | |4;prototype.html;327.06948730860705;331.4001657000828;337.14365511600533;337.239524871415;340.8057407277851;6271.090691849679;6352.872942541158;6361.632249066444;6372.203474565679;6474.25546062203;6249.218847644044;6263.091851681504;6310.936890631104;6314.368563143684;6330.177076979986;4781.187198176301;4811.3504676868615;4815.133276010317;4828.299896515021;4835.492273311304;4807.831725889595;4837.879053023685;4840.201366774478;4845.903081938377;4848.248521479177;4689.671722979393;4765.356676848615;4785.521447855222;4786.066716990188;4788.832390866321;4754.215554433515;4766.880827979294;4789.80840766369;4791.401074865642;4792.544708252711;4116.320807066831;4126.319157339066;4137.1518838638;4137.834486620532;4139.399787030894;5987.850303742398;5991.131285963511;6008;6010.849728756816;6018.247719035121;5374.596905232123;5540.556755459554;5545.223668686387;5566.2207290979295;5583.218349431083;6655.201375834882;6668.366505182048;6671.966640166816;6681.131452911139;6688.498362622823;4552.066826300634;4555.06621142665;4555.385023021916;4571.017231295287;4575.428071491064;6587.868242635169;6886.24251332353;6911.136107986502;6924.549904256258;6988.126484189476;4568.954310456853;4616.0998605272325;4629.074185162914;4630.791614377361;4634.235351167087;4653.813847446132;4664.813407463731;4680.602148817321;4683.063387322549;4688.367070445446;5461.2627295315415;5483.588730845203;5491.313585801775;5494.670319780826;5495.587830912697;6552.443042341454;6662.966685166543;6697.698603562754;6706.094677218513;6732.865342693217;1600.6158521954646;1618.8057433108102;1651.859591934699;1651.9587010324838;1652.7520871869076;1054.8154073037188;1075.5697720911699;1086.3590481615727;1087.4888802262924;1097.1277834121893;6161.630302181794;6185.443310102112;6213.130161777355;6227.626342419469;6258.812235632939;6789.626570538569;6817.5568588041615;6825.48808839339;6850.21222559412;6852.5203235774015;6153.353897840751;6199.225096862892;6200;6244.812655620339;6248.750049997949;3683.594804571495;3693.316736403774;3718.1819999600043;3719.2933342664805;3728.105254738897;7106.111736032996;7180.210176880539;7197.9640101800205;7199.2080871104135;7203.099612548432;6815.182178138655;6957.65211739411;6984.4412447004115;6997.790066297917;7000;7071.080759501335;7083.468739844532;7103.502754807218;7126.144862616416;7131.393831524275;6725.562838415487;6788.796336109925;6799.490038247251;6801.89797153053;6804.795856124324;6575;6689.26418094019;6705.497087718538;6729.394354507922;6750;7082.114735658043;7108.857822843617;7126.679299431435;7128.928710712827;7174.713011479691;4585.977070114628;4597.5747518269445;4599.425071866017;4602.447706275135;4621.722696638212;6477.805665829844;6792.558483698544;6837.384635382839;6848.9657551711925;6904.689288981907;6683.465322774264;6708.960111182774;6727.663616819237;6730.057791909038;6747.291534388818;6642.236142843635;6673.032410300382;6704.128463299739;6708.932910671026;6736.730530778714;6501.804945851442;6576.736930522726;6606.570572912745;6622.337766223339;6630.171228596426;6697.3637504437;6745.527813053235;6774.796756097325;6781.186257649114;6784.185897692309;6537.8692426150255;6546;6570.441512471493;6573.835654108686;6593.505487088583 09:36:17 INFO - PROCESS | 4349 | |5;yui.html;706.3960313931589;713.3045280851168;728.5701436152669;739.6375775869825;756.0700338583543;13186;16088.195590220486;16303.673926521462;16320.020798752068;16345;14105.153690778561;14169.574912752609;14228.359723812428;14243.074200176981;14256.92871535641;834.1491678487939;834.3700506117902;835.482001159282;836.5315423362906;859.5186695450536;854.4189950833431;857.1942374168293;857.8370109679141;857.9056303806576;858.3347905373323;889.2796834564024;892.2193081054078;893.1381217125472;893.1916615463016;894.2845723421269;889.4796544021755;891.7101941868918;893.0221407558713;893.7988952485704;893.8078313162669;650.6388954130456;651.3584119642148;654.228010947087;656.0651072222112;656.4059526128862;13867.861321386757;13909.652258693512;13928.791068133985;13936.303184840717;13941.372638231303;12524.74950500994;12544.310062946533;12786.61640150797;12836.87163128366;12896;10559.947200264027;10601.469926503643;10616.256862019662;10697.09074728649;10863.945680271627;3501.7023552998025;3615.0600843780544;3615.7288203384587;3641.4887821554025;3645.6354364563595;49004;50914.490855091346;50975.74512127416;51030.744846275906;51369.743151284005;9681.70954871355;9743.220542356594;9750.658726944523;9818.852717209247;9990.600375985025;17913.19390627425;18000.639987200444;18056.90971545134;18060.458186254433;18167.818321816878;7556.735514256975;7685.769426917202;7749.108852481924;7785.493942893694;7848.450608457353;4403.867883963486;4434.82260709568;4480.507144214133;4495.033567782943;4581.381513495702;3116.828574428428;3120.3603261331373;3127.8592463339205;3142.120206342182;3156.873725051018;528.8624957510998;536.3778017499682;538.606817023575;548.4734654731502;571.1632458448393;610.9266887973472;620.1380081686459;622.6762083716442;627.6861569215392;657.5097932265544;7717.922820771832;7867.921320786833;7899.249571290718;7999.920000799918;8057.0734365548715;560.907450270709;612.6814056690586;667.279338314619;672.4116398151617;729.234303980818;3823.866164684223;3868.323043467382;3910.9804450977563;3936.3111455495173;4059.289624315733;54293.72853135709;54402.72798636061;54619.72690136603;54797;54841.72579137079;50268.24597631038;50356.74821625868;50393.74803125961;50524.74737626289;50685.23972140421;44788.77605611951;45891.77054114708;46094.76952615283;46134;46593.06813863772;7760.495567788075;7763.456558040883;7938.880916786137;8109.3917956152345;8124.7562573122905;32718.67281327156;32964;33640.831795840866;33727.66272337245;33805.83097084499;41914;42262;42766.57233427626;43044;43378.349324759525;9864.260180486348;9901.55443005081;10077.848832267375;10148.898511014795;10484.842727359248;11310.434478275889;11403.714907127389;11511.136664750009;11526.88473115258;11592.768144637228;9897;10051.949740251544;10398.792024159626;10492.79014419692;10749.247552671552;9600.66397676078;9980.351277166961;9994.300398972002;10088.798224035625;10097.89902100999;10207.54066067014;10248.897511024794;10589.4705264738;10744.83882741744;10775.299605525615;8849.20357167858;9161.587728552364;9183.219426348835;9268.351215414856;9523.380980236263;8711.869321960303;8712.69505567302;8884.73345799627;9611.231101512001;9729.124378805942 09:36:17 INFO - PROCESS | 4349 | __end_tp_report 09:36:17 INFO - PROCESS | 4349 | __start_cc_report 09:36:17 INFO - PROCESS | 4349 | _x_x_mozilla_cycle_collect,330 09:36:17 INFO - PROCESS | 4349 | __end_cc_report 09:36:17 INFO - PROCESS | 4349 | __startTimestamp1455730577087__endTimestamp 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | ------- Summary: start ------- 09:36:17 INFO - PROCESS | 4349 | Number of tests: 6 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#0] dojo.html Cycles:165 Average:5395.94 Median:5563.00 stddev:594.32 (10.7%) stddev-sans-first:570.72 09:36:17 INFO - PROCESS | 4349 | Values: 3203.8 3291.3 3307.7 3334.4 3346.4 5270.2 5370.5 5379.1 5387.0 5398.0 5338.3 5393.4 5398.1 5434.0 5467.7 4896.3 4939.4 4975.7 5071.3 5125.7 4796.4 5000.7 5021.4 5030.3 5082.0 4864.3 4918.2 4922.7 4947.0 4953.7 4956.2 4964.1 4973.2 4994.1 5001.0 4792.8 4881.0 4962.3 4964.6 5010.2 5213.4 5222.3 5223.1 5226.5 5258.4 5763.5 5778.2 5802.7 5804.3 5826.5 5617.9 5824.4 5846.0 5870.0 5953.9 5479.6 5484.5 5487.0 5490.0 5494.3 5774.1 5976.8 5980.4 5994.4 6002.2 5729.5 5745.5 5746.8 5759.3 5786.6 5849.3 5849.6 5852.5 5862.5 5867.3 5663.2 5776.0 5788.3 5848.9 5909.3 5768.8 5814.9 5833.4 5838.5 5839.6 4337.2 4442.8 4461.4 4465.2 4523.6 3972.0 3980.2 3990.6 4011.3 4019.0 5434.4 5498.4 5498.9 5526.4 5541.5 5594.1 5805.0 5918.4 5923.2 5925.4 5437.1 5449.9 5455.8 5460.8 5485.3 4975.8 4978.2 4986.0 5005.7 5014.7 5938.9 6033.5 6092.9 6129.1 6131.9 5777.4 5791.5 5801.9 5806.9 5833.9 5856.2 6013.7 6029.8 6042.9 6046.0 5768.9 5806.2 5806.9 5813.2 5836.1 5785.3 5798.8 5838.5 5847.8 5847.9 5550.8 5649.3 5649.9 5674.6 5716.9 5580.4 5639.1 5642.4 5647.3 5670.5 5520.3 5547.1 5552.9 5563.0 5566.4 5520.1 5568.2 5572.3 5638.3 5638.5 5444.9 5507.8 5570.0 5588.9 5627.2 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#1] ext.html Cycles:180 Average:46034.06 Median:36959.63 stddev:81882.45 (221.5%) stddev-sans-first:82040.86 09:36:17 INFO - PROCESS | 4349 | Values: 526.3 526.4 534.5 547.4 550.7 34928.3 35618.5 35651.8 35859.6 35983.6 36857.4 37315.6 37404.3 37476.0 37476.1 8237.1 8358.4 8434.7 8454.3 8454.9 8213.1 8553.7 8578.7 8581.4 8630.1 8545.0 8630.3 8664.3 8716.3 8717.5 8516.9 8525.8 8592.9 8610.3 8637.7 8453.9 8589.4 8599.7 8605.2 8625.5 36661.0 37061.8 37062.0 37172.0 37309.4 3333.3 3404.7 3463.6 3498.9 3571.8 30262.4 31078.8 31310.5 31356.0 32002.0 3752.3 3847.3 3954.2 3982.4 4010.4 214674.0 215948.0 216758.7 219944.0 220562.0 42182.6 42602.8 42777.8 62766.0 62977.4 40933.6 40944.8 41095.8 41125.2 41189.2 14380.7 14594.9 14635.2 14684.1 14689.9 11799.7 11865.5 11878.9 11880.1 11931.3 14450.0 14502.7 14603.3 14631.3 14659.9 5745.1 5795.6 5805.8 5812.8 5854.3 854.1 893.4 895.2 939.5 939.6 29548.6 29935.7 29996.0 30102.7 30931.4 1020.3 1061.1 1061.7 1064.8 1123.8 15076.2 15156.5 15199.0 15530.7 15616.2 391181.0 391759.0 392175.0 392470.0 394371.0 54074.7 54183.0 54462.5 54600.7 54750.7 1322.6 1358.2 1360.5 1362.3 1364.9 28106.0 28793.0 28825.3 29419.3 29727.0 46425.8 47616.8 47841.3 47860.8 47891.3 297433.0 298748.0 298931.0 298951.0 299066.0 28053.7 31597.0 31747.2 32242.2 33000.0 37199.6 37488.8 37523.1 38592.6 38706.6 34597.8 35155.8 35408.6 35534.6 35763.6 36014.6 36238.8 36295.6 38681.0 40309.0 33479.7 38050.0 39060.6 39295.6 39526.0 27698.9 33171.8 33900.8 33983.8 34086.0 25668.2 26103.6 26117.9 26380.6 26516.9 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#2] jquery.html Cycles:180 Average:27717.97 Median:4440.62 stddev:89384.16 (2012.9%) stddev-sans-first:89611.29 09:36:17 INFO - PROCESS | 4349 | Values: 354.0 355.8 360.3 361.7 364.0 16376.0 16636.9 17174.7 17499.2 18032.2 15273.5 15281.2 15313.4 15673.6 15674.8 4871.8 5019.3 5112.7 5120.7 5127.8 5063.7 5157.6 5178.3 5208.7 5390.1 5157.1 5360.4 5377.8 5383.8 5418.8 5036.9 5210.5 5242.5 5247.5 5255.8 5048.3 5051.5 5053.6 5057.5 5088.9 13040.8 13151.7 13173.8 13189.3 15690.1 2258.6 2286.4 2296.7 2618.2 2687.5 9192.6 9254.6 9535.4 9559.7 9733.1 1793.5 1851.7 1865.9 1882.6 1890.3 61091.4 61857.0 64424.4 64851.4 65118.0 10005.2 10262.3 10398.2 10443.5 10475.9 13597.9 13613.8 13621.9 13767.8 13789.6 7681.1 7696.7 7735.0 7745.3 7793.3 7474.8 7479.6 7572.7 7593.8 7597.0 4403.6 4436.7 4444.5 4454.2 4498.5 1779.6 1796.3 1890.8 1901.3 1907.7 918.5 945.6 955.7 993.3 1061.8 15406.8 15865.8 15893.2 16225.8 16707.2 843.2 881.7 903.6 932.0 947.5 9136.9 9718.9 9819.9 9895.9 9965.3 526576.0 541818.0 551457.0 556707.0 560596.0 50554.7 50672.7 51622.7 68589.3 76871.2 1158.7 1177.4 1177.4 1181.4 1211.3 14926.2 15269.8 15375.5 15469.7 15820.9 34634.5 35043.3 35404.6 35543.8 35652.6 43933.8 44824.3 45208.8 50519.2 50681.0 7771.4 7884.6 7910.2 7922.1 8003.7 10985.7 11143.7 12313.5 12395.6 12598.3 10696.5 10767.6 10931.0 11012.9 11234.7 10715.8 11045.4 11110.2 11285.5 11365.5 6059.2 8704.4 10518.4 10814.4 11480.3 7140.9 7501.7 7571.1 7820.5 8005.8 9625.6 10019.1 10214.9 10377.1 10464.5 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#3] mootools.html Cycles:180 Average:5491.05 Median:6421.10 stddev:2877.66 (44.8%) stddev-sans-first:2869.94 09:36:17 INFO - PROCESS | 4349 | Values: 1480.1 1495.5 1677.8 1773.9 1813.5 7616.1 7683.7 7783.6 7872.8 7874.1 7860.1 7887.6 7902.8 7936.6 7977.1 2338.6 2360.5 2361.0 2363.7 2367.0 2349.5 2361.8 2364.1 2373.3 2381.1 2225.0 2274.8 2283.7 2307.2 2330.9 2285.0 2295.7 2308.4 2322.4 2325.7 2411.4 2433.5 2434.7 2437.4 2450.8 7796.0 8052.1 8066.7 8069.6 8071.9 4813.5 4912.2 4953.8 4961.4 4987.4 3078.6 3166.6 3171.2 3182.4 3188.3 935.1 941.9 958.7 974.5 974.9 10915.5 11018.1 11026.6 11027.1 11041.0 4214.3 4256.7 4289.3 4353.8 4359.4 8849.8 8858.9 8861.2 8861.4 8909.2 4828.9 4843.1 4852.5 4860.0 4896.5 4442.1 4448.6 4466.1 4468.9 4479.2 3449.1 3479.9 3486.4 3488.8 3536.6 1033.3 1037.4 1044.7 1049.4 1073.5 982.7 1033.1 1033.3 1125.4 1258.5 7066.6 7185.2 7216.5 7230.2 7239.6 625.1 637.5 641.2 641.7 777.4 5524.5 5541.9 5644.1 5710.7 5790.3 9397.2 9640.0 9658.7 9687.2 9716.6 9408.5 9578.6 9622.7 9629.0 9643.3 7340.3 7467.1 7502.6 7556.2 7566.2 7078.6 7121.4 7144.7 7153.1 7179.4 8397.1 8584.1 8584.1 8712.2 8714.9 8734.6 8749.0 8777.9 8824.2 8831.6 6585.8 6661.9 6694.1 6697.2 6712.8 7456.3 7597.8 7635.8 7642.9 7650.2 6311.9 7148.8 7168.5 7170.8 7193.6 6727.5 6764.7 6829.0 6865.9 6871.9 6736.3 6837.7 6848.6 6866.4 6908.1 6369.5 6371.5 6406.6 6420.8 6421.4 6301.9 6310.6 6370.9 6580.6 6598.4 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#4] prototype.html Cycles:180 Average:5543.82 Median:6260.95 stddev:1687.81 (27.0%) stddev-sans-first:1646.50 09:36:17 INFO - PROCESS | 4349 | Values: 327.1 331.4 337.1 337.2 340.8 6271.1 6352.9 6361.6 6372.2 6474.3 6249.2 6263.1 6310.9 6314.4 6330.2 4781.2 4811.4 4815.1 4828.3 4835.5 4807.8 4837.9 4840.2 4845.9 4848.2 4689.7 4765.4 4785.5 4786.1 4788.8 4754.2 4766.9 4789.8 4791.4 4792.5 4116.3 4126.3 4137.2 4137.8 4139.4 5987.9 5991.1 6008.0 6010.8 6018.2 5374.6 5540.6 5545.2 5566.2 5583.2 6655.2 6668.4 6672.0 6681.1 6688.5 4552.1 4555.1 4555.4 4571.0 4575.4 6587.9 6886.2 6911.1 6924.5 6988.1 4569.0 4616.1 4629.1 4630.8 4634.2 4653.8 4664.8 4680.6 4683.1 4688.4 5461.3 5483.6 5491.3 5494.7 5495.6 6552.4 6663.0 6697.7 6706.1 6732.9 1600.6 1618.8 1651.9 1652.0 1652.8 1054.8 1075.6 1086.4 1087.5 1097.1 6161.6 6185.4 6213.1 6227.6 6258.8 6789.6 6817.6 6825.5 6850.2 6852.5 6153.4 6199.2 6200.0 6244.8 6248.8 3683.6 3693.3 3718.2 3719.3 3728.1 7106.1 7180.2 7198.0 7199.2 7203.1 6815.2 6957.7 6984.4 6997.8 7000.0 7071.1 7083.5 7103.5 7126.1 7131.4 6725.6 6788.8 6799.5 6801.9 6804.8 6575.0 6689.3 6705.5 6729.4 6750.0 7082.1 7108.9 7126.7 7128.9 7174.7 4586.0 4597.6 4599.4 4602.4 4621.7 6477.8 6792.6 6837.4 6849.0 6904.7 6683.5 6709.0 6727.7 6730.1 6747.3 6642.2 6673.0 6704.1 6708.9 6736.7 6501.8 6576.7 6606.6 6622.3 6630.2 6697.4 6745.5 6774.8 6781.2 6784.2 6537.9 6546.0 6570.4 6573.8 6593.5 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - PROCESS | 4349 | [#5] yui.html Cycles:180 Average:13574.94 Median:50945.12 stddev:15683.38 (30.8%) stddev-sans-first:15697.60 09:36:17 INFO - PROCESS | 4349 | Values: 706.4 713.3 728.6 739.6 756.1 13186.0 16088.2 16303.7 16320.0 16345.0 14105.2 14169.6 14228.4 14243.1 14256.9 834.1 834.4 835.5 836.5 859.5 854.4 857.2 857.8 857.9 858.3 889.3 892.2 893.1 893.2 894.3 889.5 891.7 893.0 893.8 893.8 650.6 651.4 654.2 656.1 656.4 13867.9 13909.7 13928.8 13936.3 13941.4 12524.7 12544.3 12786.6 12836.9 12896.0 10559.9 10601.5 10616.3 10697.1 10863.9 3501.7 3615.1 3615.7 3641.5 3645.6 49004.0 50914.5 50975.7 51030.7 51369.7 9681.7 9743.2 9750.7 9818.9 9990.6 17913.2 18000.6 18056.9 18060.5 18167.8 7556.7 7685.8 7749.1 7785.5 7848.5 4403.9 4434.8 4480.5 4495.0 4581.4 3116.8 3120.4 3127.9 3142.1 3156.9 528.9 536.4 538.6 548.5 571.2 610.9 620.1 622.7 627.7 657.5 7717.9 7867.9 7899.2 7999.9 8057.1 560.9 612.7 667.3 672.4 729.2 3823.9 3868.3 3911.0 3936.3 4059.3 54293.7 54402.7 54619.7 54797.0 54841.7 50268.2 50356.7 50393.7 50524.7 50685.2 44788.8 45891.8 46094.8 46134.0 46593.1 7760.5 7763.5 7938.9 8109.4 8124.8 32718.7 32964.0 33640.8 33727.7 33805.8 41914.0 42262.0 42766.6 43044.0 43378.3 9864.3 9901.6 10077.8 10148.9 10484.8 11310.4 11403.7 11511.1 11526.9 11592.8 9897.0 10051.9 10398.8 10492.8 10749.2 9600.7 9980.4 9994.3 10088.8 10097.9 10207.5 10248.9 10589.5 10744.8 10775.3 8849.2 9161.6 9183.2 9268.4 9523.4 8711.9 8712.7 8884.7 9611.2 9729.1 09:36:17 INFO - PROCESS | 4349 | -------- Summary: end -------- 09:36:17 INFO - PROCESS | 4349 | 09:36:17 INFO - TEST-INFO | 4349: exit 0 09:36:17 INFO - TEST-OK | dromaeo_css | took 1112492ms 09:36:17 INFO - TEST-START | kraken 09:36:17 INFO - operating with platform_type : linux_ 09:36:17 INFO - Initialising browser for kraken test... 09:36:17 INFO - TEST-INFO | started process 4576 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8vZtlF/profile http://localhost:57354/getInfo.html) 09:36:21 INFO - PROCESS | 4576 | 09:36:21 INFO - PROCESS | 4576 | (process:4647): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:22 INFO - PROCESS | 4576 | __metrics Screen width/height:1600/1200 09:36:22 INFO - PROCESS | 4576 | colorDepth:24 09:36:22 INFO - PROCESS | 4576 | Browser inner width/height: 1024/697 09:36:22 INFO - PROCESS | 4576 | __metrics 09:36:23 ERROR - PROCESS | 4576 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 09:36:24 INFO - TEST-INFO | 4576: exit 0 09:36:24 INFO - Browser initialized. 09:36:24 INFO - Running cycle 1/1 for kraken test... 09:36:24 INFO - TEST-INFO | started process 4698 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8vZtlF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:25 INFO - PROCESS | 4698 | 09:36:25 INFO - PROCESS | 4698 | (process:4758): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:36:35 INFO - PROCESS | 4698 | RSS: Main: 155213824 09:36:35 INFO - PROCESS | 4698 | 09:36:38 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57354/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:39 INFO - PROCESS | 4698 | RSS: Main: 163028992 09:36:39 INFO - PROCESS | 4698 | 09:36:41 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57354/tests/kraken/driver.html?testName=audio-dft) 09:36:42 INFO - PROCESS | 4698 | RSS: Main: 165396480 09:36:42 INFO - PROCESS | 4698 | 09:36:45 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57354/tests/kraken/driver.html?testName=audio-fft) 09:36:45 INFO - PROCESS | 4698 | RSS: Main: 157720576 09:36:45 INFO - PROCESS | 4698 | 09:36:47 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57354/tests/kraken/driver.html?testName=audio-oscillator) 09:36:48 INFO - PROCESS | 4698 | RSS: Main: 156463104 09:36:48 INFO - PROCESS | 4698 | 09:36:50 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:51 INFO - PROCESS | 4698 | RSS: Main: 157106176 09:36:51 INFO - PROCESS | 4698 | 09:36:54 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57354/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:54 INFO - PROCESS | 4698 | RSS: Main: 157970432 09:36:54 INFO - PROCESS | 4698 | 09:36:58 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57354/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:58 INFO - PROCESS | 4698 | RSS: Main: 158384128 09:36:58 INFO - PROCESS | 4698 | 09:37:01 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57354/tests/kraken/driver.html?testName=json-parse-financial) 09:37:02 INFO - PROCESS | 4698 | RSS: Main: 161140736 09:37:02 INFO - PROCESS | 4698 | 09:37:04 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:04 INFO - PROCESS | 4698 | RSS: Main: 160526336 09:37:04 INFO - PROCESS | 4698 | 09:37:06 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:07 INFO - PROCESS | 4698 | RSS: Main: 160743424 09:37:07 INFO - PROCESS | 4698 | 09:37:09 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:09 INFO - PROCESS | 4698 | RSS: Main: 161103872 09:37:09 INFO - PROCESS | 4698 | 09:37:12 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:12 INFO - PROCESS | 4698 | RSS: Main: 160825344 09:37:12 INFO - PROCESS | 4698 | 09:37:15 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:16 INFO - PROCESS | 4698 | RSS: Main: 162295808 09:37:16 INFO - PROCESS | 4698 | 09:37:17 INFO - PROCESS | 4698 | Cycle 1(1): loaded http://localhost:57354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57354/tests/kraken/driver.html?testName=ai-astar) 09:37:18 INFO - PROCESS | 4698 | RSS: Main: 163643392 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | __start_tp_report 09:37:18 INFO - PROCESS | 4698 | _x_x_mozilla_page_load 09:37:18 INFO - PROCESS | 4698 | _x_x_mozilla_page_load_details 09:37:18 INFO - PROCESS | 4698 | |i|pagename|runs| 09:37:18 INFO - PROCESS | 4698 | |0;ai-astar;113;106;113;111;112;124;112;113;112;110 09:37:18 INFO - PROCESS | 4698 | |1;audio-beat-detection;164;135;155;175;127;160;159;130;174;134 09:37:18 INFO - PROCESS | 4698 | |2;audio-dft;164;165;164;166;162;161;161;166;167;162 09:37:18 INFO - PROCESS | 4698 | |3;audio-fft;76;78;76;158;79;74;75;73;161;75 09:37:18 INFO - PROCESS | 4698 | |4;audio-oscillator;97;97;139;96;98;96;148;97;98;143 09:37:18 INFO - PROCESS | 4698 | |5;imaging-gaussian-blur;122;117;117;117;117;115;115;115;116;117 09:37:18 INFO - PROCESS | 4698 | |6;imaging-darkroom;147;147;148;148;146;147;147;146;148;148 09:37:18 INFO - PROCESS | 4698 | |7;imaging-desaturate;97;96;96;97;96;97;96;96;98;97 09:37:18 INFO - PROCESS | 4698 | |8;json-parse-financial;60;59;59;58;59;59;71;64;57;59 09:37:18 INFO - PROCESS | 4698 | |9;json-stringify-tinderbox;66;68;67;67;68;69;68;67;67;67 09:37:18 INFO - PROCESS | 4698 | |10;stanford-crypto-aes;86;90;86;85;86;85;86;85;85;91 09:37:18 INFO - PROCESS | 4698 | |11;stanford-crypto-ccm;125;130;124;125;119;142;122;116;119;119 09:37:18 INFO - PROCESS | 4698 | |12;stanford-crypto-pbkdf2;145;157;164;150;158;141;153;163;145;145 09:37:18 INFO - PROCESS | 4698 | |13;stanford-crypto-sha256-iterative;70;69;78;76;71;68;68;71;67;68 09:37:18 INFO - PROCESS | 4698 | __end_tp_report 09:37:18 INFO - PROCESS | 4698 | __start_cc_report 09:37:18 INFO - PROCESS | 4698 | _x_x_mozilla_cycle_collect,759 09:37:18 INFO - PROCESS | 4698 | __end_cc_report 09:37:18 INFO - PROCESS | 4698 | __startTimestamp1455730638017__endTimestamp 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | ------- Summary: start ------- 09:37:18 INFO - PROCESS | 4698 | Number of tests: 14 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:4.53 (4.0%) stddev-sans-first:4.80 09:37:18 INFO - PROCESS | 4698 | Values: 113.0 106.0 113.0 111.0 112.0 124.0 112.0 113.0 112.0 110.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:159.50 stddev:18.25 (11.4%) stddev-sans-first:18.76 09:37:18 INFO - PROCESS | 4698 | Values: 164.0 135.0 155.0 175.0 127.0 160.0 159.0 130.0 174.0 134.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:2.20 (1.3%) stddev-sans-first:2.33 09:37:18 INFO - PROCESS | 4698 | Values: 164.0 165.0 164.0 166.0 162.0 161.0 161.0 166.0 167.0 162.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:35.36 (46.8%) stddev-sans-first:37.00 09:37:18 INFO - PROCESS | 4698 | Values: 76.0 78.0 76.0 158.0 79.0 74.0 75.0 73.0 161.0 75.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:97.00 stddev:22.49 (23.2%) stddev-sans-first:23.29 09:37:18 INFO - PROCESS | 4698 | Values: 97.0 97.0 139.0 96.0 98.0 96.0 148.0 97.0 98.0 143.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:2.04 (1.7%) stddev-sans-first:0.97 09:37:18 INFO - PROCESS | 4698 | Values: 122.0 117.0 117.0 117.0 117.0 115.0 115.0 115.0 116.0 117.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:37:18 INFO - PROCESS | 4698 | Values: 147.0 147.0 148.0 148.0 146.0 147.0 147.0 146.0 148.0 148.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:37:18 INFO - PROCESS | 4698 | Values: 97.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 98.0 97.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:4.12 (7.0%) stddev-sans-first:4.36 09:37:18 INFO - PROCESS | 4698 | Values: 60.0 59.0 59.0 58.0 59.0 59.0 71.0 64.0 57.0 59.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 09:37:18 INFO - PROCESS | 4698 | Values: 66.0 68.0 67.0 67.0 68.0 69.0 68.0 67.0 67.0 67.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.17 (2.5%) stddev-sans-first:2.30 09:37:18 INFO - PROCESS | 4698 | Values: 86.0 90.0 86.0 85.0 86.0 85.0 86.0 85.0 85.0 91.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:7.49 (6.0%) stddev-sans-first:7.94 09:37:18 INFO - PROCESS | 4698 | Values: 125.0 130.0 124.0 125.0 119.0 142.0 122.0 116.0 119.0 119.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:155.00 stddev:8.16 (5.3%) stddev-sans-first:8.24 09:37:18 INFO - PROCESS | 4698 | Values: 145.0 157.0 164.0 150.0 158.0 141.0 153.0 163.0 145.0 145.0 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - PROCESS | 4698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:3.66 (5.2%) stddev-sans-first:3.87 09:37:18 INFO - PROCESS | 4698 | Values: 70.0 69.0 78.0 76.0 71.0 68.0 68.0 71.0 67.0 68.0 09:37:18 INFO - PROCESS | 4698 | -------- Summary: end -------- 09:37:18 INFO - PROCESS | 4698 | 09:37:18 INFO - TEST-INFO | 4698: exit 0 09:37:19 INFO - TEST-OK | kraken | took 61208ms 09:37:19 INFO - SUITE-END | took 1173s 09:37:19 INFO - Completed test suite (00:19:33) 09:37:19 INFO - Working with test: dromaeo_css 09:37:19 INFO - Generating results file: dromaeo_css 09:37:19 INFO - Working with test: kraken 09:37:19 INFO - Generating results file: kraken 09:37:19 INFO - javascript benchmark 09:37:19 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 09:37:19 INFO - process_Request line: dromaeo_css 6905.25 graph.html#tests=[[72,1,43]] 09:37:19 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:37:19 INFO - process_Request line: kraken 1552.90 graph.html#tests=[[232,1,43]] 09:37:19 INFO - RETURN: dromaeo_css: 6905.25 09:37:19 INFO - RETURN: kraken: 1552.90 09:37:19 INFO - javascript benchmark 09:37:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.7597180211483, 3291.2594666200093, 3307.6526964668724, 3334.416477116504, 3346.41437748394, 5270.235815806705, 5370.462953704632, 5379.139337705968, 5386.973065134679, 5398.0, 5338.252644629755, 5393.352797664276, 5398.109311963522, 5433.972830135844, 5467.726613669311, 4896.290037944496, 4939.407271127469, 4975.676581022222, 5071.3407257056715, 5125.718085505315, 4796.448408433022, 5000.699958002513, 5021.422536408305, 5030.346055012843, 5082.034413461449, 4864.343313652647, 4918.163912134945, 4922.704637721748, 4947.0, 4953.727544985024, 4956.157453232959, 4964.081644895706, 4973.179425394806, 4994.076095922266, 5001.049800537886, 4792.760361981887, 4881.048195601859, 4962.255661650745, 4964.627652926045, 5010.223415370623, 5213.3743950725775, 5222.32109825724, 5223.059849227137, 5226.52961233487, 5258.447862974409, 5763.510101641324, 5778.191053252548, 5802.65184088956, 5804.303483581955, 5826.533877289807, 5617.859553511195, 5824.359320474744, 5846.0, 5870.0, 5953.940460595382, 5479.6164268501225, 5484.451554844523, 5487.039768040617, 5489.972550137224, 5494.340679118492, 5774.133879918046, 5976.7908123215475, 5980.401959803985, 5994.37059108796, 6002.159697642333, 5729.4843464088435, 5745.540356771448, 5746.770129194869, 5759.2512973313205, 5786.623869448473, 5849.327327357323, 5849.590528662953, 5852.502537284378, 5862.501687356537, 5867.266591676041, 5663.178839068312, 5775.971120144372, 5788.27646544182, 5848.912266316009, 5909.320428150818, 5768.7980920668415, 5814.854628634233, 5833.416658334133, 5838.5037271831525, 5839.591228613956, 4337.175936572041, 4442.844500442534, 4461.397711308931, 4465.218586747371, 4523.570260825217, 3972.0, 3980.2238563479846, 3990.580988996114, 4011.2579172853116, 4018.959810401917, 5434.402215756264, 5498.367687715964, 5498.890022199534, 5526.364468086222, 5541.5289700375115, 5594.104943209067, 5805.042168042311, 5918.378570250062, 5923.229980102559, 5925.4074592541265, 5437.075697131418, 5449.891002179934, 5455.8363249102595, 5460.781568737206, 5485.286912701324, 4975.751212439363, 4978.203487442064, 4985.975070124626, 5005.674631148963, 5014.6991180529285, 5938.910916336258, 6033.456988871023, 6092.855796792335, 6129.114290130661, 6131.877362452726, 5777.364489906023, 5791.53667706574, 5801.941980580309, 5806.854828629318, 5833.912491312719, 5856.209411729362, 6013.699315034319, 6029.758809647565, 6042.879142417215, 6046.0, 5768.94231057684, 5806.2451881255165, 5806.9419305806405, 5813.244278243801, 5836.066229403275, 5785.30576330843, 5798.768049277982, 5838.532917366516, 5847.766089356378, 5847.853803654943, 5550.75021624036, 5649.265595472562, 5649.915251271316, 5674.57440691958, 5716.942830571641, 5580.358258800127, 5639.097744360883, 5642.379338272704, 5647.322321321468, 5670.489655930986, 5520.309961254843, 5547.084731019337, 5552.944470555242, 5563.0, 5566.415526369673, 5520.1443776214755, 5568.248286481273, 5572.3034620672415, 5638.2670252866865, 5638.4925356718095, 5444.918326225031, 5507.807226747044, 5570.0, 5588.916166257591, 5627.184058311604], "unit": "score", "name": "dojo.html", "value": 5358.019030611525}, {"lowerIsBetter": false, "replicates": [526.252721135987, 526.4367127173923, 534.516262782182, 547.4416095582508, 550.6751016900029, 34928.301433971305, 35618.46572301411, 35651.82174089126, 35859.64140358599, 35983.64016359836, 36857.44713829295, 37315.62684373155, 37404.251914961686, 37476.0, 37476.06309842255, 8237.135100814403, 8358.373122015842, 8434.704785332484, 8454.28138608219, 8454.87317690232, 8213.137620549845, 8553.74338769838, 8578.699745508908, 8581.39930204886, 8630.136986301351, 8544.957275213616, 8630.266427353683, 8664.306855451548, 8716.346274029442, 8717.476951382905, 8516.914830851705, 8525.786855328604, 8592.8711069334, 8610.311175105977, 8637.65449382024, 8453.873191902127, 8589.355798315151, 8599.656013759442, 8605.225529702357, 8625.525596092213, 36661.0, 37061.81469092664, 37062.0, 37172.0, 37309.44035839465, 3333.2666813301034, 3404.710599599037, 3463.619001909788, 3498.8803582853498, 3571.8035508047046, 30262.394752104836, 31078.844605777052, 31310.530342044887, 31356.0, 32002.0, 3752.3245815753426, 3847.2882516734494, 3954.189391174831, 3982.38273067675, 4010.3984402339593, 214674.0, 215948.0, 216758.66482670416, 219944.0, 220562.0, 42182.57817421848, 42602.78698606549, 42777.78611106925, 62766.0, 62977.370226298066, 40933.59066409357, 40944.79527602402, 41095.7945210272, 41125.177496449905, 41189.176216475505, 14380.712385752226, 14594.927025364805, 14635.195064271567, 14684.118952862862, 14689.92655036718, 11799.705007374712, 11865.466054027589, 11878.88121118795, 11880.108991825648, 11931.284122952651, 14450.0, 14502.709945801236, 14603.342849571794, 14631.341589628491, 14659.92670036643, 5745.13822926556, 5795.623284486495, 5805.82582522525, 5812.82561523155, 5854.268216472941, 854.1287886355882, 893.41927746965, 895.2077411490748, 939.4832841936908, 939.6053657463882, 29548.556771648444, 29935.70064299329, 29996.037642397227, 30102.69897301043, 30931.381372372878, 1020.3062915560283, 1061.1139698351808, 1061.6708820265742, 1064.8189807732704, 1123.8145705958425, 15076.24618769057, 15156.469523566842, 15198.985602747633, 15530.689386212212, 15616.219189040503, 391181.0, 391759.0, 392175.0, 392470.0, 394371.0, 54074.72962635162, 54183.0, 54462.45537544653, 54600.72699636476, 54750.72624636851, 1322.6296636941672, 1358.1783021272186, 1360.4762166565943, 1362.3188405796902, 1364.9249291288875, 28106.0, 28793.0, 28825.279368015967, 29419.264518387212, 29727.0, 46425.76787116043, 47616.7619161902, 47841.28238076362, 47860.760696196296, 47891.28163077487, 297433.0, 298748.0, 298931.0, 298951.0, 299066.0, 28053.719462805926, 31597.0, 31747.20631984219, 32242.193945151557, 33000.0, 37199.628003720696, 37488.812555937046, 37523.06192345213, 38592.6140738589, 38706.6129338703, 34597.82701086579, 35155.824220878734, 35408.64591354054, 35534.644653553136, 35763.64236357603, 36014.639853601126, 36238.818805906856, 36295.63704363028, 38681.0, 40308.992275192184, 33479.66520334766, 38050.048748781504, 39060.609393905695, 39295.60704393034, 39526.0, 27698.89397122425, 33171.83414082914, 33900.83049584736, 33983.83008084944, 34086.0, 25668.229953101436, 26103.608445872946, 26117.869410652824, 26380.604290936037, 26516.867415662797], "unit": "score", "name": "ext.html", "value": 17732.918391951047}, {"lowerIsBetter": false, "replicates": [353.9805310707912, 355.7918617608699, 360.3441736040406, 361.6564263949247, 363.96542328478785, 16376.0, 16636.91681541592, 17174.74237886433, 17499.212535435905, 18032.18855151518, 15273.465428709997, 15281.235938203074, 15313.387464501406, 15673.608159796011, 15674.843251567481, 4871.756412179386, 5019.347484826967, 5112.693238405689, 5120.718360490171, 5127.820526281581, 5063.670861393997, 5157.6131790115705, 5178.300929374543, 5208.661437006602, 5390.056740070472, 5157.071727089123, 5360.437154098822, 5377.7580008899695, 5383.81156659517, 5418.810341638044, 5036.924446133311, 5210.5310522053005, 5242.501962313574, 5247.47525247476, 5255.842324730264, 5048.343715317022, 5051.520105589963, 5053.5957123430035, 5057.5448209660935, 5088.949110508885, 13040.80438793419, 13151.671208219776, 13173.802392964113, 13189.340532973312, 15690.058596484247, 2258.5934531784274, 2286.371247906839, 2296.712910886139, 2618.201448558189, 2687.4625074985083, 9192.586333615003, 9254.583543740548, 9535.380200287029, 9559.713208603753, 9733.124018838267, 1793.4709260767975, 1851.6666999940005, 1865.8600604954547, 1882.6234753049307, 1890.2816929566814, 61091.38908610901, 61857.0, 64424.355756442776, 64851.351486485, 65118.0, 10005.249606279413, 10262.281640285108, 10398.168146548258, 10443.530041148166, 10475.94762026185, 13597.932010340082, 13613.795793063113, 13621.863781362059, 13767.793483097761, 13789.586312410644, 7681.116671582728, 7696.6536505857375, 7734.961325193451, 7745.302922736981, 7793.2596403341595, 7474.775756727198, 7479.588622625808, 7572.734954276574, 7593.810154746176, 7596.962015189999, 4403.581659742319, 4436.711613745097, 4444.533324000933, 4454.1982443159895, 4498.482674492475, 1779.5817982774038, 1796.2725096336005, 1890.782560005617, 1901.2585091814203, 1907.6661584222707, 918.4856480371013, 945.5981207986579, 955.6559638530124, 993.3046867192994, 1061.7557961668706, 15406.768898466533, 15865.762013569805, 15893.205339732967, 16225.837741622432, 16707.164641767864, 843.2284459719289, 881.6517475597103, 903.5572569440926, 932.021377553566, 947.516766449116, 9136.908630913606, 9718.854217186748, 9819.852702209473, 9895.851562226573, 9965.302428829913, 526576.0, 541818.0, 551457.0, 556707.0, 560596.0, 50554.74722626437, 50672.74663626658, 51622.74188629033, 68589.3141068593, 76871.23128768752, 1158.7219067423757, 1177.381874515886, 1177.3877583656451, 1181.3620644851856, 1211.2792888231488, 14926.179060151795, 15269.847301527287, 15375.461858834888, 15469.690606188038, 15820.92089539545, 34634.48048279227, 35043.29913401769, 35404.64595354014, 35543.82228088843, 35652.64347356493, 43933.78033109814, 44824.32763508615, 45208.77395613001, 50519.24221136612, 50681.0, 7771.37828973692, 7884.645190966306, 7910.169432209766, 7922.0889597694695, 8003.719869804761, 10985.670429887115, 11143.72140696489, 12313.507459701512, 12395.566155184526, 12598.307093109966, 10696.465176740976, 10767.6231331903, 10931.0, 11012.889871101186, 11234.719132021764, 10715.785684286426, 11045.447727613748, 11110.222284440011, 11285.492152852978, 11365.54537818511, 6059.151718759289, 8704.434211776213, 10518.368897866152, 10814.35113893169, 11480.311181329147, 7140.857182856417, 7501.662425190989, 7571.129320128035, 7820.45256832039, 8005.8398832024195, 9625.56684949193, 10019.098281154731, 10214.948925255327, 10377.11794497446, 10464.476776161313], "unit": "score", "name": "jquery.html", "value": 8252.923541089196}, {"lowerIsBetter": false, "replicates": [1480.1193289992455, 1495.4616338118278, 1677.7735005774216, 1773.866959978002, 1813.4831573001698, 7616.086069671634, 7683.731069412572, 7783.610819459032, 7872.763817085496, 7874.055113386395, 7860.096088949773, 7887.60561971902, 7902.802429939255, 7936.642851071701, 7977.0826354969195, 2338.649202619608, 2360.527894421114, 2360.9645855312097, 2363.6690863279155, 2367.029517897662, 2349.530093981202, 2361.8464799787957, 2364.0780095762666, 2373.347329484397, 2381.1427885961125, 2224.955500889981, 2274.8066414354716, 2283.748787633359, 2307.215546714117, 2330.8951097200666, 2285.04028308111, 2295.7359903610964, 2308.3998160478227, 2322.4077860145553, 2325.744168141503, 2411.4333131714034, 2433.4889673168655, 2434.732179460258, 2437.390652336916, 2450.840695354814, 7795.961020194863, 8052.074011488695, 8066.677332906676, 8069.556174410405, 8071.878921816177, 4813.494583068762, 4912.238603016538, 4953.826616068456, 4961.404631444214, 4987.376577927759, 3078.5536097265995, 3166.62000559932, 3171.20719820045, 3182.427163110639, 3188.2666986593213, 935.088288918306, 941.8587211918199, 958.7171784323572, 974.488393593362, 974.8976357482433, 10915.454227288605, 11018.11855051602, 11026.614068507564, 11027.117830573536, 11041.0, 4214.262504061777, 4256.70203085781, 4289.335153051282, 4353.760543170093, 4359.411479450297, 8849.823003539894, 8858.86711699325, 8861.202491775643, 8861.379703420827, 8909.242714369222, 4828.903421931542, 4843.104025755247, 4852.514748525119, 4860.027994401064, 4896.510348965075, 4442.089371678798, 4448.5773851484055, 4466.062126953311, 4468.865934021985, 4479.193745125844, 3449.068751437098, 3479.8782042628386, 3486.4073107571776, 3488.7732297401094, 3536.6463353664426, 1033.2921948465325, 1037.4138611684375, 1044.6970378590124, 1049.4070849969742, 1073.5239046311322, 982.7002764157, 1033.1373303291834, 1033.2508931025097, 1125.392288164382, 1258.5028913579267, 7066.611336376446, 7185.173705023884, 7216.494845360774, 7230.2046774854725, 7239.565626062348, 625.0530446373748, 637.5473413876107, 641.1696852575925, 641.6695401868042, 777.362562698593, 5524.502794748492, 5541.944580554224, 5644.096944488862, 5710.65736055838, 5790.334111577138, 9397.154256116983, 9639.951800241095, 9658.71023869285, 9687.17658998979, 9716.61133554664, 9408.529573521297, 9578.616855325708, 9622.711318660311, 9629.0, 9643.324967252225, 7340.302671246223, 7467.1039475263315, 7502.587357695379, 7556.168821429638, 7566.2433756625, 7078.575285482888, 7121.359077682826, 7144.67848946809, 7153.105861767279, 7179.353858152791, 8397.118302578141, 8584.055753866945, 8584.141585841366, 8712.21590056898, 8714.91285087141, 8734.56327183651, 8748.956255218684, 8777.91222087771, 8824.161704638049, 8831.64673413082, 6585.769498067544, 6661.866762664623, 6694.129763130762, 6697.162854643169, 6712.798616041527, 7456.254374562717, 7597.810054748676, 7635.809104772425, 7642.923570764221, 7650.1584825668015, 6311.936880631135, 7148.821279467847, 7168.53404528704, 7170.784876453715, 7193.568385896863, 6727.529072964846, 6764.695588698619, 6828.9658551706925, 6865.931340686729, 6871.931280687129, 6736.292689267556, 6837.692303846438, 6848.623325717133, 6866.382025617719, 6908.1019467468905, 6369.49044076482, 6371.49028077762, 6406.583572067801, 6420.839479012875, 6421.357864213728, 6301.873962520815, 6310.5898116622275, 6370.904436433365, 6580.605163690194, 6598.439132673777], "unit": "score", "name": "mootools.html", "value": 4446.385985515661}, {"lowerIsBetter": false, "replicates": [327.06948730860705, 331.4001657000828, 337.14365511600533, 337.239524871415, 340.8057407277851, 6271.090691849679, 6352.872942541158, 6361.632249066444, 6372.203474565679, 6474.25546062203, 6249.218847644044, 6263.091851681504, 6310.936890631104, 6314.368563143684, 6330.177076979986, 4781.187198176301, 4811.3504676868615, 4815.133276010317, 4828.299896515021, 4835.492273311304, 4807.831725889595, 4837.879053023685, 4840.201366774478, 4845.903081938377, 4848.248521479177, 4689.671722979393, 4765.356676848615, 4785.521447855222, 4786.066716990188, 4788.832390866321, 4754.215554433515, 4766.880827979294, 4789.80840766369, 4791.401074865642, 4792.544708252711, 4116.320807066831, 4126.319157339066, 4137.1518838638, 4137.834486620532, 4139.399787030894, 5987.850303742398, 5991.131285963511, 6008.0, 6010.849728756816, 6018.247719035121, 5374.596905232123, 5540.556755459554, 5545.223668686387, 5566.2207290979295, 5583.218349431083, 6655.201375834882, 6668.366505182048, 6671.966640166816, 6681.131452911139, 6688.498362622823, 4552.066826300634, 4555.06621142665, 4555.385023021916, 4571.017231295287, 4575.428071491064, 6587.868242635169, 6886.24251332353, 6911.136107986502, 6924.549904256258, 6988.126484189476, 4568.954310456853, 4616.0998605272325, 4629.074185162914, 4630.791614377361, 4634.235351167087, 4653.813847446132, 4664.813407463731, 4680.602148817321, 4683.063387322549, 4688.367070445446, 5461.2627295315415, 5483.588730845203, 5491.313585801775, 5494.670319780826, 5495.587830912697, 6552.443042341454, 6662.966685166543, 6697.698603562754, 6706.094677218513, 6732.865342693217, 1600.6158521954646, 1618.8057433108102, 1651.859591934699, 1651.9587010324838, 1652.7520871869076, 1054.8154073037188, 1075.5697720911699, 1086.3590481615727, 1087.4888802262924, 1097.1277834121893, 6161.630302181794, 6185.443310102112, 6213.130161777355, 6227.626342419469, 6258.812235632939, 6789.626570538569, 6817.5568588041615, 6825.48808839339, 6850.21222559412, 6852.5203235774015, 6153.353897840751, 6199.225096862892, 6200.0, 6244.812655620339, 6248.750049997949, 3683.594804571495, 3693.316736403774, 3718.1819999600043, 3719.2933342664805, 3728.105254738897, 7106.111736032996, 7180.210176880539, 7197.9640101800205, 7199.2080871104135, 7203.099612548432, 6815.182178138655, 6957.65211739411, 6984.4412447004115, 6997.790066297917, 7000.0, 7071.080759501335, 7083.468739844532, 7103.502754807218, 7126.144862616416, 7131.393831524275, 6725.562838415487, 6788.796336109925, 6799.490038247251, 6801.89797153053, 6804.795856124324, 6575.0, 6689.26418094019, 6705.497087718538, 6729.394354507922, 6750.0, 7082.114735658043, 7108.857822843617, 7126.679299431435, 7128.928710712827, 7174.713011479691, 4585.977070114628, 4597.5747518269445, 4599.425071866017, 4602.447706275135, 4621.722696638212, 6477.805665829844, 6792.558483698544, 6837.384635382839, 6848.9657551711925, 6904.689288981907, 6683.465322774264, 6708.960111182774, 6727.663616819237, 6730.057791909038, 6747.291534388818, 6642.236142843635, 6673.032410300382, 6704.128463299739, 6708.932910671026, 6736.730530778714, 6501.804945851442, 6576.736930522726, 6606.570572912745, 6622.337766223339, 6630.171228596426, 6697.3637504437, 6745.527813053235, 6774.796756097325, 6781.186257649114, 6784.185897692309, 6537.8692426150255, 6546.0, 6570.441512471493, 6573.835654108686, 6593.505487088583], "unit": "score", "name": "prototype.html", "value": 4984.581864940532}, {"lowerIsBetter": false, "replicates": [706.3960313931589, 713.3045280851168, 728.5701436152669, 739.6375775869825, 756.0700338583543, 13186.0, 16088.195590220486, 16303.673926521462, 16320.020798752068, 16345.0, 14105.153690778561, 14169.574912752609, 14228.359723812428, 14243.074200176981, 14256.92871535641, 834.1491678487939, 834.3700506117902, 835.482001159282, 836.5315423362906, 859.5186695450536, 854.4189950833431, 857.1942374168293, 857.8370109679141, 857.9056303806576, 858.3347905373323, 889.2796834564024, 892.2193081054078, 893.1381217125472, 893.1916615463016, 894.2845723421269, 889.4796544021755, 891.7101941868918, 893.0221407558713, 893.7988952485704, 893.8078313162669, 650.6388954130456, 651.3584119642148, 654.228010947087, 656.0651072222112, 656.4059526128862, 13867.861321386757, 13909.652258693512, 13928.791068133985, 13936.303184840717, 13941.372638231303, 12524.74950500994, 12544.310062946533, 12786.61640150797, 12836.87163128366, 12896.0, 10559.947200264027, 10601.469926503643, 10616.256862019662, 10697.09074728649, 10863.945680271627, 3501.7023552998025, 3615.0600843780544, 3615.7288203384587, 3641.4887821554025, 3645.6354364563595, 49004.0, 50914.490855091346, 50975.74512127416, 51030.744846275906, 51369.743151284005, 9681.70954871355, 9743.220542356594, 9750.658726944523, 9818.852717209247, 9990.600375985025, 17913.19390627425, 18000.639987200444, 18056.90971545134, 18060.458186254433, 18167.818321816878, 7556.735514256975, 7685.769426917202, 7749.108852481924, 7785.493942893694, 7848.450608457353, 4403.867883963486, 4434.82260709568, 4480.507144214133, 4495.033567782943, 4581.381513495702, 3116.828574428428, 3120.3603261331373, 3127.8592463339205, 3142.120206342182, 3156.873725051018, 528.8624957510998, 536.3778017499682, 538.606817023575, 548.4734654731502, 571.1632458448393, 610.9266887973472, 620.1380081686459, 622.6762083716442, 627.6861569215392, 657.5097932265544, 7717.922820771832, 7867.921320786833, 7899.249571290718, 7999.920000799918, 8057.0734365548715, 560.907450270709, 612.6814056690586, 667.279338314619, 672.4116398151617, 729.234303980818, 3823.866164684223, 3868.323043467382, 3910.9804450977563, 3936.3111455495173, 4059.289624315733, 54293.72853135709, 54402.72798636061, 54619.72690136603, 54797.0, 54841.72579137079, 50268.24597631038, 50356.74821625868, 50393.74803125961, 50524.74737626289, 50685.23972140421, 44788.77605611951, 45891.77054114708, 46094.76952615283, 46134.0, 46593.06813863772, 7760.495567788075, 7763.456558040883, 7938.880916786137, 8109.3917956152345, 8124.7562573122905, 32718.67281327156, 32964.0, 33640.831795840866, 33727.66272337245, 33805.83097084499, 41914.0, 42262.0, 42766.57233427626, 43044.0, 43378.349324759525, 9864.260180486348, 9901.55443005081, 10077.848832267375, 10148.898511014795, 10484.842727359248, 11310.434478275889, 11403.714907127389, 11511.136664750009, 11526.88473115258, 11592.768144637228, 9897.0, 10051.949740251544, 10398.792024159626, 10492.79014419692, 10749.247552671552, 9600.66397676078, 9980.351277166961, 9994.300398972002, 10088.798224035625, 10097.89902100999, 10207.54066067014, 10248.897511024794, 10589.4705264738, 10744.83882741744, 10775.299605525615, 8849.20357167858, 9161.587728552364, 9183.219426348835, 9268.351215414856, 9523.380980236263, 8711.869321960303, 8712.69505567302, 8884.73345799627, 9611.231101512001, 9729.124378805942], "unit": "score", "name": "yui.html", "value": 6237.554329791193}], "name": "dromaeo_css", "value": 6905.2534744418945}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 106.0, 113.0, 111.0, 112.0, 124.0, 112.0, 113.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [164.0, 135.0, 155.0, 175.0, 127.0, 160.0, 159.0, 130.0, 174.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 164.0, 166.0, 162.0, 161.0, 161.0, 166.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 76.0, 158.0, 79.0, 74.0, 75.0, 73.0, 161.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 139.0, 96.0, 98.0, 96.0, 148.0, 97.0, 98.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.9}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 117.0, 117.0, 117.0, 115.0, 115.0, 115.0, 116.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 147.0, 146.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 58.0, 59.0, 59.0, 71.0, 64.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.5}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 86.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [125.0, 130.0, 124.0, 125.0, 119.0, 142.0, 122.0, 116.0, 119.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [145.0, 157.0, 164.0, 150.0, 158.0, 141.0, 153.0, 163.0, 145.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 78.0, 76.0, 71.0, 68.0, 68.0, 71.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1552.8999999999996}]} 09:37:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1552.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6905.25"}}} 09:37:19 INFO - Return code: 0 09:37:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:37:19 ERROR - # TBPL SUCCESS # 09:37:19 INFO - Running post-action listener: _resource_record_post_action 09:37:19 INFO - Running post-run listener: _resource_record_post_run 09:37:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 90112; Write bytes: 308244480; Read time: 800; Write time: 384904 09:37:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14036992; Read time: 0; Write time: 5244 09:37:20 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 90112; Write bytes: 294207488; Read time: 800; Write time: 379660 09:37:20 INFO - Running post-run listener: _upload_blobber_files 09:37:20 INFO - Blob upload gear active. 09:37:20 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 09:37:20 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 09:37:20 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'] 09:37:20 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 09:37:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:22 INFO - (blobuploader) - INFO - Done attempting. 09:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:23 INFO - (blobuploader) - INFO - Done attempting. 09:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:23 INFO - Return code: 0 09:37:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 09:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96222ed987ca6fd25804eaa3426cbe689b378ff3db2a2510909c15c9977f9d137f4f83281540ddb1c8e839f23ed04e7d6ac9f67c2cf652b1330009d1dccae708", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dce7d9580b97ced39dc54251b5cc44471b72330e61a3cefe6f346c62752b376a4af11723cc0573fdb8e4bd815ad5844b2ce03b64d4114d76807c9e295e29ce6"} 09:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 09:37:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 09:37:23 INFO - Contents: 09:37:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96222ed987ca6fd25804eaa3426cbe689b378ff3db2a2510909c15c9977f9d137f4f83281540ddb1c8e839f23ed04e7d6ac9f67c2cf652b1330009d1dccae708", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dce7d9580b97ced39dc54251b5cc44471b72330e61a3cefe6f346c62752b376a4af11723cc0573fdb8e4bd815ad5844b2ce03b64d4114d76807c9e295e29ce6"} 09:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:23 INFO - Copying logs to upload dir... 09:37:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 09:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.705782 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-02-17 09:37:23.868767) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 09:37:23.872877) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 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/96222ed987ca6fd25804eaa3426cbe689b378ff3db2a2510909c15c9977f9d137f4f83281540ddb1c8e839f23ed04e7d6ac9f67c2cf652b1330009d1dccae708", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dce7d9580b97ced39dc54251b5cc44471b72330e61a3cefe6f346c62752b376a4af11723cc0573fdb8e4bd815ad5844b2ce03b64d4114d76807c9e295e29ce6"} build_url:https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/EZ18rKgeTVC8yZLPllZpKg/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/96222ed987ca6fd25804eaa3426cbe689b378ff3db2a2510909c15c9977f9d137f4f83281540ddb1c8e839f23ed04e7d6ac9f67c2cf652b1330009d1dccae708", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dce7d9580b97ced39dc54251b5cc44471b72330e61a3cefe6f346c62752b376a4af11723cc0573fdb8e4bd815ad5844b2ce03b64d4114d76807c9e295e29ce6"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 09:37:23.935854) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:37:23.936637) ========= 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=af724c981e2a0f424dbabf99000001e7-1455729409.124156-974395423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:37:24.010413) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 09:37:24.011169) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 09:37:24.011761) ========= ========= Total master_lag: 0.28 =========