builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1456708638.27 results: success (0) buildid: 20160228143008 builduid: ca5c34ae670b48cb9d661da295ca6943 revision: 96ae037a678133ae412e669e67e45cb9a7141694 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.269871) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.270294) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.270616) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008967 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.297240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.297598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.311535) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.311871) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.363125) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.363749) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.364621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.365364) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-28 17:17:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.7M=0s 2016-02-28 17:17:18 (84.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.539329) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.539838) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.591354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:18.591705) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 96ae037a678133ae412e669e67e45cb9a7141694 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 96ae037a678133ae412e669e67e45cb9a7141694 --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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-28 17:17:18,856 truncating revision to first 12 chars 2016-02-28 17:17:18,856 Setting DEBUG logging. 2016-02-28 17:17:18,856 attempt 1/10 2016-02-28 17:17:18,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/96ae037a6781?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-28 17:17:19,125 unpacking tar archive at: fx-team-96ae037a6781/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557652 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:19.166533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:19.166884) ========= echo 96ae037a678133ae412e669e67e45cb9a7141694 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'96ae037a678133ae412e669e67e45cb9a7141694'] 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 96ae037a678133ae412e669e67e45cb9a7141694 program finished with exit code 0 elapsedTime=0.004654 script_repo_revision: '96ae037a678133ae412e669e67e45cb9a7141694' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:19.230226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:19.230532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 17:17:19.241066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-28 17:17:19.241367) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:19 INFO - MultiFileLogger online at 20160228 17:17:19 in /builds/slave/test-pgo 17:17:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:17:19 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:17:19 INFO - {'append_to_log': False, 17:17:19 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:17:19 INFO - 'blob_upload_branch': 'Fx-Team', 17:17:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:17:19 INFO - 'branch': 'Fx-Team', 17:17:19 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:19 INFO - 'config_files': ('talos/linux_config.py',), 17:17:19 INFO - 'default_actions': ('clobber', 17:17:19 INFO - 'read-buildbot-config', 17:17:19 INFO - 'download-and-extract', 17:17:19 INFO - 'populate-webroot', 17:17:19 INFO - 'create-virtualenv', 17:17:19 INFO - 'install', 17:17:19 INFO - 'run-tests'), 17:17:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:19 INFO - 'download_minidump_stackwalk': True, 17:17:19 INFO - 'download_symbols': 'ondemand', 17:17:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:19 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:19 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:19 INFO - 'installer_path': 'installer.exe', 17:17:19 INFO - 'log_level': 'info', 17:17:19 INFO - 'log_name': 'talos', 17:17:19 INFO - 'log_to_console': True, 17:17:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:19 INFO - 'opt_config_files': (), 17:17:19 INFO - 'pip_index': False, 17:17:19 INFO - 'sps_profile': False, 17:17:19 INFO - 'sps_profile_interval': 0, 17:17:19 INFO - 'suite': 'dromaeojs-e10s', 17:17:19 INFO - 'system_bits': '32', 17:17:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:19 INFO - 'title': 'talos-linux64-ix-062', 17:17:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:19 INFO - 'use_talos_json': True, 17:17:19 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:17:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:19 INFO - 'work_dir': 'build'} 17:17:19 INFO - ##### 17:17:19 INFO - ##### Running clobber step. 17:17:19 INFO - ##### 17:17:19 INFO - Running pre-action listener: _resource_record_pre_action 17:17:19 INFO - Running main action method: clobber 17:17:19 INFO - rmtree: /builds/slave/test-pgo/build 17:17:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:17:20 INFO - Running post-action listener: _resource_record_post_action 17:17:20 INFO - ##### 17:17:20 INFO - ##### Running read-buildbot-config step. 17:17:20 INFO - ##### 17:17:20 INFO - Running pre-action listener: _resource_record_pre_action 17:17:20 INFO - Running main action method: read_buildbot_config 17:17:20 INFO - Using buildbot properties: 17:17:20 INFO - { 17:17:20 INFO - "project": "", 17:17:20 INFO - "product": "firefox", 17:17:20 INFO - "script_repo_revision": "production", 17:17:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:17:20 INFO - "repository": "", 17:17:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:17:20 INFO - "buildid": "20160228143008", 17:17:20 INFO - "pgo_build": "True", 17:17:20 INFO - "basedir": "/builds/slave/test-pgo", 17:17:20 INFO - "buildnumber": 533, 17:17:20 INFO - "slavename": "talos-linux64-ix-062", 17:17:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:17:20 INFO - "platform": "ubuntu64_hw", 17:17:20 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:17:20 INFO - "branch": "fx-team", 17:17:20 INFO - "repo_path": "integration/fx-team", 17:17:20 INFO - "revision": "96ae037a678133ae412e669e67e45cb9a7141694", 17:17:20 INFO - "stage_platform": "linux64-pgo", 17:17:20 INFO - "builduid": "ca5c34ae670b48cb9d661da295ca6943", 17:17:20 INFO - "slavebuilddir": "test" 17:17:20 INFO - } 17:17:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:17:20 INFO - Running post-action listener: _resource_record_post_action 17:17:20 INFO - ##### 17:17:20 INFO - ##### Running download-and-extract step. 17:17:20 INFO - ##### 17:17:20 INFO - Running pre-action listener: _resource_record_pre_action 17:17:20 INFO - Running main action method: download_and_extract 17:17:20 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/test_packages.json 17:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/test_packages.json 17:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:17:25 INFO - Downloaded 1448 bytes. 17:17:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:17:25 INFO - Using the following test package requirements: 17:17:25 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:25 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:25 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:25 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'jsshell-linux-x86_64.zip'], 17:17:25 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:25 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:25 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:25 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:25 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:25 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:25 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:25 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:25 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:25 INFO - https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:17:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:17:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:27 INFO - Downloaded 23372048 bytes. 17:17:27 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'] 17:17:27 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 17:17:28 INFO - Return code: 0 17:17:28 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 17:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:28 INFO - https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:33 INFO - Downloaded 23372048 bytes. 17:17:33 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'] 17:17:33 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 17:17:34 INFO - Return code: 0 17:17:34 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')]} 17:17:34 INFO - https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:35 INFO - Downloaded 10713410 bytes. 17:17:35 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'] 17:17:35 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 17:17:36 INFO - Return code: 0 17:17:36 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')]} 17:17:36 INFO - https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GCm13yexQo-yOosP8k4bmw/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 17:17:37 INFO - Downloaded 56628370 bytes. 17:17:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:17:37 INFO - mkdir: /builds/slave/test-pgo/properties 17:17:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:17:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:17:37 INFO - Contents: 17:17:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:17:38 INFO - Running post-action listener: _resource_record_post_action 17:17:38 INFO - Running post-action listener: set_extra_try_arguments 17:17:38 INFO - ##### 17:17:38 INFO - ##### Running populate-webroot step. 17:17:38 INFO - ##### 17:17:38 INFO - Running pre-action listener: _resource_record_pre_action 17:17:38 INFO - Running main action method: populate_webroot 17:17:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:38 INFO - '--tppagecycles', 17:17:38 INFO - '7'], 17:17:38 INFO - 'tests': ['tsvgm']}}, 17:17:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:17:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:17:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'tests': ['damp', 'tps']}, 17:17:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['damp', 'tps']}, 17:17:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:17:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:38 INFO - 'other': {'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'other_l64': {'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'other_nol64': {'tests': ['a11yr', 17:17:38 INFO - 'ts_paint', 17:17:38 INFO - 'tpaint', 17:17:38 INFO - 'sessionrestore', 17:17:38 INFO - 'sessionrestore_no_auto_restore']}, 17:17:38 INFO - 'svgr': {'tests': ['tsvgx', 17:17:38 INFO - 'tsvgr_opacity', 17:17:38 INFO - 'tart', 17:17:38 INFO - 'tscrollx', 17:17:38 INFO - 'cart']}, 17:17:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['tsvgx', 17:17:38 INFO - 'tsvgr_opacity', 17:17:38 INFO - 'tart', 17:17:38 INFO - 'tscrollx', 17:17:38 INFO - 'cart']}, 17:17:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'tests': ['tp5o']}, 17:17:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'talos_options': ['--e10s'], 17:17:38 INFO - 'tests': ['tp5o']}, 17:17:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'talos_options': ['--xperf_path', 17:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:38 INFO - 'tests': ['tp5n']}, 17:17:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:38 INFO - 'talos_options': ['--e10s', 17:17:38 INFO - '--xperf_path', 17:17:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:38 INFO - 'tests': ['tp5n']}}, 17:17:38 INFO - 'talos.zip': {'path': '', 17:17:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:38 INFO - Running post-action listener: _resource_record_post_action 17:17:38 INFO - ##### 17:17:38 INFO - ##### Running create-virtualenv step. 17:17:38 INFO - ##### 17:17:38 INFO - Running pre-action listener: _resource_record_pre_action 17:17:38 INFO - Running main action method: create_virtualenv 17:17:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:17:38 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 17:17:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:17:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:38 INFO - Using real prefix '/usr' 17:17:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:17:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:40 INFO - Installing pip.................done. 17:17:40 INFO - Return code: 0 17:17:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:40 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:40 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 17:17:40 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 17:17:40 INFO - Using env: {'DISPLAY': ':0', 17:17:40 INFO - 'HOME': '/home/cltbld', 17:17:40 INFO - 'LANG': 'en_US.UTF-8', 17:17:40 INFO - 'LANGUAGE': 'en_US:en', 17:17:40 INFO - 'LOGNAME': 'cltbld', 17:17:40 INFO - 'MAIL': '/var/mail/cltbld', 17:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:40 INFO - 'MOZ_NO_REMOTE': '1', 17:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:40 INFO - 'NO_EM_RESTART': '1', 17:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:40 INFO - 'SHELL': '/bin/bash', 17:17:40 INFO - 'SHLVL': '1', 17:17:40 INFO - 'TERM': 'linux', 17:17:40 INFO - 'TMOUT': '86400', 17:17:40 INFO - 'USER': 'cltbld', 17:17:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:40 INFO - '_': '/tools/buildbot/bin/python'} 17:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:40 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 17:17:40 INFO - Cleaning up... 17:17:40 INFO - Return code: 0 17:17:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:40 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:40 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 17:17:40 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 17:17:40 INFO - Using env: {'DISPLAY': ':0', 17:17:40 INFO - 'HOME': '/home/cltbld', 17:17:40 INFO - 'LANG': 'en_US.UTF-8', 17:17:40 INFO - 'LANGUAGE': 'en_US:en', 17:17:40 INFO - 'LOGNAME': 'cltbld', 17:17:40 INFO - 'MAIL': '/var/mail/cltbld', 17:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:40 INFO - 'MOZ_NO_REMOTE': '1', 17:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:40 INFO - 'NO_EM_RESTART': '1', 17:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:40 INFO - 'SHELL': '/bin/bash', 17:17:40 INFO - 'SHLVL': '1', 17:17:40 INFO - 'TERM': 'linux', 17:17:40 INFO - 'TMOUT': '86400', 17:17:40 INFO - 'USER': 'cltbld', 17:17:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:40 INFO - '_': '/tools/buildbot/bin/python'} 17:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:41 INFO - Downloading/unpacking psutil>=0.7.1 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:43 INFO - Installing collected packages: psutil 17:17:43 INFO - Running setup.py install for psutil 17:17:43 INFO - building 'psutil._psutil_linux' extension 17:17:43 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 17:17:43 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 17:17:43 INFO - building 'psutil._psutil_posix' extension 17:17:43 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 17:17:43 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 17:17:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:43 INFO - Successfully installed psutil 17:17:43 INFO - Cleaning up... 17:17:43 INFO - Return code: 0 17:17:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17: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')]} 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17: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')]} 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:17:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:17:43 INFO - Using env: {'DISPLAY': ':0', 17:17:43 INFO - 'HOME': '/home/cltbld', 17:17:43 INFO - 'LANG': 'en_US.UTF-8', 17:17:43 INFO - 'LANGUAGE': 'en_US:en', 17:17:43 INFO - 'LOGNAME': 'cltbld', 17:17:43 INFO - 'MAIL': '/var/mail/cltbld', 17:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:43 INFO - 'MOZ_NO_REMOTE': '1', 17:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:43 INFO - 'NO_EM_RESTART': '1', 17:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:43 INFO - 'SHELL': '/bin/bash', 17:17:43 INFO - 'SHLVL': '1', 17:17:43 INFO - 'TERM': 'linux', 17:17:43 INFO - 'TMOUT': '86400', 17:17:43 INFO - 'USER': 'cltbld', 17:17:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:43 INFO - '_': '/tools/buildbot/bin/python'} 17:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:45 INFO - Installing collected packages: mozsystemmonitor 17:17:45 INFO - Running setup.py install for mozsystemmonitor 17:17:45 INFO - Successfully installed mozsystemmonitor 17:17:45 INFO - Cleaning up... 17:17:45 INFO - Return code: 0 17:17:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:17:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:46 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:17:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - Downloading docopt-0.6.1.tar.gz 17:17:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:48 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:48 INFO - Running setup.py install for blobuploader 17:17:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:17:48 INFO - Running setup.py install for requests 17:17:49 INFO - Running setup.py install for docopt 17:17:49 INFO - Successfully installed blobuploader requests docopt 17:17:49 INFO - Cleaning up... 17:17:49 INFO - Return code: 0 17:17:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:17:49 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')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:49 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 17:17:49 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 17:17:49 INFO - Using env: {'DISPLAY': ':0', 17:17:49 INFO - 'HOME': '/home/cltbld', 17:17:49 INFO - 'LANG': 'en_US.UTF-8', 17:17:49 INFO - 'LANGUAGE': 'en_US:en', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MAIL': '/var/mail/cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SHLVL': '1', 17:17:49 INFO - 'TERM': 'linux', 17:17:49 INFO - 'TMOUT': '86400', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - '_': '/tools/buildbot/bin/python'} 17:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:17:49 INFO - Running setup.py (path:/tmp/pip-QtgGJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:17:49 INFO - Running setup.py (path:/tmp/pip-jCLHDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:17:49 INFO - Running setup.py (path:/tmp/pip-tkMjOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:17:49 INFO - Running setup.py (path:/tmp/pip-nzbVFV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:17:49 INFO - Running setup.py (path:/tmp/pip-GYMQut-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:17:49 INFO - Running setup.py (path:/tmp/pip-JGE34v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:17:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:17:49 INFO - Running setup.py (path:/tmp/pip-juLwl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:17:50 INFO - Running setup.py (path:/tmp/pip-QW4MfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:17:50 INFO - Running setup.py (path:/tmp/pip-BTKvHI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:17:50 INFO - Running setup.py (path:/tmp/pip-PycGaN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:17:50 INFO - Running setup.py (path:/tmp/pip-czDwz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:17:50 INFO - Running setup.py (path:/tmp/pip-BN9M5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:17:50 INFO - Running setup.py (path:/tmp/pip-uBd6LN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:17:50 INFO - Running setup.py (path:/tmp/pip-Cc18ep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:17:50 INFO - Running setup.py (path:/tmp/pip-5CePos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:17:50 INFO - Running setup.py (path:/tmp/pip-y5czs4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:17:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:17:50 INFO - Running setup.py (path:/tmp/pip-vKMP5P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:50 INFO - Running setup.py install for manifestparser 17:17:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:17:50 INFO - Running setup.py install for mozcrash 17:17:50 INFO - Running setup.py install for mozdebug 17:17:51 INFO - Running setup.py install for mozdevice 17:17:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for mozfile 17:17:51 INFO - Running setup.py install for mozhttpd 17:17:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for mozinfo 17:17:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for mozInstall 17:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for mozleak 17:17:51 INFO - Running setup.py install for mozlog 17:17:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for moznetwork 17:17:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:17:51 INFO - Running setup.py install for mozprocess 17:17:52 INFO - Running setup.py install for mozprofile 17:17:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:17:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:17:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:17:52 INFO - Running setup.py install for mozrunner 17:17:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:17:52 INFO - Running setup.py install for mozscreenshot 17:17:52 INFO - Running setup.py install for moztest 17:17:52 INFO - Running setup.py install for mozversion 17:17:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:52 INFO - Cleaning up... 17:17:52 INFO - Return code: 0 17:17:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:17: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')]} 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:52 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:52 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 17:17:52 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 17:17:52 INFO - Using env: {'DISPLAY': ':0', 17:17:52 INFO - 'HOME': '/home/cltbld', 17:17:52 INFO - 'LANG': 'en_US.UTF-8', 17:17:52 INFO - 'LANGUAGE': 'en_US:en', 17:17:52 INFO - 'LOGNAME': 'cltbld', 17:17:52 INFO - 'MAIL': '/var/mail/cltbld', 17:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:52 INFO - 'MOZ_NO_REMOTE': '1', 17:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:52 INFO - 'NO_EM_RESTART': '1', 17:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:52 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:52 INFO - 'SHELL': '/bin/bash', 17:17:52 INFO - 'SHLVL': '1', 17:17:52 INFO - 'TERM': 'linux', 17:17:52 INFO - 'TMOUT': '86400', 17:17:52 INFO - 'USER': 'cltbld', 17:17:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:52 INFO - '_': '/tools/buildbot/bin/python'} 17:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:17:52 INFO - Running setup.py (path:/tmp/pip-zlXRDD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:17:52 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)) 17:17:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:17:52 INFO - Running setup.py (path:/tmp/pip-lE7zNx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:17:52 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)) 17:17:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:17:52 INFO - Running setup.py (path:/tmp/pip-0bSPeA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:17:53 INFO - Running setup.py (path:/tmp/pip-UDPzKx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:17:53 INFO - Running setup.py (path:/tmp/pip-81cgke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:17:53 INFO - Running setup.py (path:/tmp/pip-O08Pnm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:17:53 INFO - Running setup.py (path:/tmp/pip-xhooXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:17:53 INFO - Running setup.py (path:/tmp/pip-l1R4eL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:17:53 INFO - Running setup.py (path:/tmp/pip-_uE2qk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:17:53 INFO - Running setup.py (path:/tmp/pip-Eb1X6L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:17:53 INFO - Running setup.py (path:/tmp/pip-zgakyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:17:53 INFO - Running setup.py (path:/tmp/pip-KeWZLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:17:53 INFO - Running setup.py (path:/tmp/pip-clDQ1V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:17:53 INFO - Running setup.py (path:/tmp/pip-p0i0th-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:17:53 INFO - Running setup.py (path:/tmp/pip-PiDOat-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:17:53 INFO - Running setup.py (path:/tmp/pip-e3l7XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:17:53 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)) 17:17:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:17:53 INFO - Running setup.py (path:/tmp/pip-tdSpYO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:17:54 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)) 17:17:54 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)) 17:17:54 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)) 17:17:54 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)) 17:17:54 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)) 17:17:54 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)) 17:17:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:55 INFO - Downloading blessings-1.6.tar.gz 17:17:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:55 INFO - Installing collected packages: blessings 17:17:55 INFO - Running setup.py install for blessings 17:17:56 INFO - Successfully installed blessings 17:17:56 INFO - Cleaning up... 17:17:56 INFO - Return code: 0 17:17:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:17:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:17:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:17:56 INFO - Reading from file tmpfile_stdout 17:17:56 INFO - Current package versions: 17:17:56 INFO - argparse == 1.2.1 17:17:56 INFO - blessings == 1.6 17:17:56 INFO - blobuploader == 1.2.4 17:17:56 INFO - docopt == 0.6.1 17:17:56 INFO - manifestparser == 1.1 17:17:56 INFO - mozInstall == 1.12 17:17:56 INFO - mozcrash == 0.16 17:17:56 INFO - mozdebug == 0.1 17:17:56 INFO - mozdevice == 0.48 17:17:56 INFO - mozfile == 1.2 17:17:56 INFO - mozhttpd == 0.7 17:17:56 INFO - mozinfo == 0.9 17:17:56 INFO - mozleak == 0.1 17:17:56 INFO - mozlog == 3.1 17:17:56 INFO - moznetwork == 0.27 17:17:56 INFO - mozprocess == 0.22 17:17:56 INFO - mozprofile == 0.28 17:17:56 INFO - mozrunner == 6.11 17:17:56 INFO - mozscreenshot == 0.1 17:17:56 INFO - mozsystemmonitor == 0.0 17:17:56 INFO - moztest == 0.7 17:17:56 INFO - mozversion == 1.4 17:17:56 INFO - psutil == 3.1.1 17:17:56 INFO - requests == 1.2.3 17:17:56 INFO - wsgiref == 0.1.2 17:17:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:56 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 17:17:56 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 17:17:56 INFO - Using env: {'DISPLAY': ':0', 17:17:56 INFO - 'HOME': '/home/cltbld', 17:17:56 INFO - 'LANG': 'en_US.UTF-8', 17:17:56 INFO - 'LANGUAGE': 'en_US:en', 17:17:56 INFO - 'LOGNAME': 'cltbld', 17:17:56 INFO - 'MAIL': '/var/mail/cltbld', 17:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:56 INFO - 'MOZ_NO_REMOTE': '1', 17:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:56 INFO - 'NO_EM_RESTART': '1', 17:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:56 INFO - 'SHELL': '/bin/bash', 17:17:56 INFO - 'SHLVL': '1', 17:17:56 INFO - 'TERM': 'linux', 17:17:56 INFO - 'TMOUT': '86400', 17:17:56 INFO - 'USER': 'cltbld', 17:17:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:56 INFO - '_': '/tools/buildbot/bin/python'} 17:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 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)) 17:17:56 INFO - Cleaning up... 17:17:56 INFO - Return code: 0 17:17:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:17:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:17:56 INFO - Using env: {'DISPLAY': ':0', 17:17:56 INFO - 'HOME': '/home/cltbld', 17:17:56 INFO - 'LANG': 'en_US.UTF-8', 17:17:56 INFO - 'LANGUAGE': 'en_US:en', 17:17:56 INFO - 'LOGNAME': 'cltbld', 17:17:56 INFO - 'MAIL': '/var/mail/cltbld', 17:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:56 INFO - 'MOZ_NO_REMOTE': '1', 17:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:56 INFO - 'NO_EM_RESTART': '1', 17:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:56 INFO - 'SHELL': '/bin/bash', 17:17:56 INFO - 'SHLVL': '1', 17:17:56 INFO - 'TERM': 'linux', 17:17:56 INFO - 'TMOUT': '86400', 17:17:56 INFO - 'USER': 'cltbld', 17:17:56 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:56 INFO - '_': '/tools/buildbot/bin/python'} 17:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:56 INFO - Downloading/unpacking jsonschema 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:58 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:58 INFO - warning: no files found matching '*.txt' 17:17:58 INFO - no previously-included directories found matching 'build' 17:17:58 INFO - no previously-included directories found matching 'dist' 17:17:58 INFO - no previously-included directories found matching '.git*' 17:17:58 INFO - Installing collected packages: jsonschema, functools32 17:17:58 INFO - Running setup.py install for functools32 17:17:58 INFO - warning: no files found matching '*.txt' 17:17:58 INFO - no previously-included directories found matching 'build' 17:17:58 INFO - no previously-included directories found matching 'dist' 17:17:58 INFO - no previously-included directories found matching '.git*' 17:17:58 INFO - Successfully installed jsonschema functools32 17:17:58 INFO - Cleaning up... 17:17:59 INFO - Return code: 0 17:17:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:17: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')]} 17:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:59 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 0x7f3f4a25df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1115670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', '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 17:17:59 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 17:17:59 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 17:17:59 INFO - Using env: {'DISPLAY': ':0', 17:17:59 INFO - 'HOME': '/home/cltbld', 17:17:59 INFO - 'LANG': 'en_US.UTF-8', 17:17:59 INFO - 'LANGUAGE': 'en_US:en', 17:17:59 INFO - 'LOGNAME': 'cltbld', 17:17:59 INFO - 'MAIL': '/var/mail/cltbld', 17:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:59 INFO - 'MOZ_NO_REMOTE': '1', 17:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:59 INFO - 'NO_EM_RESTART': '1', 17:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:17:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:17:59 INFO - 'SHELL': '/bin/bash', 17:17:59 INFO - 'SHLVL': '1', 17:17:59 INFO - 'TERM': 'linux', 17:17:59 INFO - 'TMOUT': '86400', 17:17:59 INFO - 'USER': 'cltbld', 17:17:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:59 INFO - '_': '/tools/buildbot/bin/python'} 17:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:59 INFO - Downloading/unpacking flake8 17:17:59 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 17:17:59 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 17:17:59 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 17:17:59 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 17:17:59 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 17:17:59 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 17:18:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:18:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:18:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 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 17:18:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:01 INFO - no previously-included directories found matching 'docs/_build' 17:18:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:18:01 INFO - Running setup.py install for pep8 17:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:18:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:18:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:18:01 INFO - no previously-included directories found matching 'docs/_build' 17:18:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:18:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:18:01 INFO - Cleaning up... 17:18:02 INFO - Return code: 0 17:18:02 INFO - Running post-action listener: _resource_record_post_action 17:18:02 INFO - Running post-action listener: _start_resource_monitoring 17:18:02 INFO - Starting resource monitoring. 17:18:02 INFO - ##### 17:18:02 INFO - ##### Running install step. 17:18:02 INFO - ##### 17:18:02 INFO - Running pre-action listener: _resource_record_pre_action 17:18:02 INFO - Running main action method: install 17:18:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:18:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:18:02 INFO - Reading from file tmpfile_stdout 17:18:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:18:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:18:02 INFO - Reading from file tmpfile_stdout 17:18:02 INFO - Output received: 17:18:02 INFO - Usage: mozinstall [options] installer 17:18:02 INFO - Options: 17:18:02 INFO - -h, --help show this help message and exit 17:18:02 INFO - -d DEST, --destination=DEST 17:18:02 INFO - Directory to install application into. [default: 17:18:02 INFO - "/builds/slave/test-pgo"] 17:18:02 INFO - --app=APP Application being installed. [default: firefox] 17:18:02 INFO - mkdir: /builds/slave/test-pgo/build/application 17:18:02 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'] 17:18:02 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 17:18:18 INFO - Reading from file tmpfile_stdout 17:18:18 INFO - Output received: 17:18:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:18:18 INFO - Running post-action listener: _resource_record_post_action 17:18:18 INFO - ##### 17:18:18 INFO - ##### Running run-tests step. 17:18:18 INFO - ##### 17:18:18 INFO - Running pre-action listener: _resource_record_pre_action 17:18:18 INFO - Running main action method: run_tests 17:18:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:18:18 INFO - Python 2.7.3 17:18:18 INFO - Return code: 0 17:18:18 INFO - grabbing minidump binary from tooltool 17:18:18 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')]} 17:18:18 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 0x11a48c0>, '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 0x11a57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a5c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:18:18 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 17:18:18 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 17:18:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:18 INFO - Return code: 0 17:18:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:18:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:18:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:18:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:18:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:18:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:18:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:18:19 INFO - Return code: 0 17:18:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:18:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 17:18:19 INFO - Using env: {'DISPLAY': ':0', 17:18:19 INFO - 'HOME': '/home/cltbld', 17:18:19 INFO - 'LANG': 'en_US.UTF-8', 17:18:19 INFO - 'LANGUAGE': 'en_US:en', 17:18:19 INFO - 'LOGNAME': 'cltbld', 17:18:19 INFO - 'MAIL': '/var/mail/cltbld', 17:18:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:18:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:19 INFO - 'MOZ_NO_REMOTE': '1', 17:18:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:19 INFO - 'NO_EM_RESTART': '1', 17:18:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:18:19 INFO - 'PWD': '/builds/slave/test-pgo', 17:18:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:18:19 INFO - 'SHELL': '/bin/bash', 17:18:19 INFO - 'SHLVL': '1', 17:18:19 INFO - 'TERM': 'linux', 17:18:19 INFO - 'TMOUT': '86400', 17:18:19 INFO - 'USER': 'cltbld', 17:18:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698', 17:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:19 INFO - '_': '/tools/buildbot/bin/python'} 17:18:19 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 17:18:19 INFO - mozversion application_buildid: 20160228143008 17:18:19 INFO - mozversion application_changeset: 96ae037a678133ae412e669e67e45cb9a7141694 17:18:19 INFO - mozversion application_display_name: Nightly 17:18:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:19 INFO - mozversion application_name: Firefox 17:18:19 INFO - mozversion application_remotingname: firefox 17:18:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:19 INFO - mozversion application_vendor: Mozilla 17:18:19 INFO - mozversion application_version: 47.0a1 17:18:19 INFO - mozversion platform_buildid: 20160228143008 17:18:19 INFO - mozversion platform_changeset: 96ae037a678133ae412e669e67e45cb9a7141694 17:18:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:19 INFO - mozversion platform_version: 47.0a1 17:18:19 INFO - using testdate: 1456708699 17:18:19 INFO - actual date: 1456708699 17:18:19 INFO - starting webserver on 'localhost:44872' 17:18:19 INFO - SUITE-START | Running 2 tests 17:18:19 INFO - TEST-START | dromaeo_css 17:18:19 INFO - operating with platform_type : linux_ 17:18:19 INFO - Initialising browser for dromaeo_css test... 17:18:19 INFO - TEST-INFO | started process 5099 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU9McXP/profile http://localhost:44872/getInfo.html) 17:18:23 INFO - PROCESS | 5099 | 17:18:23 INFO - PROCESS | 5099 | (process:5179): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:24 INFO - PROCESS | 5099 | __metrics Screen width/height:1600/1200 17:18:24 INFO - PROCESS | 5099 | colorDepth:24 17:18:24 INFO - PROCESS | 5099 | Browser inner width/height: 1024/697 17:18:24 INFO - PROCESS | 5099 | __metrics 17:18:24 ERROR - PROCESS | 5099 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:24 INFO - PROCESS | 5099 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:18:25 INFO - TEST-INFO | 5099: exit 0 17:18:25 INFO - Browser initialized. 17:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:25 INFO - TEST-INFO | started process 5230 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU9McXP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:26 INFO - PROCESS | 5230 | 17:18:26 INFO - PROCESS | 5230 | (process:5292): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:37 INFO - PROCESS | 5230 | RSS: Main: 158072832 17:18:37 INFO - PROCESS | 5230 | 17:19:26 INFO - PROCESS | 5230 | 1456708766843 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] 17:21:35 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44872/tests/dromaeo/cssquery-ext.html) 17:21:36 INFO - PROCESS | 5230 | RSS: Main: 165433344 17:21:36 INFO - PROCESS | 5230 | 17:24:38 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-ext.html (next: http://localhost:44872/tests/dromaeo/cssquery-jquery.html) 17:24:39 INFO - PROCESS | 5230 | RSS: Main: 161652736 17:24:39 INFO - PROCESS | 5230 | 17:27:40 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44872/tests/dromaeo/cssquery-mootools.html) 17:27:41 INFO - PROCESS | 5230 | RSS: Main: 162906112 17:27:41 INFO - PROCESS | 5230 | 17:30:43 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44872/tests/dromaeo/cssquery-prototype.html) 17:30:43 INFO - PROCESS | 5230 | RSS: Main: 160739328 17:30:43 INFO - PROCESS | 5230 | 17:33:46 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44872/tests/dromaeo/cssquery-yui.html) 17:33:46 INFO - PROCESS | 5230 | RSS: Main: 161198080 17:33:46 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | Cycle 1(1): loaded http://localhost:44872/tests/dromaeo/cssquery-yui.html (next: http://localhost:44872/tests/dromaeo/cssquery-dojo.html) 17:36:49 INFO - PROCESS | 5230 | RSS: Main: 165847040 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | __start_tp_report 17:36:49 INFO - PROCESS | 5230 | _x_x_mozilla_page_load 17:36:49 INFO - PROCESS | 5230 | _x_x_mozilla_page_load_details 17:36:49 INFO - PROCESS | 5230 | |i|pagename|runs| 17:36:49 INFO - PROCESS | 5230 | |0;dojo.html;3169.841507924604;3174.254050298181;3199.58405407297;3211.662775408582;3217.678232176783;5134.922976155356;5147.51098645629;5186.7147306898105;5196.870078248041;5207.6875387476775;5202.453742357055;5204.583633309336;5254.106801843686;5273.736313184345;5299;4732.858014259569;4800.90398192036;4850.611951043926;4858.805647774103;4907.043126590316;4770.165221086313;4866.902661946759;4935.457099719028;4938.7530623468865;4970.676906001098;4746.288056791492;4760.357351757503;4808.831690890802;4828;4835.830745923893;4759.4764575896625;4760;4767.404074490689;4803.687760295569;4818.34952281441;4643.953560464386;4707.411573553306;4772.331873537708;4772.6911460817155;4800.519948005206;5097.158968770148;5111.872203194913;5132.923006154911;5140.228965655144;5175.068487672217;5478.424765399655;5555.611107222496;5558.722063896829;5559.499645031926;5582.911332290205;5514.310711161105;5641.971790141023;5643.802466913679;5664.320281566197;5666.235058267122;5269.789208431658;5287.947120528784;5313.203019547099;5326.5472434842695;5345.465453454663;5706.229658996065;5734.655920644691;5747.597668163272;5753.33836608787;5762.423757624204;5376.220448035013;5431.293931788842;5470.452954704578;5521.116621340566;5610.354809196913;5632.746526406239;5635.802746903921;5638.210650508932;5650.180723795027;5669.858253543612;5356.276902618175;5563.082091454865;5571.4428557143965;5585.469380408855;5714.114312281603;5487.176923461433;5555.333359996826;5570.916436253459;5596.076647353222;5623.353314368818;4189.2040512302565;4233.640140588084;4236.491621005437;4245.80893859777;4286.271333873186;3838.673712734393;3841.8655347063277;3847.826847791856;3859.208862183246;3859.9035024124623;5147.974260128675;5270.789168433296;5271.103912334912;5333.120035194227;5338.599605029638;5569.081101618188;5594.13290939905;5627.887442251132;5637.661740295595;5663.122216056518;5292.153255479105;5375.3012108425655;5375.462453754593;5380.91928621071;5433.185022246695;4624.791884365211;4718.292256161603;4747.95252047482;4751.596114330251;4826.710397376169;5798.362180160179;5806;5806.68063256525;5815.79644712433;5831.79588714393;5474.972625136849;5580.581456390706;5588.133839254922;5591.6365436246515;5624.803131890364;5865.5600829937075;5898.20374249488;5920.763169473173;5934.287885453773;5944.167816505779;5500.697461639648;5521.558275337883;5522.502974732293;5526.392096869261;5537.280153580009;5461.317335333083;5555.2222688822785;5601.859953501195;5618.803341883015;5635.605507614591;5327.627066105335;5389.137737961907;5449.291592093003;5478.369987451494;5523.972380138073;5393.51458368733;5398.271233383443;5433.701146436984;5438.184272359178;5440.727963601725;5270.552003079782;5313.574914006793;5320.0955837506945;5327.094393953114;5393.40672526014;5465.699386533779;5514.972425137848;5521.475459831309;5527.088030474926;5527.2538207343105;5346.411894691659;5360.731963401892;5394.056040193029;5412.83761487156;5466.863328416822 17:36:49 INFO - PROCESS | 5230 | |1;ext.html;495.9231319145529;556.7383329834976;588.3293045927643;592.9940700592994;599.4125756758376;28094.438111237763;35921.46117808235;35961.820190899045;36268.63731362686;36273.63726362732;39296.41055384164;39445.80277098618;39720;39948.600513994854;40043.19913601726;8385.119562445932;8551.059383467813;8587.141285871394;8617.827643447128;8629.69796057138;8324.916750832475;8532.445391049592;8533.359998000144;8533.487990720576;8604.26863716585;8449.197326253996;8748.650053997833;8757.605907734136;8769.298456123526;8822.514761688104;8696.086910874363;8704.129587041309;8710.651573937035;8725.214730674237;8749.912500874974;8640.611172497252;8692.434991725517;8728.650853965833;8830;8842.159994800484;39401.60598394008;39445.60554394448;39674.603253967376;40080.79959600212;40218.39672404916;3467.9826600867086;3554.751167418282;3596.226811235597;3674.430463278196;3945.9013524662114;29387.265318366997;29792.553111703342;29897.402051959056;30458.54312185319;30755.231119221975;3780.6030366811638;3796.335641262768;3804.5434547854156;3893.1629699614437;3932.4494570760116;264726;267891;268779;270092;270711;39765.60234397677;40977.79511102485;56118.15822762662;56413.435865640815;56426.43573564294;39341.40987885184;39375.2124957505;39474.21051578952;39537.60462395339;39761.60238397579;14439.566812995417;14600.809878518307;14626.268686565629;14659.853401465849;14675.92662036683;11720.88279117198;11824.763504729857;11864.406779660982;11874.525018999317;11877;13568.118072325267;14117.152970821784;14131.152130871975;14168.504102356368;14236.928815355857;5627.71861406928;5806.65160090396;5855.209546711139;5907.763689452374;5950.256217972754;932.529072818236;970.3644113105927;976.3556053004983;1017.811704834608;1023.8822535408375;27428.177154685392;28365.574516382272;28416.85791571029;28750.13749587516;28986.27534311617;970.5195928015678;1006.6778630838207;1040.5265604150093;1041.9218558608134;1100.0979197058496;13146.671333216746;14145.5049073284;14244.715105697827;14373.568792936228;14407.135571865721;281284;441378;448102;448261;448603;52937.735311323966;53394.19908701372;53766.73116634392;53981.1902821458;54025.72987135039;1369.383777300219;1372.524536123671;1381.3369582600208;1390.3326403326257;1401.0472878442554;28039.158825235274;29322.413551729274;29682.703172967995;30015.54976675308;30095.398092038475;43756.56243437525;44512.33231501465;44605.330920036875;44617.33074003957;44689.32966005448;272913;277333;278002;278195;278235;31223;31494.842525787226;41859;42705.14589708126;43159;39613;40302.1939561213;40686.389704153866;40863.7956810214;41037;35192;35527.64472355243;35690.64309356873;35723.46414803728;36342.63657363498;34993.47509787406;35527.46708799422;35733.82133089318;36013;36062.098447537974;36185.095372614844;36265.45601816028;37620.62379376281;38367.232655347296;38578.61421385862;28479.715202847707;32576.34847302993;33159;33309;33460.83269583636;24213.394665133514;24344.26967190987;24667.25998220056;24927.37681557903;24950 17:36:49 INFO - PROCESS | 5230 | |2;jquery.html;333.225251290749;341.172656308452;347.11831946855006;359.1882345898269;361.0090302120679;16572.751408728862;17174.313027478885;17197.22612482438;17563.999999999985;17742.733858992095;15884.52346429609;16184.190790460489;16307.347706091772;16416.917915410435;16500.17499125045;4736.455307639622;4910.41075070992;4936.777844996984;4945.480724523927;4970.030843985424;4974.42794078682;5385.111456609655;5415.783368665248;5442.945570544283;5445.646033007862;5270.868228294305;5328.440513746059;5341.626086173969;5392.865178370533;5397.919031214535;5053.79784808609;5247.212918062283;5257.263983042377;5270.104082305978;5368.812091576796;4969.577585905203;5038;5042.672226305279;5043.823466178666;5122.743862806882;12733.236005839586;13009.60971170857;13035.934820325838;13069.346532673328;13106.60680179596;2153;2257.3115199864037;2393.34183099649;2399.6280576510667;2601.9869900650374;9187.173154416068;9349.672761453385;9379.202767764747;9599.616015359377;9744.512774361254;1796.4341232511847;1800.7478952946599;1816.2190258188973;1828.3509354179207;1888.6033932874113;57862.42137578612;61767.69116154435;63276.36723632751;63296;65192.674036629985;9364.204042656314;9403.858942115874;9573.569189386495;9606.567704453317;9642.4214547126;11721.296722196696;12052.517899284107;12286.139970202;12428.875711242952;12451.501939922482;7178.856422871513;7456.925430745731;7498.925010749932;7499.437542184358;7567.3189412952;7533.397328213729;7605.505642133244;7615.390768738488;7752.302292793675;7770.650320735581;4071.2875246831686;4149.460570125864;4190.224808410454;4213.936790948138;4516.096780643885;1776.644671065792;1836.063607560154;1859.618778150476;1875.6248750250004;1901.610169915164;429.21239525470486;431.45851955795274;440.02534386334423;840.8318336332758;887.6286137916934;10494.842577361345;10953.726156846142;11133.10935125188;11220.438978051065;11239.887601124048;444.4488833846072;448.7128237927729;449.6627529352985;450.92108880945705;459.10016367918587;5763.423657634287;6002.909956350658;6061.575689701678;6097.817065488042;6124.755009799647;389197;391031;396861;405789;407825;73493.26506734971;73604;74223.62888185524;75089;76589.23410765933;481.8096851743542;483.09660934053545;483.63485568395635;485.8396729079466;486.7104073076514;14793.260336983323;15841.920790395974;15849.286782094603;15948.521544353687;16369;31273.8436307817;32849.34301314008;33163.668363317025;34982.65017349794;36110;36688.63311366852;38553.61446385612;41147.58852411438;43015.13969720525;43198.78400607977;8036.1160272368825;8067.636956337096;8168.428210025241;8261.917380826355;8276.379271554537;10603.41681207541;10912.825011963541;11806.055515558563;11846.466908988943;12492.188007779465;9861.211103111877;9957.601695932082;10275.177985761271;10493.160547156056;10798.298110622783;7520.924790752241;7550.924490755022;7561.4706970513735;7616.124145723313;7730.497517661334;5263.289455923401;7415.443841711785;8267.545285009382;8335;8620.61207245688;10554.841677374692;10680.412577308012;11058.170637202404;11103.222774405715;11106.50020749052;10825.729356766144;10997.175211858983;11448.370339631067;11593;11727.179097463095 17:36:49 INFO - PROCESS | 5230 | |3;mootools.html;1439.9352029158688;1448.760954442517;1604.5507257967765;1751.0806826416137;1789.0786245083775;6939.965300173499;7090.149182098143;7126.75056373027;7150.606716630577;7271.709131634741;7340.816479588013;7358.043454350927;7453.291937265964;7460.104787425503;7477.925220747791;2238.3173132194675;2239.764824693408;2259.378670865517;2261.1520679745095;2261.2424837679314;2261.321603518946;2270.126001489422;2295.8737269450176;2308.7575804540534;2320.454693147109;2191.7260342457193;2202.48241663209;2244.5286489837154;2260.2654137405407;2287.1308902616984;2256.2216035467736;2270.1146552844402;2276.544691061786;2278.043221846828;2290.3701482092474;2285.382946604424;2311.133325003124;2312.6993490846253;2314.618088015475;2323.604987152188;7383.409327253807;7385.66764495599;7437.85124297511;7438.367738742213;7443.962780186119;4403.229434848889;4473.507914129443;4498.707584007062;4506.864794056183;4518.570735780096;2852.429514097168;2873.2668307130198;2941.264683829043;2969.035063604316;2994.1766014346013;911.6717981526646;917.3807679816098;928.4150984879483;928.9628414863397;939.4316438554645;9847;9905.85141222875;9907;9952.850707239397;9975.600975960953;3907.902302442462;3919.3141200290406;3983.46223259862;4033.899152521152;4046.8988275292763;8017.7995550110545;8038.356931445471;8068;8068.273855353046;8071.152528984489;4462.085272519126;4475.015496590745;4523.208438523246;4539.9773001135445;4562.771861406916;4015.718899677053;4123.773192474383;4123.97938010308;4164.541900390955;4237.237297286456;3317.9170520736693;3349.447341188725;3350.413677606458;3361.798292102482;3398.150462384404;1052.0531521630442;1052.85786418834;1058.687687132298;1060.0565496707936;1064.2975636080305;1035.5598870480017;1049.5959055763585;1222.541546919905;1341.4231880291372;1355.1327150623608;6834.726610935606;6869.931300687029;6894.827629309308;6926.06498122747;6939.514234003672;482.3632804697765;483.8113135877011;486.9440014398319;490.80122550367156;492.3230557982774;5262.158054711228;5323.840284791385;5325.813596524103;5362.463753624606;5372.785088596491;8419.452735572168;8561.315094792526;8841.381103322705;8876.8668469973;8954.955225223832;8664.523451210118;8675.6529738811;8784.253338466175;8785.736427907173;8786.60460279289;6597.538172327987;6699.162604674416;6738.629375384303;6999.720011199495;7014.824629384306;6666.666666666744;6693.464522838259;6706.262311145868;6740.561863478858;6742.224644165984;7718.266764657348;7833.843323133391;7986.640601173078;7990.280874721303;8040.638171282189;7930.920690793018;8009.75970720856;8110.553919534483;8134.633941472766;8143.5928203590765;5625.831225063254;5848.356680765198;6193.38066193377;6308.400701933309;6323.525735569759;6811.114555107804;6900.171979362509;6915.89626155598;6920.342567456084;6920.5847649141215;6253.593516421418;6506.804795856132;6586.769463068769;6595.736170553124;6599.67001649906;6221.097940798469;6354.6504942226775;6390.201224846895;6458.580192287486;6524.869502610016;6617.735290588323;6633.9336606633315;6659.667016649051;6686.331366863469;6688.531802773759;5970.253718285215;6089.756409743561;6128.356522565245;6147.170132032118;6156.26124865019;6205.596636218631;6242.406971337716;6273.560850740404;6284.340144284784;6295.150154729236 17:36:49 INFO - PROCESS | 5230 | |4;prototype.html;319.8065170571804;326.29194647614673;326.44178454842216;330.3887807556021;331.1274790925911;6147.69261536923;6242.937570624293;6284.308726040132;6307.905381419277;6339.429451349371;6114.113453549233;6163.2912215095275;6176.320604733476;6180.783672571461;6181.381861813817;4444.20004399208;4548.727076375411;4566.589006989387;4584.174848527264;4738.478767335599;4579.107074120548;4609.53904609538;4613;4631.328457373679;4653.674242803005;4561.315802629599;4566.246569316058;4568.2462393705;4578.610818080467;4609.078184363124;4577.038821847416;4599.977000114995;4608.907821843578;4612.1698094343;4618.8152473901;3894.883153505399;3933.645971862546;3941.5861334559745;3943.861964831217;3945.506811648544;5844.26946631671;5857.297124345063;5864.7067646617925;5872.236609240814;5872.765089396419;5152.819651312224;5331.706756128411;5362.946370536284;5370.060239458079;5392.811251606175;6506.93493065068;6536.150300460909;6537.280899101095;6542.345765423467;6554.967225163891;4414.073044660625;4417.690761646686;4426.136903303857;4426.313921342197;4439.445069366329;6761.29006454325;6783.864322713567;6786.185657721056;6840.384365407088;6870.62211578368;4513.81944722214;4515.142122996685;4521.886952826206;4529.207388706963;4536.750478723636;4539.319102134707;4581.152486789888;4592.67851250416;4674.205385084544;4695.741734204652;5382.300300960928;5384.5692344612335;5406.567474602022;5417.593680473901;5432.424596866943;6521.021846722934;6537.607743535403;6557.737690492422;6569.277379488252;6593.900866592694;1648.6372997940434;1690.8309169082993;1696.5164927995463;1702.6850032743982;1705.292303693953;1103.089950790601;1118.8825173356843;1137.0676045642658;1159.2986243322837;1160.100921785606;6260;6278.560500764903;6281.497480201573;6281.842953926097;6289.308176100625;6724;6726.3609957054005;6727.29363416844;6736.494762892803;6782.491313151533;6129.172561704113;6260.436560709558;6266.091416744546;6315.684215789192;6397.552171347961;3682.779033258013;3686.391745362039;3704.0554658561896;3715.498407714978;3719.590845007047;7221.277872212841;7245.8550828983125;7255.129384473791;7260.491765576359;7282.235365286569;7009.369156775914;7012.5792452452;7020.543664661883;7020.613866237406;7033.156021277479;7063.434925205971;7243.674034668347;7245.456590755609;7245.637718114073;7250.673719682627;6777.322267773183;6782.694778735067;6789.762358317435;6811.65941702903;6842.623655698984;6735.696893639896;6760.425363844129;6769.559978601375;6780.966095169492;6801.353871382211;7010.579365238102;7065.22282548909;7084;7091.964540177266;7114.14630244374;4374.956250437455;4435.911281774411;4459.241928872035;4476.798544065459;4481;6792.592444453151;6793.694283757144;6794.76218332356;6795.524313298021;6805.625690586867;6511.283758786624;6516.315786842503;6549.345065493412;6562.34376562359;6573.014047892854;6506.772262970773;6558.344165583403;6565.573237739723;6568.770093046912;6584.078229047841;6326.778562750282;6418.582792118497;6429.646369449538;6449.580777249652;6452.225732911893;6670;6689.46484281266;6711.563748356341;6715.832104197434;6731.057651928636;6475.643839588868;6482.805515834532;6503.869922601616;6512.283648798533;6525.477961763143 17:36:49 INFO - PROCESS | 5230 | |5;yui.html;722.6422920654276;737.9889301660472;794.3089512124452;806.7378102116813;830.0869044051544;13706.657333566665;13822.930885345584;13884.305784710761;13893.930530347334;13902.235377054245;12977.221366718004;13033.674158146052;13149.145305555132;13255.933720331384;13261.403236854341;685.4379408884716;821.3880658909106;825.1789469477878;836.7489753074084;839.0728245288959;827.4084029918607;832.633641197874;834.4617721569614;835.7033253195119;836.7322456813822;879.3009557401849;879.5778026547262;880.2737741363369;880.2781718990431;884.9513276769775;871.2072014466868;873.9431936924079;877.9429337093069;878.2052242720316;878.3719640457072;643.7618081309898;646.2148489585177;647.4399644307687;650.3821369698805;652.7780554611455;13798.586042418743;13825.032247742662;13854.030217884752;13856;13864.722705545833;13070.346482675923;13185.602168312253;13193.274369909652;13195.472181112744;13294.601161965156;10269.793791969538;10515.63195288169;10582.470876456146;10600.310979786289;10975.231733778639;3714.23858109087;3718.7025037996896;3724.646158614927;3751.118487155516;3817.923641527154;46055.76972115151;46122.308165377544;46584.30123548149;46849.29726054112;49319.260211096866;10440.164786817037;10534.262601617813;10550.894491055145;10606.787864242671;10725.78548429027;17734.20196091179;17795.73306400405;17798.110094495223;17849.286028558712;17887.105644717973;7780.221977802287;7859.214078592209;7935.682572697027;7953.443258971816;8130.552819594979;4495.1234509271035;4520.050789334211;4536.546345365437;4547.522510136454;4797.112534181118;3054.801437906529;3079.1840162356993;3086.537019447101;3095.9845200773852;3104.611923509561;589.3428826858108;593.4777395891588;594.5867622002753;597.0745344715673;602.3614968133792;504.04735050754107;526.7971830845153;630.3948209718629;651.9641419721866;657.1239112334313;7954.960225198837;8253.257206851413;8278;8689.348298877609;9244.491552964651;543.8096666166809;668.3433007247769;669.9732010719516;680.1328306409268;702.1784512120729;3898.4152377143655;3904.590018048121;3921.843126274974;3934.901627459279;3980.900477488086;54664;55226.44773552213;55276.72361638166;55489.445105548424;55561.44438555644;47631.76184119126;48143.75928120337;48453.75773121112;48519.5148048515;48832.26751598729;43489.78255108704;44355;44896.73481019298;45551.99999999934;46365.768171158925;7834;7886.132525422314;7988.281054705104;8013.559254241072;8135.430519863553;31685.5247171288;32815.34369312648;33499.66500335063;33677.15807104744;33856.15359615931;39467.40798887962;40672.79663601663;40820.1835963285;41609.37585936153;42527.787361064235;10629.787404252027;10991.890081099407;11036.172287078341;11159;11319.320840749582;11889.048876090064;12010.33943133136;12430.12989090755;12505.957108816376;12669.429875655433;10912.836307455553;11132.777344452903;11314.698809636668;11492.425378731197;11846.881531184577;10471.528781204712;10551.366917984946;10629.521671524646;10644.137275976827;10704.143668506345;10562.683119506428;11475.311481311148;11492.94253528727;11806.462547731218;11911.3448760319;9716.22270218395;10052;10244;10259.127974122282;10273.280870339004;8795.340349473687;8885.764429021352;9206.520501561696;9620.518974051129;9841.065098815601 17:36:49 INFO - PROCESS | 5230 | __end_tp_report 17:36:49 INFO - PROCESS | 5230 | __start_cc_report 17:36:49 INFO - PROCESS | 5230 | _x_x_mozilla_cycle_collect,317 17:36:49 INFO - PROCESS | 5230 | __end_cc_report 17:36:49 INFO - PROCESS | 5230 | __startTimestamp1456709809734__endTimestamp 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | ------- Summary: start ------- 17:36:49 INFO - PROCESS | 5230 | Number of tests: 6 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#0] dojo.html Cycles:165 Average:5206.94 Median:5380.92 stddev:571.75 (10.6%) stddev-sans-first:550.72 17:36:49 INFO - PROCESS | 5230 | Values: 3169.8 3174.3 3199.6 3211.7 3217.7 5134.9 5147.5 5186.7 5196.9 5207.7 5202.5 5204.6 5254.1 5273.7 5299.0 4732.9 4800.9 4850.6 4858.8 4907.0 4770.2 4866.9 4935.5 4938.8 4970.7 4746.3 4760.4 4808.8 4828.0 4835.8 4759.5 4760.0 4767.4 4803.7 4818.3 4644.0 4707.4 4772.3 4772.7 4800.5 5097.2 5111.9 5132.9 5140.2 5175.1 5478.4 5555.6 5558.7 5559.5 5582.9 5514.3 5642.0 5643.8 5664.3 5666.2 5269.8 5287.9 5313.2 5326.5 5345.5 5706.2 5734.7 5747.6 5753.3 5762.4 5376.2 5431.3 5470.5 5521.1 5610.4 5632.7 5635.8 5638.2 5650.2 5669.9 5356.3 5563.1 5571.4 5585.5 5714.1 5487.2 5555.3 5570.9 5596.1 5623.4 4189.2 4233.6 4236.5 4245.8 4286.3 3838.7 3841.9 3847.8 3859.2 3859.9 5148.0 5270.8 5271.1 5333.1 5338.6 5569.1 5594.1 5627.9 5637.7 5663.1 5292.2 5375.3 5375.5 5380.9 5433.2 4624.8 4718.3 4748.0 4751.6 4826.7 5798.4 5806.0 5806.7 5815.8 5831.8 5475.0 5580.6 5588.1 5591.6 5624.8 5865.6 5898.2 5920.8 5934.3 5944.2 5500.7 5521.6 5522.5 5526.4 5537.3 5461.3 5555.2 5601.9 5618.8 5635.6 5327.6 5389.1 5449.3 5478.4 5524.0 5393.5 5398.3 5433.7 5438.2 5440.7 5270.6 5313.6 5320.1 5327.1 5393.4 5465.7 5515.0 5521.5 5527.1 5527.3 5346.4 5360.7 5394.1 5412.8 5466.9 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#1] ext.html Cycles:180 Average:47429.54 Median:20700.61 stddev:86677.23 (418.7%) stddev-sans-first:86848.75 17:36:49 INFO - PROCESS | 5230 | Values: 495.9 556.7 588.3 593.0 599.4 28094.4 35921.5 35961.8 36268.6 36273.6 39296.4 39445.8 39720.0 39948.6 40043.2 8385.1 8551.1 8587.1 8617.8 8629.7 8324.9 8532.4 8533.4 8533.5 8604.3 8449.2 8748.7 8757.6 8769.3 8822.5 8696.1 8704.1 8710.7 8725.2 8749.9 8640.6 8692.4 8728.7 8830.0 8842.2 39401.6 39445.6 39674.6 40080.8 40218.4 3468.0 3554.8 3596.2 3674.4 3945.9 29387.3 29792.6 29897.4 30458.5 30755.2 3780.6 3796.3 3804.5 3893.2 3932.4 264726.0 267891.0 268779.0 270092.0 270711.0 39765.6 40977.8 56118.2 56413.4 56426.4 39341.4 39375.2 39474.2 39537.6 39761.6 14439.6 14600.8 14626.3 14659.9 14675.9 11720.9 11824.8 11864.4 11874.5 11877.0 13568.1 14117.2 14131.2 14168.5 14236.9 5627.7 5806.7 5855.2 5907.8 5950.3 932.5 970.4 976.4 1017.8 1023.9 27428.2 28365.6 28416.9 28750.1 28986.3 970.5 1006.7 1040.5 1041.9 1100.1 13146.7 14145.5 14244.7 14373.6 14407.1 281284.0 441378.0 448102.0 448261.0 448603.0 52937.7 53394.2 53766.7 53981.2 54025.7 1369.4 1372.5 1381.3 1390.3 1401.0 28039.2 29322.4 29682.7 30015.5 30095.4 43756.6 44512.3 44605.3 44617.3 44689.3 272913.0 277333.0 278002.0 278195.0 278235.0 31223.0 31494.8 41859.0 42705.1 43159.0 39613.0 40302.2 40686.4 40863.8 41037.0 35192.0 35527.6 35690.6 35723.5 36342.6 34993.5 35527.5 35733.8 36013.0 36062.1 36185.1 36265.5 37620.6 38367.2 38578.6 28479.7 32576.3 33159.0 33309.0 33460.8 24213.4 24344.3 24667.3 24927.4 24950.0 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#2] jquery.html Cycles:180 Average:23336.98 Median:446.58 stddev:65505.68 (14668.3%) stddev-sans-first:65666.67 17:36:49 INFO - PROCESS | 5230 | Values: 333.2 341.2 347.1 359.2 361.0 16572.8 17174.3 17197.2 17564.0 17742.7 15884.5 16184.2 16307.3 16416.9 16500.2 4736.5 4910.4 4936.8 4945.5 4970.0 4974.4 5385.1 5415.8 5442.9 5445.6 5270.9 5328.4 5341.6 5392.9 5397.9 5053.8 5247.2 5257.3 5270.1 5368.8 4969.6 5038.0 5042.7 5043.8 5122.7 12733.2 13009.6 13035.9 13069.3 13106.6 2153.0 2257.3 2393.3 2399.6 2602.0 9187.2 9349.7 9379.2 9599.6 9744.5 1796.4 1800.7 1816.2 1828.4 1888.6 57862.4 61767.7 63276.4 63296.0 65192.7 9364.2 9403.9 9573.6 9606.6 9642.4 11721.3 12052.5 12286.1 12428.9 12451.5 7178.9 7456.9 7498.9 7499.4 7567.3 7533.4 7605.5 7615.4 7752.3 7770.7 4071.3 4149.5 4190.2 4213.9 4516.1 1776.6 1836.1 1859.6 1875.6 1901.6 429.2 431.5 440.0 840.8 887.6 10494.8 10953.7 11133.1 11220.4 11239.9 444.4 448.7 449.7 450.9 459.1 5763.4 6002.9 6061.6 6097.8 6124.8 389197.0 391031.0 396861.0 405789.0 407825.0 73493.3 73604.0 74223.6 75089.0 76589.2 481.8 483.1 483.6 485.8 486.7 14793.3 15841.9 15849.3 15948.5 16369.0 31273.8 32849.3 33163.7 34982.7 36110.0 36688.6 38553.6 41147.6 43015.1 43198.8 8036.1 8067.6 8168.4 8261.9 8276.4 10603.4 10912.8 11806.1 11846.5 12492.2 9861.2 9957.6 10275.2 10493.2 10798.3 7520.9 7550.9 7561.5 7616.1 7730.5 5263.3 7415.4 8267.5 8335.0 8620.6 10554.8 10680.4 11058.2 11103.2 11106.5 10825.7 10997.2 11448.4 11593.0 11727.2 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#3] mootools.html Cycles:180 Average:5111.38 Median:6248.00 stddev:2613.95 (41.8%) stddev-sans-first:2606.72 17:36:49 INFO - PROCESS | 5230 | Values: 1439.9 1448.8 1604.6 1751.1 1789.1 6940.0 7090.1 7126.8 7150.6 7271.7 7340.8 7358.0 7453.3 7460.1 7477.9 2238.3 2239.8 2259.4 2261.2 2261.2 2261.3 2270.1 2295.9 2308.8 2320.5 2191.7 2202.5 2244.5 2260.3 2287.1 2256.2 2270.1 2276.5 2278.0 2290.4 2285.4 2311.1 2312.7 2314.6 2323.6 7383.4 7385.7 7437.9 7438.4 7444.0 4403.2 4473.5 4498.7 4506.9 4518.6 2852.4 2873.3 2941.3 2969.0 2994.2 911.7 917.4 928.4 929.0 939.4 9847.0 9905.9 9907.0 9952.9 9975.6 3907.9 3919.3 3983.5 4033.9 4046.9 8017.8 8038.4 8068.0 8068.3 8071.2 4462.1 4475.0 4523.2 4540.0 4562.8 4015.7 4123.8 4124.0 4164.5 4237.2 3317.9 3349.4 3350.4 3361.8 3398.2 1052.1 1052.9 1058.7 1060.1 1064.3 1035.6 1049.6 1222.5 1341.4 1355.1 6834.7 6869.9 6894.8 6926.1 6939.5 482.4 483.8 486.9 490.8 492.3 5262.2 5323.8 5325.8 5362.5 5372.8 8419.5 8561.3 8841.4 8876.9 8955.0 8664.5 8675.7 8784.3 8785.7 8786.6 6597.5 6699.2 6738.6 6999.7 7014.8 6666.7 6693.5 6706.3 6740.6 6742.2 7718.3 7833.8 7986.6 7990.3 8040.6 7930.9 8009.8 8110.6 8134.6 8143.6 5625.8 5848.4 6193.4 6308.4 6323.5 6811.1 6900.2 6915.9 6920.3 6920.6 6253.6 6506.8 6586.8 6595.7 6599.7 6221.1 6354.7 6390.2 6458.6 6524.9 6617.7 6633.9 6659.7 6686.3 6688.5 5970.3 6089.8 6128.4 6147.2 6156.3 6205.6 6242.4 6273.6 6284.3 6295.2 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#4] prototype.html Cycles:180 Average:5472.70 Median:6272.33 stddev:1691.53 (27.0%) stddev-sans-first:1651.47 17:36:49 INFO - PROCESS | 5230 | Values: 319.8 326.3 326.4 330.4 331.1 6147.7 6242.9 6284.3 6307.9 6339.4 6114.1 6163.3 6176.3 6180.8 6181.4 4444.2 4548.7 4566.6 4584.2 4738.5 4579.1 4609.5 4613.0 4631.3 4653.7 4561.3 4566.2 4568.2 4578.6 4609.1 4577.0 4600.0 4608.9 4612.2 4618.8 3894.9 3933.6 3941.6 3943.9 3945.5 5844.3 5857.3 5864.7 5872.2 5872.8 5152.8 5331.7 5362.9 5370.1 5392.8 6506.9 6536.2 6537.3 6542.3 6555.0 4414.1 4417.7 4426.1 4426.3 4439.4 6761.3 6783.9 6786.2 6840.4 6870.6 4513.8 4515.1 4521.9 4529.2 4536.8 4539.3 4581.2 4592.7 4674.2 4695.7 5382.3 5384.6 5406.6 5417.6 5432.4 6521.0 6537.6 6557.7 6569.3 6593.9 1648.6 1690.8 1696.5 1702.7 1705.3 1103.1 1118.9 1137.1 1159.3 1160.1 6260.0 6278.6 6281.5 6281.8 6289.3 6724.0 6726.4 6727.3 6736.5 6782.5 6129.2 6260.4 6266.1 6315.7 6397.6 3682.8 3686.4 3704.1 3715.5 3719.6 7221.3 7245.9 7255.1 7260.5 7282.2 7009.4 7012.6 7020.5 7020.6 7033.2 7063.4 7243.7 7245.5 7245.6 7250.7 6777.3 6782.7 6789.8 6811.7 6842.6 6735.7 6760.4 6769.6 6781.0 6801.4 7010.6 7065.2 7084.0 7092.0 7114.1 4375.0 4435.9 4459.2 4476.8 4481.0 6792.6 6793.7 6794.8 6795.5 6805.6 6511.3 6516.3 6549.3 6562.3 6573.0 6506.8 6558.3 6565.6 6568.8 6584.1 6326.8 6418.6 6429.6 6449.6 6452.2 6670.0 6689.5 6711.6 6715.8 6731.1 6475.6 6482.8 6503.9 6512.3 6525.5 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | [#5] yui.html Cycles:180 Average:13474.00 Median:44625.87 stddev:15160.64 (34.0%) stddev-sans-first:15172.92 17:36:49 INFO - PROCESS | 5230 | Values: 722.6 738.0 794.3 806.7 830.1 13706.7 13822.9 13884.3 13893.9 13902.2 12977.2 13033.7 13149.1 13255.9 13261.4 685.4 821.4 825.2 836.7 839.1 827.4 832.6 834.5 835.7 836.7 879.3 879.6 880.3 880.3 885.0 871.2 873.9 877.9 878.2 878.4 643.8 646.2 647.4 650.4 652.8 13798.6 13825.0 13854.0 13856.0 13864.7 13070.3 13185.6 13193.3 13195.5 13294.6 10269.8 10515.6 10582.5 10600.3 10975.2 3714.2 3718.7 3724.6 3751.1 3817.9 46055.8 46122.3 46584.3 46849.3 49319.3 10440.2 10534.3 10550.9 10606.8 10725.8 17734.2 17795.7 17798.1 17849.3 17887.1 7780.2 7859.2 7935.7 7953.4 8130.6 4495.1 4520.1 4536.5 4547.5 4797.1 3054.8 3079.2 3086.5 3096.0 3104.6 589.3 593.5 594.6 597.1 602.4 504.0 526.8 630.4 652.0 657.1 7955.0 8253.3 8278.0 8689.3 9244.5 543.8 668.3 670.0 680.1 702.2 3898.4 3904.6 3921.8 3934.9 3980.9 54664.0 55226.4 55276.7 55489.4 55561.4 47631.8 48143.8 48453.8 48519.5 48832.3 43489.8 44355.0 44896.7 45552.0 46365.8 7834.0 7886.1 7988.3 8013.6 8135.4 31685.5 32815.3 33499.7 33677.2 33856.2 39467.4 40672.8 40820.2 41609.4 42527.8 10629.8 10991.9 11036.2 11159.0 11319.3 11889.0 12010.3 12430.1 12506.0 12669.4 10912.8 11132.8 11314.7 11492.4 11846.9 10471.5 10551.4 10629.5 10644.1 10704.1 10562.7 11475.3 11492.9 11806.5 11911.3 9716.2 10052.0 10244.0 10259.1 10273.3 8795.3 8885.8 9206.5 9620.5 9841.1 17:36:49 INFO - PROCESS | 5230 | -------- Summary: end -------- 17:36:49 INFO - PROCESS | 5230 | 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:49 INFO - PROCESS | 5230 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:50 INFO - TEST-INFO | 5230: exit 0 17:36:50 INFO - TEST-OK | dromaeo_css | took 1110493ms 17:36:50 INFO - TEST-START | kraken 17:36:50 INFO - operating with platform_type : linux_ 17:36:50 INFO - Initialising browser for kraken test... 17:36:50 INFO - TEST-INFO | started process 5471 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCTAhx/profile http://localhost:44872/getInfo.html) 17:36:53 INFO - PROCESS | 5471 | 17:36:53 INFO - PROCESS | 5471 | (process:5545): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:36:54 INFO - PROCESS | 5471 | __metrics Screen width/height:1600/1200 17:36:54 INFO - PROCESS | 5471 | colorDepth:24 17:36:54 INFO - PROCESS | 5471 | Browser inner width/height: 1024/697 17:36:54 INFO - PROCESS | 5471 | __metrics 17:36:54 ERROR - PROCESS | 5471 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:54 INFO - PROCESS | 5471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:36:55 INFO - TEST-INFO | 5471: exit 0 17:36:55 INFO - Browser initialized. 17:36:55 INFO - Running cycle 1/1 for kraken test... 17:36:55 INFO - TEST-INFO | started process 5596 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFCTAhx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:57 INFO - PROCESS | 5596 | 17:36:57 INFO - PROCESS | 5596 | (process:5655): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:37:07 INFO - PROCESS | 5596 | RSS: Main: 157831168 17:37:07 INFO - PROCESS | 5596 | 17:37:10 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44872/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:10 INFO - PROCESS | 5596 | RSS: Main: 164847616 17:37:10 INFO - PROCESS | 5596 | 17:37:13 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44872/tests/kraken/driver.html?testName=audio-dft) 17:37:13 INFO - PROCESS | 5596 | RSS: Main: 166993920 17:37:13 INFO - PROCESS | 5596 | 17:37:16 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44872/tests/kraken/driver.html?testName=audio-fft) 17:37:17 INFO - PROCESS | 5596 | RSS: Main: 161337344 17:37:17 INFO - PROCESS | 5596 | 17:37:19 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44872/tests/kraken/driver.html?testName=audio-oscillator) 17:37:20 INFO - PROCESS | 5596 | RSS: Main: 161009664 17:37:20 INFO - PROCESS | 5596 | 17:37:22 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:22 INFO - PROCESS | 5596 | RSS: Main: 160976896 17:37:22 INFO - PROCESS | 5596 | 17:37:25 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44872/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:26 INFO - PROCESS | 5596 | RSS: Main: 162832384 17:37:26 INFO - PROCESS | 5596 | 17:37:29 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44872/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:30 INFO - PROCESS | 5596 | RSS: Main: 162496512 17:37:30 INFO - PROCESS | 5596 | 17:37:33 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44872/tests/kraken/driver.html?testName=json-parse-financial) 17:37:33 INFO - PROCESS | 5596 | RSS: Main: 161918976 17:37:33 INFO - PROCESS | 5596 | 17:37:35 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:36 INFO - PROCESS | 5596 | RSS: Main: 163753984 17:37:36 INFO - PROCESS | 5596 | 17:37:37 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:38 INFO - PROCESS | 5596 | RSS: Main: 161554432 17:37:38 INFO - PROCESS | 5596 | 17:37:40 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:41 INFO - PROCESS | 5596 | RSS: Main: 162021376 17:37:41 INFO - PROCESS | 5596 | 17:37:43 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:44 INFO - PROCESS | 5596 | RSS: Main: 163860480 17:37:44 INFO - PROCESS | 5596 | 17:37:46 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:47 INFO - PROCESS | 5596 | RSS: Main: 162902016 17:37:47 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | Cycle 1(1): loaded http://localhost:44872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44872/tests/kraken/driver.html?testName=ai-astar) 17:37:49 INFO - PROCESS | 5596 | RSS: Main: 163299328 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | __start_tp_report 17:37:49 INFO - PROCESS | 5596 | _x_x_mozilla_page_load 17:37:49 INFO - PROCESS | 5596 | _x_x_mozilla_page_load_details 17:37:49 INFO - PROCESS | 5596 | |i|pagename|runs| 17:37:49 INFO - PROCESS | 5596 | |0;ai-astar;113;108;114;112;113;123;112;110;113;113 17:37:49 INFO - PROCESS | 5596 | |1;audio-beat-detection;164;127;154;171;127;153;155;142;169;139 17:37:49 INFO - PROCESS | 5596 | |2;audio-dft;164;165;166;165;165;162;166;173;166;164 17:37:49 INFO - PROCESS | 5596 | |3;audio-fft;73;76;75;74;73;155;74;74;77;74 17:37:49 INFO - PROCESS | 5596 | |4;audio-oscillator;96;97;150;96;97;98;155;97;97;151 17:37:49 INFO - PROCESS | 5596 | |5;imaging-gaussian-blur;121;116;117;116;116;116;117;116;115;116 17:37:49 INFO - PROCESS | 5596 | |6;imaging-darkroom;148;147;149;148;149;147;147;147;147;146 17:37:49 INFO - PROCESS | 5596 | |7;imaging-desaturate;96;97;97;97;97;99;97;97;97;97 17:37:49 INFO - PROCESS | 5596 | |8;json-parse-financial;58;62;59;57;60;61;59;68;58;59 17:37:49 INFO - PROCESS | 5596 | |9;json-stringify-tinderbox;70;68;68;68;67;68;68;69;68;68 17:37:49 INFO - PROCESS | 5596 | |10;stanford-crypto-aes;84;92;85;83;86;92;83;83;83;84 17:37:49 INFO - PROCESS | 5596 | |11;stanford-crypto-ccm;120;130;120;126;122;131;126;137;126;122 17:37:49 INFO - PROCESS | 5596 | |12;stanford-crypto-pbkdf2;148;147;167;156;167;144;158;149;161;140 17:37:49 INFO - PROCESS | 5596 | |13;stanford-crypto-sha256-iterative;74;71;78;72;73;69;71;73;68;69 17:37:49 INFO - PROCESS | 5596 | __end_tp_report 17:37:49 INFO - PROCESS | 5596 | __start_cc_report 17:37:49 INFO - PROCESS | 5596 | _x_x_mozilla_cycle_collect,776 17:37:49 INFO - PROCESS | 5596 | __end_cc_report 17:37:49 INFO - PROCESS | 5596 | __startTimestamp1456709869580__endTimestamp 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | ------- Summary: start ------- 17:37:49 INFO - PROCESS | 5596 | Number of tests: 14 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.90 (3.5%) stddev-sans-first:4.14 17:37:49 INFO - PROCESS | 5596 | Values: 113.0 108.0 114.0 112.0 113.0 123.0 112.0 110.0 113.0 113.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:154.50 stddev:15.95 (10.3%) stddev-sans-first:16.11 17:37:49 INFO - PROCESS | 5596 | Values: 164.0 127.0 154.0 171.0 127.0 153.0 155.0 142.0 169.0 139.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.88 (1.7%) stddev-sans-first:2.99 17:37:49 INFO - PROCESS | 5596 | Values: 164.0 165.0 166.0 165.0 165.0 162.0 166.0 173.0 166.0 164.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:25.50 (34.5%) stddev-sans-first:26.82 17:37:49 INFO - PROCESS | 5596 | Values: 73.0 76.0 75.0 74.0 73.0 155.0 74.0 74.0 77.0 74.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#4] audio-oscillator Cycles:10 Average:113.40 Median:97.00 stddev:26.67 (27.5%) stddev-sans-first:27.54 17:37:49 INFO - PROCESS | 5596 | Values: 96.0 97.0 150.0 96.0 97.0 98.0 155.0 97.0 97.0 151.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:116.00 stddev:1.65 (1.4%) stddev-sans-first:0.60 17:37:49 INFO - PROCESS | 5596 | Values: 121.0 116.0 117.0 116.0 116.0 116.0 117.0 116.0 115.0 116.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 17:37:49 INFO - PROCESS | 5596 | Values: 148.0 147.0 149.0 148.0 149.0 147.0 147.0 147.0 147.0 146.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 17:37:49 INFO - PROCESS | 5596 | Values: 96.0 97.0 97.0 97.0 97.0 99.0 97.0 97.0 97.0 97.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.50 stddev:3.14 (5.3%) stddev-sans-first:3.24 17:37:49 INFO - PROCESS | 5596 | Values: 58.0 62.0 59.0 57.0 60.0 61.0 59.0 68.0 58.0 59.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.50 17:37:49 INFO - PROCESS | 5596 | Values: 70.0 68.0 68.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:3.57 (4.2%) stddev-sans-first:3.74 17:37:49 INFO - PROCESS | 5596 | Values: 84.0 92.0 85.0 83.0 86.0 92.0 83.0 83.0 83.0 84.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.00 stddev:5.44 (4.3%) stddev-sans-first:5.32 17:37:49 INFO - PROCESS | 5596 | Values: 120.0 130.0 120.0 126.0 122.0 131.0 126.0 137.0 126.0 122.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:157.00 stddev:9.50 (6.1%) stddev-sans-first:9.85 17:37:49 INFO - PROCESS | 5596 | Values: 148.0 147.0 167.0 156.0 167.0 144.0 158.0 149.0 161.0 140.0 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:2.94 (4.1%) stddev-sans-first:3.00 17:37:49 INFO - PROCESS | 5596 | Values: 74.0 71.0 78.0 72.0 73.0 69.0 71.0 73.0 68.0 69.0 17:37:49 INFO - PROCESS | 5596 | -------- Summary: end -------- 17:37:49 INFO - PROCESS | 5596 | 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:49 INFO - PROCESS | 5596 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:37:50 INFO - TEST-INFO | 5596: exit 0 17:37:50 INFO - TEST-OK | kraken | took 60104ms 17:37:50 INFO - SUITE-END | took 1170s 17:37:50 INFO - Completed test suite (00:19:30) 17:37:50 INFO - Working with test: dromaeo_css 17:37:50 INFO - Generating results file: dromaeo_css 17:37:50 INFO - Working with test: kraken 17:37:50 INFO - Generating results file: kraken 17:37:50 INFO - javascript benchmark 17:37:50 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:37:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:37:50 INFO - process_Request line: dromaeo_css 6680.89 graph.html#tests=[[72,64,43]] 17:37:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:37:50 INFO - process_Request line: kraken 1551.20 graph.html#tests=[[232,64,43]] 17:37:50 INFO - RETURN: dromaeo_css: 6680.89 17:37:50 INFO - RETURN: kraken: 1551.20 17:37:50 INFO - javascript benchmark 17:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3169.841507924604, 3174.254050298181, 3199.58405407297, 3211.662775408582, 3217.678232176783, 5134.922976155356, 5147.51098645629, 5186.7147306898105, 5196.870078248041, 5207.6875387476775, 5202.453742357055, 5204.583633309336, 5254.106801843686, 5273.736313184345, 5299.0, 4732.858014259569, 4800.90398192036, 4850.611951043926, 4858.805647774103, 4907.043126590316, 4770.165221086313, 4866.902661946759, 4935.457099719028, 4938.7530623468865, 4970.676906001098, 4746.288056791492, 4760.357351757503, 4808.831690890802, 4828.0, 4835.830745923893, 4759.4764575896625, 4760.0, 4767.404074490689, 4803.687760295569, 4818.34952281441, 4643.953560464386, 4707.411573553306, 4772.331873537708, 4772.6911460817155, 4800.519948005206, 5097.158968770148, 5111.872203194913, 5132.923006154911, 5140.228965655144, 5175.068487672217, 5478.424765399655, 5555.611107222496, 5558.722063896829, 5559.499645031926, 5582.911332290205, 5514.310711161105, 5641.971790141023, 5643.802466913679, 5664.320281566197, 5666.235058267122, 5269.789208431658, 5287.947120528784, 5313.203019547099, 5326.5472434842695, 5345.465453454663, 5706.229658996065, 5734.655920644691, 5747.597668163272, 5753.33836608787, 5762.423757624204, 5376.220448035013, 5431.293931788842, 5470.452954704578, 5521.116621340566, 5610.354809196913, 5632.746526406239, 5635.802746903921, 5638.210650508932, 5650.180723795027, 5669.858253543612, 5356.276902618175, 5563.082091454865, 5571.4428557143965, 5585.469380408855, 5714.114312281603, 5487.176923461433, 5555.333359996826, 5570.916436253459, 5596.076647353222, 5623.353314368818, 4189.2040512302565, 4233.640140588084, 4236.491621005437, 4245.80893859777, 4286.271333873186, 3838.673712734393, 3841.8655347063277, 3847.826847791856, 3859.208862183246, 3859.9035024124623, 5147.974260128675, 5270.789168433296, 5271.103912334912, 5333.120035194227, 5338.599605029638, 5569.081101618188, 5594.13290939905, 5627.887442251132, 5637.661740295595, 5663.122216056518, 5292.153255479105, 5375.3012108425655, 5375.462453754593, 5380.91928621071, 5433.185022246695, 4624.791884365211, 4718.292256161603, 4747.95252047482, 4751.596114330251, 4826.710397376169, 5798.362180160179, 5806.0, 5806.68063256525, 5815.79644712433, 5831.79588714393, 5474.972625136849, 5580.581456390706, 5588.133839254922, 5591.6365436246515, 5624.803131890364, 5865.5600829937075, 5898.20374249488, 5920.763169473173, 5934.287885453773, 5944.167816505779, 5500.697461639648, 5521.558275337883, 5522.502974732293, 5526.392096869261, 5537.280153580009, 5461.317335333083, 5555.2222688822785, 5601.859953501195, 5618.803341883015, 5635.605507614591, 5327.627066105335, 5389.137737961907, 5449.291592093003, 5478.369987451494, 5523.972380138073, 5393.51458368733, 5398.271233383443, 5433.701146436984, 5438.184272359178, 5440.727963601725, 5270.552003079782, 5313.574914006793, 5320.0955837506945, 5327.094393953114, 5393.40672526014, 5465.699386533779, 5514.972425137848, 5521.475459831309, 5527.088030474926, 5527.2538207343105, 5346.411894691659, 5360.731963401892, 5394.056040193029, 5412.83761487156, 5466.863328416822], "unit": "score", "name": "dojo.html", "value": 5170.486200053499}, {"lowerIsBetter": false, "replicates": [495.9231319145529, 556.7383329834976, 588.3293045927643, 592.9940700592994, 599.4125756758376, 28094.438111237763, 35921.46117808235, 35961.820190899045, 36268.63731362686, 36273.63726362732, 39296.41055384164, 39445.80277098618, 39720.0, 39948.600513994854, 40043.19913601726, 8385.119562445932, 8551.059383467813, 8587.141285871394, 8617.827643447128, 8629.69796057138, 8324.916750832475, 8532.445391049592, 8533.359998000144, 8533.487990720576, 8604.26863716585, 8449.197326253996, 8748.650053997833, 8757.605907734136, 8769.298456123526, 8822.514761688104, 8696.086910874363, 8704.129587041309, 8710.651573937035, 8725.214730674237, 8749.912500874974, 8640.611172497252, 8692.434991725517, 8728.650853965833, 8830.0, 8842.159994800484, 39401.60598394008, 39445.60554394448, 39674.603253967376, 40080.79959600212, 40218.39672404916, 3467.9826600867086, 3554.751167418282, 3596.226811235597, 3674.430463278196, 3945.9013524662114, 29387.265318366997, 29792.553111703342, 29897.402051959056, 30458.54312185319, 30755.231119221975, 3780.6030366811638, 3796.335641262768, 3804.5434547854156, 3893.1629699614437, 3932.4494570760116, 264726.0, 267891.0, 268779.0, 270092.0, 270711.0, 39765.60234397677, 40977.79511102485, 56118.15822762662, 56413.435865640815, 56426.43573564294, 39341.40987885184, 39375.2124957505, 39474.21051578952, 39537.60462395339, 39761.60238397579, 14439.566812995417, 14600.809878518307, 14626.268686565629, 14659.853401465849, 14675.92662036683, 11720.88279117198, 11824.763504729857, 11864.406779660982, 11874.525018999317, 11877.0, 13568.118072325267, 14117.152970821784, 14131.152130871975, 14168.504102356368, 14236.928815355857, 5627.71861406928, 5806.65160090396, 5855.209546711139, 5907.763689452374, 5950.256217972754, 932.529072818236, 970.3644113105927, 976.3556053004983, 1017.811704834608, 1023.8822535408375, 27428.177154685392, 28365.574516382272, 28416.85791571029, 28750.13749587516, 28986.27534311617, 970.5195928015678, 1006.6778630838207, 1040.5265604150093, 1041.9218558608134, 1100.0979197058496, 13146.671333216746, 14145.5049073284, 14244.715105697827, 14373.568792936228, 14407.135571865721, 281284.0, 441378.0, 448102.0, 448261.0, 448603.0, 52937.735311323966, 53394.19908701372, 53766.73116634392, 53981.1902821458, 54025.72987135039, 1369.383777300219, 1372.524536123671, 1381.3369582600208, 1390.3326403326257, 1401.0472878442554, 28039.158825235274, 29322.413551729274, 29682.703172967995, 30015.54976675308, 30095.398092038475, 43756.56243437525, 44512.33231501465, 44605.330920036875, 44617.33074003957, 44689.32966005448, 272913.0, 277333.0, 278002.0, 278195.0, 278235.0, 31223.0, 31494.842525787226, 41859.0, 42705.14589708126, 43159.0, 39613.0, 40302.1939561213, 40686.389704153866, 40863.7956810214, 41037.0, 35192.0, 35527.64472355243, 35690.64309356873, 35723.46414803728, 36342.63657363498, 34993.47509787406, 35527.46708799422, 35733.82133089318, 36013.0, 36062.098447537974, 36185.095372614844, 36265.45601816028, 37620.62379376281, 38367.232655347296, 38578.61421385862, 28479.715202847707, 32576.34847302993, 33159.0, 33309.0, 33460.83269583636, 24213.394665133514, 24344.26967190987, 24667.25998220056, 24927.37681557903, 24950.0], "unit": "score", "name": "ext.html", "value": 17888.974667016508}, {"lowerIsBetter": false, "replicates": [333.225251290749, 341.172656308452, 347.11831946855006, 359.1882345898269, 361.0090302120679, 16572.751408728862, 17174.313027478885, 17197.22612482438, 17563.999999999985, 17742.733858992095, 15884.52346429609, 16184.190790460489, 16307.347706091772, 16416.917915410435, 16500.17499125045, 4736.455307639622, 4910.41075070992, 4936.777844996984, 4945.480724523927, 4970.030843985424, 4974.42794078682, 5385.111456609655, 5415.783368665248, 5442.945570544283, 5445.646033007862, 5270.868228294305, 5328.440513746059, 5341.626086173969, 5392.865178370533, 5397.919031214535, 5053.79784808609, 5247.212918062283, 5257.263983042377, 5270.104082305978, 5368.812091576796, 4969.577585905203, 5038.0, 5042.672226305279, 5043.823466178666, 5122.743862806882, 12733.236005839586, 13009.60971170857, 13035.934820325838, 13069.346532673328, 13106.60680179596, 2153.0, 2257.3115199864037, 2393.34183099649, 2399.6280576510667, 2601.9869900650374, 9187.173154416068, 9349.672761453385, 9379.202767764747, 9599.616015359377, 9744.512774361254, 1796.4341232511847, 1800.7478952946599, 1816.2190258188973, 1828.3509354179207, 1888.6033932874113, 57862.42137578612, 61767.69116154435, 63276.36723632751, 63296.0, 65192.674036629985, 9364.204042656314, 9403.858942115874, 9573.569189386495, 9606.567704453317, 9642.4214547126, 11721.296722196696, 12052.517899284107, 12286.139970202, 12428.875711242952, 12451.501939922482, 7178.856422871513, 7456.925430745731, 7498.925010749932, 7499.437542184358, 7567.3189412952, 7533.397328213729, 7605.505642133244, 7615.390768738488, 7752.302292793675, 7770.650320735581, 4071.2875246831686, 4149.460570125864, 4190.224808410454, 4213.936790948138, 4516.096780643885, 1776.644671065792, 1836.063607560154, 1859.618778150476, 1875.6248750250004, 1901.610169915164, 429.21239525470486, 431.45851955795274, 440.02534386334423, 840.8318336332758, 887.6286137916934, 10494.842577361345, 10953.726156846142, 11133.10935125188, 11220.438978051065, 11239.887601124048, 444.4488833846072, 448.7128237927729, 449.6627529352985, 450.92108880945705, 459.10016367918587, 5763.423657634287, 6002.909956350658, 6061.575689701678, 6097.817065488042, 6124.755009799647, 389197.0, 391031.0, 396861.0, 405789.0, 407825.0, 73493.26506734971, 73604.0, 74223.62888185524, 75089.0, 76589.23410765933, 481.8096851743542, 483.09660934053545, 483.63485568395635, 485.8396729079466, 486.7104073076514, 14793.260336983323, 15841.920790395974, 15849.286782094603, 15948.521544353687, 16369.0, 31273.8436307817, 32849.34301314008, 33163.668363317025, 34982.65017349794, 36110.0, 36688.63311366852, 38553.61446385612, 41147.58852411438, 43015.13969720525, 43198.78400607977, 8036.1160272368825, 8067.636956337096, 8168.428210025241, 8261.917380826355, 8276.379271554537, 10603.41681207541, 10912.825011963541, 11806.055515558563, 11846.466908988943, 12492.188007779465, 9861.211103111877, 9957.601695932082, 10275.177985761271, 10493.160547156056, 10798.298110622783, 7520.924790752241, 7550.924490755022, 7561.4706970513735, 7616.124145723313, 7730.497517661334, 5263.289455923401, 7415.443841711785, 8267.545285009382, 8335.0, 8620.61207245688, 10554.841677374692, 10680.412577308012, 11058.170637202404, 11103.222774405715, 11106.50020749052, 10825.729356766144, 10997.175211858983, 11448.370339631067, 11593.0, 11727.179097463095], "unit": "score", "name": "jquery.html", "value": 7439.93289621248}, {"lowerIsBetter": false, "replicates": [1439.9352029158688, 1448.760954442517, 1604.5507257967765, 1751.0806826416137, 1789.0786245083775, 6939.965300173499, 7090.149182098143, 7126.75056373027, 7150.606716630577, 7271.709131634741, 7340.816479588013, 7358.043454350927, 7453.291937265964, 7460.104787425503, 7477.925220747791, 2238.3173132194675, 2239.764824693408, 2259.378670865517, 2261.1520679745095, 2261.2424837679314, 2261.321603518946, 2270.126001489422, 2295.8737269450176, 2308.7575804540534, 2320.454693147109, 2191.7260342457193, 2202.48241663209, 2244.5286489837154, 2260.2654137405407, 2287.1308902616984, 2256.2216035467736, 2270.1146552844402, 2276.544691061786, 2278.043221846828, 2290.3701482092474, 2285.382946604424, 2311.133325003124, 2312.6993490846253, 2314.618088015475, 2323.604987152188, 7383.409327253807, 7385.66764495599, 7437.85124297511, 7438.367738742213, 7443.962780186119, 4403.229434848889, 4473.507914129443, 4498.707584007062, 4506.864794056183, 4518.570735780096, 2852.429514097168, 2873.2668307130198, 2941.264683829043, 2969.035063604316, 2994.1766014346013, 911.6717981526646, 917.3807679816098, 928.4150984879483, 928.9628414863397, 939.4316438554645, 9847.0, 9905.85141222875, 9907.0, 9952.850707239397, 9975.600975960953, 3907.902302442462, 3919.3141200290406, 3983.46223259862, 4033.899152521152, 4046.8988275292763, 8017.7995550110545, 8038.356931445471, 8068.0, 8068.273855353046, 8071.152528984489, 4462.085272519126, 4475.015496590745, 4523.208438523246, 4539.9773001135445, 4562.771861406916, 4015.718899677053, 4123.773192474383, 4123.97938010308, 4164.541900390955, 4237.237297286456, 3317.9170520736693, 3349.447341188725, 3350.413677606458, 3361.798292102482, 3398.150462384404, 1052.0531521630442, 1052.85786418834, 1058.687687132298, 1060.0565496707936, 1064.2975636080305, 1035.5598870480017, 1049.5959055763585, 1222.541546919905, 1341.4231880291372, 1355.1327150623608, 6834.726610935606, 6869.931300687029, 6894.827629309308, 6926.06498122747, 6939.514234003672, 482.3632804697765, 483.8113135877011, 486.9440014398319, 490.80122550367156, 492.3230557982774, 5262.158054711228, 5323.840284791385, 5325.813596524103, 5362.463753624606, 5372.785088596491, 8419.452735572168, 8561.315094792526, 8841.381103322705, 8876.8668469973, 8954.955225223832, 8664.523451210118, 8675.6529738811, 8784.253338466175, 8785.736427907173, 8786.60460279289, 6597.538172327987, 6699.162604674416, 6738.629375384303, 6999.720011199495, 7014.824629384306, 6666.666666666744, 6693.464522838259, 6706.262311145868, 6740.561863478858, 6742.224644165984, 7718.266764657348, 7833.843323133391, 7986.640601173078, 7990.280874721303, 8040.638171282189, 7930.920690793018, 8009.75970720856, 8110.553919534483, 8134.633941472766, 8143.5928203590765, 5625.831225063254, 5848.356680765198, 6193.38066193377, 6308.400701933309, 6323.525735569759, 6811.114555107804, 6900.171979362509, 6915.89626155598, 6920.342567456084, 6920.5847649141215, 6253.593516421418, 6506.804795856132, 6586.769463068769, 6595.736170553124, 6599.67001649906, 6221.097940798469, 6354.6504942226775, 6390.201224846895, 6458.580192287486, 6524.869502610016, 6617.735290588323, 6633.9336606633315, 6659.667016649051, 6686.331366863469, 6688.531802773759, 5970.253718285215, 6089.756409743561, 6128.356522565245, 6147.170132032118, 6156.26124865019, 6205.596636218631, 6242.406971337716, 6273.560850740404, 6284.340144284784, 6295.150154729236], "unit": "score", "name": "mootools.html", "value": 4167.182162458034}, {"lowerIsBetter": false, "replicates": [319.8065170571804, 326.29194647614673, 326.44178454842216, 330.3887807556021, 331.1274790925911, 6147.69261536923, 6242.937570624293, 6284.308726040132, 6307.905381419277, 6339.429451349371, 6114.113453549233, 6163.2912215095275, 6176.320604733476, 6180.783672571461, 6181.381861813817, 4444.20004399208, 4548.727076375411, 4566.589006989387, 4584.174848527264, 4738.478767335599, 4579.107074120548, 4609.53904609538, 4613.0, 4631.328457373679, 4653.674242803005, 4561.315802629599, 4566.246569316058, 4568.2462393705, 4578.610818080467, 4609.078184363124, 4577.038821847416, 4599.977000114995, 4608.907821843578, 4612.1698094343, 4618.8152473901, 3894.883153505399, 3933.645971862546, 3941.5861334559745, 3943.861964831217, 3945.506811648544, 5844.26946631671, 5857.297124345063, 5864.7067646617925, 5872.236609240814, 5872.765089396419, 5152.819651312224, 5331.706756128411, 5362.946370536284, 5370.060239458079, 5392.811251606175, 6506.93493065068, 6536.150300460909, 6537.280899101095, 6542.345765423467, 6554.967225163891, 4414.073044660625, 4417.690761646686, 4426.136903303857, 4426.313921342197, 4439.445069366329, 6761.29006454325, 6783.864322713567, 6786.185657721056, 6840.384365407088, 6870.62211578368, 4513.81944722214, 4515.142122996685, 4521.886952826206, 4529.207388706963, 4536.750478723636, 4539.319102134707, 4581.152486789888, 4592.67851250416, 4674.205385084544, 4695.741734204652, 5382.300300960928, 5384.5692344612335, 5406.567474602022, 5417.593680473901, 5432.424596866943, 6521.021846722934, 6537.607743535403, 6557.737690492422, 6569.277379488252, 6593.900866592694, 1648.6372997940434, 1690.8309169082993, 1696.5164927995463, 1702.6850032743982, 1705.292303693953, 1103.089950790601, 1118.8825173356843, 1137.0676045642658, 1159.2986243322837, 1160.100921785606, 6260.0, 6278.560500764903, 6281.497480201573, 6281.842953926097, 6289.308176100625, 6724.0, 6726.3609957054005, 6727.29363416844, 6736.494762892803, 6782.491313151533, 6129.172561704113, 6260.436560709558, 6266.091416744546, 6315.684215789192, 6397.552171347961, 3682.779033258013, 3686.391745362039, 3704.0554658561896, 3715.498407714978, 3719.590845007047, 7221.277872212841, 7245.8550828983125, 7255.129384473791, 7260.491765576359, 7282.235365286569, 7009.369156775914, 7012.5792452452, 7020.543664661883, 7020.613866237406, 7033.156021277479, 7063.434925205971, 7243.674034668347, 7245.456590755609, 7245.637718114073, 7250.673719682627, 6777.322267773183, 6782.694778735067, 6789.762358317435, 6811.65941702903, 6842.623655698984, 6735.696893639896, 6760.425363844129, 6769.559978601375, 6780.966095169492, 6801.353871382211, 7010.579365238102, 7065.22282548909, 7084.0, 7091.964540177266, 7114.14630244374, 4374.956250437455, 4435.911281774411, 4459.241928872035, 4476.798544065459, 4481.0, 6792.592444453151, 6793.694283757144, 6794.76218332356, 6795.524313298021, 6805.625690586867, 6511.283758786624, 6516.315786842503, 6549.345065493412, 6562.34376562359, 6573.014047892854, 6506.772262970773, 6558.344165583403, 6565.573237739723, 6568.770093046912, 6584.078229047841, 6326.778562750282, 6418.582792118497, 6429.646369449538, 6449.580777249652, 6452.225732911893, 6670.0, 6689.46484281266, 6711.563748356341, 6715.832104197434, 6731.057651928636, 6475.643839588868, 6482.805515834532, 6503.869922601616, 6512.283648798533, 6525.477961763143], "unit": "score", "name": "prototype.html", "value": 4921.268879492148}, {"lowerIsBetter": false, "replicates": [722.6422920654276, 737.9889301660472, 794.3089512124452, 806.7378102116813, 830.0869044051544, 13706.657333566665, 13822.930885345584, 13884.305784710761, 13893.930530347334, 13902.235377054245, 12977.221366718004, 13033.674158146052, 13149.145305555132, 13255.933720331384, 13261.403236854341, 685.4379408884716, 821.3880658909106, 825.1789469477878, 836.7489753074084, 839.0728245288959, 827.4084029918607, 832.633641197874, 834.4617721569614, 835.7033253195119, 836.7322456813822, 879.3009557401849, 879.5778026547262, 880.2737741363369, 880.2781718990431, 884.9513276769775, 871.2072014466868, 873.9431936924079, 877.9429337093069, 878.2052242720316, 878.3719640457072, 643.7618081309898, 646.2148489585177, 647.4399644307687, 650.3821369698805, 652.7780554611455, 13798.586042418743, 13825.032247742662, 13854.030217884752, 13856.0, 13864.722705545833, 13070.346482675923, 13185.602168312253, 13193.274369909652, 13195.472181112744, 13294.601161965156, 10269.793791969538, 10515.63195288169, 10582.470876456146, 10600.310979786289, 10975.231733778639, 3714.23858109087, 3718.7025037996896, 3724.646158614927, 3751.118487155516, 3817.923641527154, 46055.76972115151, 46122.308165377544, 46584.30123548149, 46849.29726054112, 49319.260211096866, 10440.164786817037, 10534.262601617813, 10550.894491055145, 10606.787864242671, 10725.78548429027, 17734.20196091179, 17795.73306400405, 17798.110094495223, 17849.286028558712, 17887.105644717973, 7780.221977802287, 7859.214078592209, 7935.682572697027, 7953.443258971816, 8130.552819594979, 4495.1234509271035, 4520.050789334211, 4536.546345365437, 4547.522510136454, 4797.112534181118, 3054.801437906529, 3079.1840162356993, 3086.537019447101, 3095.9845200773852, 3104.611923509561, 589.3428826858108, 593.4777395891588, 594.5867622002753, 597.0745344715673, 602.3614968133792, 504.04735050754107, 526.7971830845153, 630.3948209718629, 651.9641419721866, 657.1239112334313, 7954.960225198837, 8253.257206851413, 8278.0, 8689.348298877609, 9244.491552964651, 543.8096666166809, 668.3433007247769, 669.9732010719516, 680.1328306409268, 702.1784512120729, 3898.4152377143655, 3904.590018048121, 3921.843126274974, 3934.901627459279, 3980.900477488086, 54664.0, 55226.44773552213, 55276.72361638166, 55489.445105548424, 55561.44438555644, 47631.76184119126, 48143.75928120337, 48453.75773121112, 48519.5148048515, 48832.26751598729, 43489.78255108704, 44355.0, 44896.73481019298, 45551.99999999934, 46365.768171158925, 7834.0, 7886.132525422314, 7988.281054705104, 8013.559254241072, 8135.430519863553, 31685.5247171288, 32815.34369312648, 33499.66500335063, 33677.15807104744, 33856.15359615931, 39467.40798887962, 40672.79663601663, 40820.1835963285, 41609.37585936153, 42527.787361064235, 10629.787404252027, 10991.890081099407, 11036.172287078341, 11159.0, 11319.320840749582, 11889.048876090064, 12010.33943133136, 12430.12989090755, 12505.957108816376, 12669.429875655433, 10912.836307455553, 11132.777344452903, 11314.698809636668, 11492.425378731197, 11846.881531184577, 10471.528781204712, 10551.366917984946, 10629.521671524646, 10644.137275976827, 10704.143668506345, 10562.683119506428, 11475.311481311148, 11492.94253528727, 11806.462547731218, 11911.3448760319, 9716.22270218395, 10052.0, 10244.0, 10259.127974122282, 10273.280870339004, 8795.340349473687, 8885.764429021352, 9206.520501561696, 9620.518974051129, 9841.065098815601], "unit": "score", "name": "yui.html", "value": 6300.330511690218}], "name": "dromaeo_css", "value": 6680.892144489214}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 114.0, 112.0, 113.0, 123.0, 112.0, 110.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [164.0, 127.0, 154.0, 171.0, 127.0, 153.0, 155.0, 142.0, 169.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [164.0, 165.0, 166.0, 165.0, 165.0, 162.0, 166.0, 173.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 165.6}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 75.0, 74.0, 73.0, 155.0, 74.0, 74.0, 77.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 96.0, 97.0, 98.0, 155.0, 97.0, 97.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 113.4}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 148.0, 149.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 99.0, 97.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.1}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 59.0, 57.0, 60.0, 61.0, 59.0, 68.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 92.0, 85.0, 83.0, 86.0, 92.0, 83.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [120.0, 130.0, 120.0, 126.0, 122.0, 131.0, 126.0, 137.0, 126.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 167.0, 156.0, 167.0, 144.0, 158.0, 149.0, 161.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 78.0, 72.0, 73.0, 69.0, 71.0, 73.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1551.2}]} 17:37:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1551.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6680.89"}}} 17:37:50 INFO - Return code: 0 17:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:50 ERROR - # TBPL SUCCESS # 17:37:50 INFO - Running post-action listener: _resource_record_post_action 17:37:50 INFO - Running post-run listener: _resource_record_post_run 17:37:52 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542793728; Read time: 24; Write time: 513956 17:37:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247459840; Read time: 0; Write time: 295876 17:37:52 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295333888; Read time: 24; Write time: 218080 17:37:52 INFO - Running post-run listener: _upload_blobber_files 17:37:52 INFO - Blob upload gear active. 17:37:52 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:37:52 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 17:37:52 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 17:37:52 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 17:37:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:53 INFO - (blobuploader) - INFO - Done attempting. 17:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:53 INFO - (blobuploader) - INFO - Done attempting. 17:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:54 INFO - Return code: 0 17:37:54 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:37:54 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2a72455d9c646e001df0096c28a586babd26c538881d6400e20b35e1ef993e96febdea495995dcfced3fc1bd5393fda154142ff346a42b51b8b97a89b041b1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cca2fd6aa7733ee37216689dc0856dcdf51d3f440d69c992542c0def29617cefb639fe4dff52a8e6cc5ca6e9bdc74e5cf91665bc6644bc0577e20bda92ab58"} 17:37:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:37:54 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:37:54 INFO - Contents: 17:37:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2a72455d9c646e001df0096c28a586babd26c538881d6400e20b35e1ef993e96febdea495995dcfced3fc1bd5393fda154142ff346a42b51b8b97a89b041b1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cca2fd6aa7733ee37216689dc0856dcdf51d3f440d69c992542c0def29617cefb639fe4dff52a8e6cc5ca6e9bdc74e5cf91665bc6644bc0577e20bda92ab58"} 17:37:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:54 INFO - Copying logs to upload dir... 17:37:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:37:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.571269 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-28 17:37:53.824955) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 17:37:53.827982) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 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/Fx-Team/sha512/e2a72455d9c646e001df0096c28a586babd26c538881d6400e20b35e1ef993e96febdea495995dcfced3fc1bd5393fda154142ff346a42b51b8b97a89b041b1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cca2fd6aa7733ee37216689dc0856dcdf51d3f440d69c992542c0def29617cefb639fe4dff52a8e6cc5ca6e9bdc74e5cf91665bc6644bc0577e20bda92ab58"} build_url:https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011386 build_url: 'https://queue.taskcluster.net/v1/task/GCm13yexQo-yOosP8k4bmw/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/Fx-Team/sha512/e2a72455d9c646e001df0096c28a586babd26c538881d6400e20b35e1ef993e96febdea495995dcfced3fc1bd5393fda154142ff346a42b51b8b97a89b041b1d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cca2fd6aa7733ee37216689dc0856dcdf51d3f440d69c992542c0def29617cefb639fe4dff52a8e6cc5ca6e9bdc74e5cf91665bc6644bc0577e20bda92ab58"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 17:37:53.851942) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:37:53.852219) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1456708171.813903-1042567698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 17:37:53.937564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 17:37:53.937932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 17:37:53.938275) ========= ========= Total master_lag: 0.29 =========