builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1456977969.97 results: success (0) buildid: 20160302173009 builduid: ccaeddfe0ef74dcaafb39bb8b59be82c revision: 6a355b46c68b43c0df96978a25b36b661dd98737 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:09.968070) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:09.968514) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:09.968817) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008866 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:09.991685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:09.992000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.005265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.005591) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.054871) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.055187) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.055580) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.055861) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-02 20:06:10-- 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% 69.5M=0s 2016-03-02 20:06:10 (69.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.179797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.180261) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022049 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:10.275678) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 20:06:10.276311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a355b46c68b43c0df96978a25b36b661dd98737 --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 6a355b46c68b43c0df96978a25b36b661dd98737 --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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-02 20:06:10,481 truncating revision to first 12 chars 2016-03-02 20:06:10,481 Setting DEBUG logging. 2016-03-02 20:06:10,481 attempt 1/10 2016-03-02 20:06:10,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a355b46c68b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 20:06:11,833 unpacking tar archive at: fx-team-6a355b46c68b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.650414 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 20:06:11.940288) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:11.940640) ========= echo 6a355b46c68b43c0df96978a25b36b661dd98737 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6a355b46c68b43c0df96978a25b36b661dd98737'] 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6a355b46c68b43c0df96978a25b36b661dd98737 program finished with exit code 0 elapsedTime=0.004795 script_repo_revision: '6a355b46c68b43c0df96978a25b36b661dd98737' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:11.998991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:11.999331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 20:06:12.009068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-02 20:06:12.009389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:12 INFO - MultiFileLogger online at 20160302 20:06:12 in /builds/slave/test-pgo 20:06:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:06:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:06:12 INFO - {'append_to_log': False, 20:06:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:06:12 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:06:12 INFO - 'branch': 'Fx-Team', 20:06:12 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:12 INFO - 'config_files': ('talos/linux_config.py',), 20:06:12 INFO - 'default_actions': ('clobber', 20:06:12 INFO - 'read-buildbot-config', 20:06:12 INFO - 'download-and-extract', 20:06:12 INFO - 'populate-webroot', 20:06:12 INFO - 'create-virtualenv', 20:06:12 INFO - 'install', 20:06:12 INFO - 'run-tests'), 20:06:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:12 INFO - 'download_minidump_stackwalk': True, 20:06:12 INFO - 'download_symbols': 'ondemand', 20:06:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:12 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:12 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:12 INFO - 'installer_path': 'installer.exe', 20:06:12 INFO - 'log_level': 'info', 20:06:12 INFO - 'log_name': 'talos', 20:06:12 INFO - 'log_to_console': True, 20:06:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:12 INFO - 'opt_config_files': (), 20:06:12 INFO - 'pip_index': False, 20:06:12 INFO - 'sps_profile': False, 20:06:12 INFO - 'sps_profile_interval': 0, 20:06:12 INFO - 'suite': 'dromaeojs', 20:06:12 INFO - 'system_bits': '32', 20:06:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:12 INFO - 'title': 'talos-linux64-ix-016', 20:06:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:12 INFO - 'use_talos_json': True, 20:06:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:06:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:12 INFO - 'work_dir': 'build'} 20:06:12 INFO - ##### 20:06:12 INFO - ##### Running clobber step. 20:06:12 INFO - ##### 20:06:12 INFO - Running pre-action listener: _resource_record_pre_action 20:06:12 INFO - Running main action method: clobber 20:06:12 INFO - rmtree: /builds/slave/test-pgo/build 20:06:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:06:12 INFO - Running post-action listener: _resource_record_post_action 20:06:12 INFO - ##### 20:06:12 INFO - ##### Running read-buildbot-config step. 20:06:12 INFO - ##### 20:06:12 INFO - Running pre-action listener: _resource_record_pre_action 20:06:12 INFO - Running main action method: read_buildbot_config 20:06:12 INFO - Using buildbot properties: 20:06:12 INFO - { 20:06:12 INFO - "project": "", 20:06:12 INFO - "product": "firefox", 20:06:12 INFO - "script_repo_revision": "production", 20:06:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:06:12 INFO - "repository": "", 20:06:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:06:12 INFO - "buildid": "20160302173009", 20:06:12 INFO - "pgo_build": "True", 20:06:12 INFO - "basedir": "/builds/slave/test-pgo", 20:06:12 INFO - "buildnumber": 529, 20:06:12 INFO - "slavename": "talos-linux64-ix-016", 20:06:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:06:12 INFO - "platform": "ubuntu64_hw", 20:06:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:06:12 INFO - "branch": "fx-team", 20:06:12 INFO - "repo_path": "integration/fx-team", 20:06:12 INFO - "revision": "6a355b46c68b43c0df96978a25b36b661dd98737", 20:06:12 INFO - "stage_platform": "linux64-pgo", 20:06:12 INFO - "builduid": "ccaeddfe0ef74dcaafb39bb8b59be82c", 20:06:12 INFO - "slavebuilddir": "test" 20:06:12 INFO - } 20:06:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 20:06:12 INFO - Running post-action listener: _resource_record_post_action 20:06:12 INFO - ##### 20:06:12 INFO - ##### Running download-and-extract step. 20:06:12 INFO - ##### 20:06:12 INFO - Running pre-action listener: _resource_record_pre_action 20:06:12 INFO - Running main action method: download_and_extract 20:06:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:12 INFO - https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 20:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 20:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 20:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:06:14 INFO - Downloaded 1448 bytes. 20:06:14 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 20:06:14 INFO - Using the following test package requirements: 20:06:14 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'jsshell-linux-x86_64.zip'], 20:06:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:14 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:14 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:14 INFO - https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:16 INFO - Downloaded 23394724 bytes. 20:06:16 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'] 20:06:16 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 20:06:17 INFO - Return code: 0 20:06:17 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 20:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:17 INFO - https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:06:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:06:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:19 INFO - Downloaded 23394724 bytes. 20:06:19 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'] 20:06:19 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 20:06:20 INFO - Return code: 0 20:06: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')]} 20:06:20 INFO - https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:21 INFO - Downloaded 10808263 bytes. 20:06:21 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'] 20:06:21 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 20:06:21 INFO - Return code: 0 20:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:21 INFO - https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fonu3_qqQgCBih2N3o9bFg/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 20:06:23 INFO - Downloaded 56156099 bytes. 20:06:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:06:23 INFO - mkdir: /builds/slave/test-pgo/properties 20:06:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:06:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:06:23 INFO - Contents: 20:06:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:06:24 INFO - Running post-action listener: _resource_record_post_action 20:06:24 INFO - Running post-action listener: set_extra_try_arguments 20:06:24 INFO - ##### 20:06:24 INFO - ##### Running populate-webroot step. 20:06:24 INFO - ##### 20:06:24 INFO - Running pre-action listener: _resource_record_pre_action 20:06:24 INFO - Running main action method: populate_webroot 20:06:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:24 INFO - '--tppagecycles', 20:06:24 INFO - '7'], 20:06:24 INFO - 'tests': ['tsvgm']}}, 20:06:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:06:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:06:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'tests': ['damp', 'tps']}, 20:06:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['damp', 'tps']}, 20:06:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:06:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:24 INFO - 'other': {'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'other_l64': {'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'other_nol64': {'tests': ['a11yr', 20:06:24 INFO - 'ts_paint', 20:06:24 INFO - 'tpaint', 20:06:24 INFO - 'sessionrestore', 20:06:24 INFO - 'sessionrestore_no_auto_restore']}, 20:06:24 INFO - 'svgr': {'tests': ['tsvgx', 20:06:24 INFO - 'tsvgr_opacity', 20:06:24 INFO - 'tart', 20:06:24 INFO - 'tscrollx', 20:06:24 INFO - 'cart']}, 20:06:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['tsvgx', 20:06:24 INFO - 'tsvgr_opacity', 20:06:24 INFO - 'tart', 20:06:24 INFO - 'tscrollx', 20:06:24 INFO - 'cart']}, 20:06:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'tests': ['tp5o']}, 20:06:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'talos_options': ['--e10s'], 20:06:24 INFO - 'tests': ['tp5o']}, 20:06:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'talos_options': ['--xperf_path', 20:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:24 INFO - 'tests': ['tp5n']}, 20:06:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:24 INFO - 'talos_options': ['--e10s', 20:06:24 INFO - '--xperf_path', 20:06:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:24 INFO - 'tests': ['tp5n']}}, 20:06:24 INFO - 'talos.zip': {'path': '', 20:06:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:24 INFO - Running post-action listener: _resource_record_post_action 20:06:24 INFO - ##### 20:06:24 INFO - ##### Running create-virtualenv step. 20:06:24 INFO - ##### 20:06:24 INFO - Running pre-action listener: _resource_record_pre_action 20:06:24 INFO - Running main action method: create_virtualenv 20:06:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:06:24 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 20:06:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:06:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:24 INFO - Using real prefix '/usr' 20:06:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:06:25 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:26 INFO - Installing pip.................done. 20:06:26 INFO - Return code: 0 20:06:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:06:26 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')]} 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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')]} 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:27 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 20:06:27 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 20:06:27 INFO - Using env: {'DISPLAY': ':0', 20:06:27 INFO - 'HOME': '/home/cltbld', 20:06:27 INFO - 'LANG': 'en_US.UTF-8', 20:06:27 INFO - 'LANGUAGE': 'en_US:en', 20:06:27 INFO - 'LOGNAME': 'cltbld', 20:06:27 INFO - 'MAIL': '/var/mail/cltbld', 20:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:27 INFO - 'MOZ_NO_REMOTE': '1', 20:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:27 INFO - 'NO_EM_RESTART': '1', 20:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:27 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:27 INFO - 'SHELL': '/bin/bash', 20:06:27 INFO - 'SHLVL': '1', 20:06:27 INFO - 'TERM': 'linux', 20:06:27 INFO - 'TMOUT': '86400', 20:06:27 INFO - 'USER': 'cltbld', 20:06:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:27 INFO - '_': '/tools/buildbot/bin/python'} 20:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:27 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 20:06:27 INFO - Cleaning up... 20:06:27 INFO - Return code: 0 20:06:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:06:27 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')]} 20:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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')]} 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:27 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 20:06:27 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 20:06:27 INFO - Using env: {'DISPLAY': ':0', 20:06:27 INFO - 'HOME': '/home/cltbld', 20:06:27 INFO - 'LANG': 'en_US.UTF-8', 20:06:27 INFO - 'LANGUAGE': 'en_US:en', 20:06:27 INFO - 'LOGNAME': 'cltbld', 20:06:27 INFO - 'MAIL': '/var/mail/cltbld', 20:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:27 INFO - 'MOZ_NO_REMOTE': '1', 20:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:27 INFO - 'NO_EM_RESTART': '1', 20:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:27 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:27 INFO - 'SHELL': '/bin/bash', 20:06:27 INFO - 'SHLVL': '1', 20:06:27 INFO - 'TERM': 'linux', 20:06:27 INFO - 'TMOUT': '86400', 20:06:27 INFO - 'USER': 'cltbld', 20:06:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:27 INFO - '_': '/tools/buildbot/bin/python'} 20:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:27 INFO - Downloading/unpacking psutil>=0.7.1 20:06:27 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 20:06:27 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 20:06:27 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 20:06:27 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 20:06:27 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 20:06:27 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 20:06:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:29 INFO - Installing collected packages: psutil 20:06:29 INFO - Running setup.py install for psutil 20:06:29 INFO - building 'psutil._psutil_linux' extension 20:06:29 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 20:06:29 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 20:06:29 INFO - building 'psutil._psutil_posix' extension 20:06:29 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 20:06:29 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 20:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:29 INFO - Successfully installed psutil 20:06:29 INFO - Cleaning up... 20:06:29 INFO - Return code: 0 20:06:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:06:29 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')]} 20:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:29 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')]} 20:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:29 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:29 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 20:06:29 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 20:06:29 INFO - Using env: {'DISPLAY': ':0', 20:06:29 INFO - 'HOME': '/home/cltbld', 20:06:29 INFO - 'LANG': 'en_US.UTF-8', 20:06:29 INFO - 'LANGUAGE': 'en_US:en', 20:06:29 INFO - 'LOGNAME': 'cltbld', 20:06:29 INFO - 'MAIL': '/var/mail/cltbld', 20:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:29 INFO - 'MOZ_NO_REMOTE': '1', 20:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:29 INFO - 'NO_EM_RESTART': '1', 20:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:29 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:29 INFO - 'SHELL': '/bin/bash', 20:06:29 INFO - 'SHLVL': '1', 20:06:29 INFO - 'TERM': 'linux', 20:06:29 INFO - 'TMOUT': '86400', 20:06:29 INFO - 'USER': 'cltbld', 20:06:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:29 INFO - '_': '/tools/buildbot/bin/python'} 20:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:06:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:06:31 INFO - Installing collected packages: mozsystemmonitor 20:06:31 INFO - Running setup.py install for mozsystemmonitor 20:06:32 INFO - Successfully installed mozsystemmonitor 20:06:32 INFO - Cleaning up... 20:06:32 INFO - Return code: 0 20:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:06:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:06:32 INFO - Using env: {'DISPLAY': ':0', 20:06:32 INFO - 'HOME': '/home/cltbld', 20:06:32 INFO - 'LANG': 'en_US.UTF-8', 20:06:32 INFO - 'LANGUAGE': 'en_US:en', 20:06:32 INFO - 'LOGNAME': 'cltbld', 20:06:32 INFO - 'MAIL': '/var/mail/cltbld', 20:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:32 INFO - 'MOZ_NO_REMOTE': '1', 20:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:32 INFO - 'NO_EM_RESTART': '1', 20:06:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:32 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:32 INFO - 'SHELL': '/bin/bash', 20:06:32 INFO - 'SHLVL': '1', 20:06:32 INFO - 'TERM': 'linux', 20:06:32 INFO - 'TMOUT': '86400', 20:06:32 INFO - 'USER': 'cltbld', 20:06:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:32 INFO - '_': '/tools/buildbot/bin/python'} 20:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:32 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:06:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:34 INFO - Downloading docopt-0.6.1.tar.gz 20:06:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:34 INFO - Running setup.py install for blobuploader 20:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:06:35 INFO - Running setup.py install for requests 20:06:35 INFO - Running setup.py install for docopt 20:06:35 INFO - Successfully installed blobuploader requests docopt 20:06:35 INFO - Cleaning up... 20:06:35 INFO - Return code: 0 20:06:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:35 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:35 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 20:06:35 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 20:06:35 INFO - Using env: {'DISPLAY': ':0', 20:06:35 INFO - 'HOME': '/home/cltbld', 20:06:35 INFO - 'LANG': 'en_US.UTF-8', 20:06:35 INFO - 'LANGUAGE': 'en_US:en', 20:06:35 INFO - 'LOGNAME': 'cltbld', 20:06:35 INFO - 'MAIL': '/var/mail/cltbld', 20:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:35 INFO - 'MOZ_NO_REMOTE': '1', 20:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:35 INFO - 'NO_EM_RESTART': '1', 20:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:35 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:35 INFO - 'SHELL': '/bin/bash', 20:06:35 INFO - 'SHLVL': '1', 20:06:35 INFO - 'TERM': 'linux', 20:06:35 INFO - 'TMOUT': '86400', 20:06:35 INFO - 'USER': 'cltbld', 20:06:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:35 INFO - '_': '/tools/buildbot/bin/python'} 20:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:35 INFO - Running setup.py (path:/tmp/pip-O1Sw6W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:35 INFO - Running setup.py (path:/tmp/pip-Io7m5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:35 INFO - Running setup.py (path:/tmp/pip-Sgxeje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:36 INFO - Running setup.py (path:/tmp/pip-Gi6kER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:36 INFO - Running setup.py (path:/tmp/pip-YnF3FI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:36 INFO - Running setup.py (path:/tmp/pip-iPgIHM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:36 INFO - Running setup.py (path:/tmp/pip-YEfYbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:36 INFO - Running setup.py (path:/tmp/pip-rWBtH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:36 INFO - Running setup.py (path:/tmp/pip-X4Zd0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:36 INFO - Running setup.py (path:/tmp/pip-uUmDRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:36 INFO - Running setup.py (path:/tmp/pip-LrEXX6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:36 INFO - Running setup.py (path:/tmp/pip-4I63Jr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:36 INFO - Running setup.py (path:/tmp/pip-NYFW0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:36 INFO - Running setup.py (path:/tmp/pip-roRVrD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:36 INFO - Running setup.py (path:/tmp/pip-u6T_eK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:36 INFO - Running setup.py (path:/tmp/pip-A9HStu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:36 INFO - Running setup.py (path:/tmp/pip-3JLbOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:37 INFO - Running setup.py install for manifestparser 20:06:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Running setup.py install for mozcrash 20:06:37 INFO - Running setup.py install for mozdebug 20:06:37 INFO - Running setup.py install for mozdevice 20:06:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Running setup.py install for mozfile 20:06:37 INFO - Running setup.py install for mozhttpd 20:06:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Running setup.py install for mozinfo 20:06:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Running setup.py install for mozInstall 20:06:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:06:37 INFO - Running setup.py install for mozleak 20:06:37 INFO - Running setup.py install for mozlog 20:06:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Running setup.py install for moznetwork 20:06:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Running setup.py install for mozprocess 20:06:38 INFO - Running setup.py install for mozprofile 20:06:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Running setup.py install for mozrunner 20:06:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Running setup.py install for mozscreenshot 20:06:38 INFO - Running setup.py install for moztest 20:06:38 INFO - Running setup.py install for mozversion 20:06:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:06:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:38 INFO - Cleaning up... 20:06:38 INFO - Return code: 0 20:06:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:38 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:38 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 20:06:38 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 20:06:38 INFO - Using env: {'DISPLAY': ':0', 20:06:38 INFO - 'HOME': '/home/cltbld', 20:06:38 INFO - 'LANG': 'en_US.UTF-8', 20:06:38 INFO - 'LANGUAGE': 'en_US:en', 20:06:38 INFO - 'LOGNAME': 'cltbld', 20:06:38 INFO - 'MAIL': '/var/mail/cltbld', 20:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:38 INFO - 'MOZ_NO_REMOTE': '1', 20:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:38 INFO - 'NO_EM_RESTART': '1', 20:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:38 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:38 INFO - 'SHELL': '/bin/bash', 20:06:38 INFO - 'SHLVL': '1', 20:06:38 INFO - 'TERM': 'linux', 20:06:38 INFO - 'TMOUT': '86400', 20:06:38 INFO - 'USER': 'cltbld', 20:06:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:38 INFO - '_': '/tools/buildbot/bin/python'} 20:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:39 INFO - Running setup.py (path:/tmp/pip-2GVca7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:39 INFO - Running setup.py (path:/tmp/pip-_J38Zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:39 INFO - Running setup.py (path:/tmp/pip-6yKhIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:39 INFO - Running setup.py (path:/tmp/pip-aRLubc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:39 INFO - Running setup.py (path:/tmp/pip-oRglMd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:39 INFO - Running setup.py (path:/tmp/pip-FA4NwG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:39 INFO - Running setup.py (path:/tmp/pip-XSbn4U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:39 INFO - Running setup.py (path:/tmp/pip-n5ePwo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:39 INFO - Running setup.py (path:/tmp/pip-GFUWv7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:39 INFO - Running setup.py (path:/tmp/pip-_JSpma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:39 INFO - Running setup.py (path:/tmp/pip-V7kFfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:39 INFO - Running setup.py (path:/tmp/pip-MqrqqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:39 INFO - Running setup.py (path:/tmp/pip-tJLkui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:06:39 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)) 20:06:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:39 INFO - Running setup.py (path:/tmp/pip-H4pFEb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:40 INFO - Running setup.py (path:/tmp/pip-q1kl4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:40 INFO - Running setup.py (path:/tmp/pip-O1iI6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:06:40 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)) 20:06:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:40 INFO - Running setup.py (path:/tmp/pip-SMibWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:06:40 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)) 20:06:40 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)) 20:06:40 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)) 20:06:40 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)) 20:06:40 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)) 20:06:40 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)) 20:06:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:40 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 20:06:40 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 20:06:40 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 20:06:40 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 20:06:40 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 20:06:40 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 20:06:42 INFO - Downloading blessings-1.6.tar.gz 20:06:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:42 INFO - Installing collected packages: blessings 20:06:42 INFO - Running setup.py install for blessings 20:06:42 INFO - Successfully installed blessings 20:06:42 INFO - Cleaning up... 20:06:42 INFO - Return code: 0 20:06:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:06:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:06:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:06:42 INFO - Reading from file tmpfile_stdout 20:06:42 INFO - Current package versions: 20:06:42 INFO - argparse == 1.2.1 20:06:42 INFO - blessings == 1.6 20:06:42 INFO - blobuploader == 1.2.4 20:06:42 INFO - docopt == 0.6.1 20:06:42 INFO - manifestparser == 1.1 20:06:42 INFO - mozInstall == 1.12 20:06:42 INFO - mozcrash == 0.16 20:06:42 INFO - mozdebug == 0.1 20:06:42 INFO - mozdevice == 0.48 20:06:42 INFO - mozfile == 1.2 20:06:42 INFO - mozhttpd == 0.7 20:06:42 INFO - mozinfo == 0.9 20:06:42 INFO - mozleak == 0.1 20:06:42 INFO - mozlog == 3.1 20:06:42 INFO - moznetwork == 0.27 20:06:42 INFO - mozprocess == 0.22 20:06:42 INFO - mozprofile == 0.28 20:06:42 INFO - mozrunner == 6.11 20:06:42 INFO - mozscreenshot == 0.1 20:06:42 INFO - mozsystemmonitor == 0.0 20:06:42 INFO - moztest == 0.7 20:06:42 INFO - mozversion == 1.4 20:06:42 INFO - psutil == 3.1.1 20:06:42 INFO - requests == 1.2.3 20:06:42 INFO - wsgiref == 0.1.2 20:06:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:42 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 20:06:42 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 20:06:42 INFO - Using env: {'DISPLAY': ':0', 20:06:42 INFO - 'HOME': '/home/cltbld', 20:06:42 INFO - 'LANG': 'en_US.UTF-8', 20:06:42 INFO - 'LANGUAGE': 'en_US:en', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MAIL': '/var/mail/cltbld', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SHLVL': '1', 20:06:42 INFO - 'TERM': 'linux', 20:06:42 INFO - 'TMOUT': '86400', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - '_': '/tools/buildbot/bin/python'} 20:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 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)) 20:06:42 INFO - Cleaning up... 20:06:42 INFO - Return code: 0 20:06:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 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 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06:42 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 20:06:42 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 20:06:42 INFO - Using env: {'DISPLAY': ':0', 20:06:42 INFO - 'HOME': '/home/cltbld', 20:06:42 INFO - 'LANG': 'en_US.UTF-8', 20:06:42 INFO - 'LANGUAGE': 'en_US:en', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MAIL': '/var/mail/cltbld', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SHLVL': '1', 20:06:42 INFO - 'TERM': 'linux', 20:06:42 INFO - 'TMOUT': '86400', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - '_': '/tools/buildbot/bin/python'} 20:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:42 INFO - Downloading/unpacking jsonschema 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:42 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 20:06:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:44 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:44 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 20:06:44 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 20:06:44 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 20:06:44 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 20:06:44 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 20:06:44 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 20:06:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:45 INFO - warning: no files found matching '*.txt' 20:06:45 INFO - no previously-included directories found matching 'build' 20:06:45 INFO - no previously-included directories found matching 'dist' 20:06:45 INFO - no previously-included directories found matching '.git*' 20:06:45 INFO - Installing collected packages: jsonschema, functools32 20:06:45 INFO - Running setup.py install for functools32 20:06:45 INFO - warning: no files found matching '*.txt' 20:06:45 INFO - no previously-included directories found matching 'build' 20:06:45 INFO - no previously-included directories found matching 'dist' 20:06:45 INFO - no previously-included directories found matching '.git*' 20:06:45 INFO - Successfully installed jsonschema functools32 20:06:45 INFO - Cleaning up... 20:06:45 INFO - Return code: 0 20:06:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:06: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')]} 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0937f35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1672670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, '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': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', '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 20:06: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', 'flake8'] in /builds/slave/test-pgo/build 20:06: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 flake8 20:06:45 INFO - Using env: {'DISPLAY': ':0', 20:06:45 INFO - 'HOME': '/home/cltbld', 20:06:45 INFO - 'LANG': 'en_US.UTF-8', 20:06:45 INFO - 'LANGUAGE': 'en_US:en', 20:06:45 INFO - 'LOGNAME': 'cltbld', 20:06:45 INFO - 'MAIL': '/var/mail/cltbld', 20:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:45 INFO - 'MOZ_NO_REMOTE': '1', 20:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:45 INFO - 'NO_EM_RESTART': '1', 20:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:06:45 INFO - 'PWD': '/builds/slave/test-pgo', 20:06:45 INFO - 'SHELL': '/bin/bash', 20:06:45 INFO - 'SHLVL': '1', 20:06:45 INFO - 'TERM': 'linux', 20:06:45 INFO - 'TMOUT': '86400', 20:06:45 INFO - 'USER': 'cltbld', 20:06:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:45 INFO - '_': '/tools/buildbot/bin/python'} 20:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:45 INFO - Downloading/unpacking flake8 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 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 20:06:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:47 INFO - no previously-included directories found matching 'docs/_build' 20:06:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:48 INFO - Running setup.py install for pep8 20:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:48 INFO - no previously-included directories found matching 'docs/_build' 20:06:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:06:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:48 INFO - Cleaning up... 20:06:48 INFO - Return code: 0 20:06:48 INFO - Running post-action listener: _resource_record_post_action 20:06:48 INFO - Running post-action listener: _start_resource_monitoring 20:06:48 INFO - Starting resource monitoring. 20:06:48 INFO - ##### 20:06:48 INFO - ##### Running install step. 20:06:48 INFO - ##### 20:06:48 INFO - Running pre-action listener: _resource_record_pre_action 20:06:48 INFO - Running main action method: install 20:06:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:06:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:06:48 INFO - Reading from file tmpfile_stdout 20:06:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:06:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:06:48 INFO - Reading from file tmpfile_stdout 20:06:48 INFO - Output received: 20:06:48 INFO - Usage: mozinstall [options] installer 20:06:48 INFO - Options: 20:06:48 INFO - -h, --help show this help message and exit 20:06:48 INFO - -d DEST, --destination=DEST 20:06:48 INFO - Directory to install application into. [default: 20:06:48 INFO - "/builds/slave/test-pgo"] 20:06:48 INFO - --app=APP Application being installed. [default: firefox] 20:06:48 INFO - mkdir: /builds/slave/test-pgo/build/application 20:06:48 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'] 20:06:48 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 20:07:04 INFO - Reading from file tmpfile_stdout 20:07:04 INFO - Output received: 20:07:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:07:04 INFO - Running post-action listener: _resource_record_post_action 20:07:04 INFO - ##### 20:07:04 INFO - ##### Running run-tests step. 20:07:04 INFO - ##### 20:07:04 INFO - Running pre-action listener: _resource_record_pre_action 20:07:04 INFO - Running main action method: run_tests 20:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:07:04 INFO - Python 2.7.3 20:07:04 INFO - Return code: 0 20:07:04 INFO - grabbing minidump binary from tooltool 20:07:04 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')]} 20:07:04 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 0x17018c0>, '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 0x17027c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1702c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:07:04 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 20:07:04 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 20:07:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:04 INFO - Return code: 0 20:07:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:07:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:07:05 INFO - Return code: 0 20:07:05 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 20:07:05 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 20:07:05 INFO - Using env: {'DISPLAY': ':0', 20:07:05 INFO - 'HOME': '/home/cltbld', 20:07:05 INFO - 'LANG': 'en_US.UTF-8', 20:07:05 INFO - 'LANGUAGE': 'en_US:en', 20:07:05 INFO - 'LOGNAME': 'cltbld', 20:07:05 INFO - 'MAIL': '/var/mail/cltbld', 20:07:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:07:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:05 INFO - 'MOZ_NO_REMOTE': '1', 20:07:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:05 INFO - 'NO_EM_RESTART': '1', 20:07:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:07:05 INFO - 'PWD': '/builds/slave/test-pgo', 20:07:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:07:05 INFO - 'SHELL': '/bin/bash', 20:07:05 INFO - 'SHLVL': '1', 20:07:05 INFO - 'TERM': 'linux', 20:07:05 INFO - 'TMOUT': '86400', 20:07:05 INFO - 'USER': 'cltbld', 20:07:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307', 20:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:05 INFO - '_': '/tools/buildbot/bin/python'} 20:07:05 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:07:05 INFO - mozversion application_buildid: 20160302173009 20:07:05 INFO - mozversion application_changeset: 6a355b46c68b43c0df96978a25b36b661dd98737 20:07:05 INFO - mozversion application_display_name: Nightly 20:07:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:05 INFO - mozversion application_name: Firefox 20:07:05 INFO - mozversion application_remotingname: firefox 20:07:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:05 INFO - mozversion application_vendor: Mozilla 20:07:05 INFO - mozversion application_version: 47.0a1 20:07:05 INFO - mozversion platform_buildid: 20160302173009 20:07:05 INFO - mozversion platform_changeset: 6a355b46c68b43c0df96978a25b36b661dd98737 20:07:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:05 INFO - mozversion platform_version: 47.0a1 20:07:05 INFO - using testdate: 1456978025 20:07:05 INFO - actual date: 1456978025 20:07:05 INFO - starting webserver on 'localhost:38126' 20:07:05 INFO - SUITE-START | Running 2 tests 20:07:05 INFO - TEST-START | dromaeo_css 20:07:05 INFO - operating with platform_type : linux_ 20:07:05 INFO - Initialising browser for dromaeo_css test... 20:07:05 INFO - TEST-INFO | started process 22439 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgWpV38/profile http://localhost:38126/getInfo.html) 20:07:09 INFO - PROCESS | 22439 | __metrics Screen width/height:1600/1200 20:07:09 INFO - PROCESS | 22439 | colorDepth:24 20:07:09 INFO - PROCESS | 22439 | Browser inner width/height: 1024/697 20:07:09 INFO - PROCESS | 22439 | __metrics 20:07:11 INFO - PROCESS | 22439 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:11 INFO - TEST-INFO | 22439: exit 0 20:07:11 INFO - Browser initialized. 20:07:11 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:11 INFO - TEST-INFO | started process 22534 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgWpV38/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:23 INFO - PROCESS | 22534 | RSS: Main: 155205632 20:07:23 INFO - PROCESS | 22534 | 20:08:15 INFO - PROCESS | 22534 | 1456978095253 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] 20:10:23 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38126/tests/dromaeo/cssquery-ext.html) 20:10:24 INFO - PROCESS | 22534 | RSS: Main: 252923904 20:10:24 INFO - PROCESS | 22534 | 20:13:26 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-ext.html (next: http://localhost:38126/tests/dromaeo/cssquery-jquery.html) 20:13:26 INFO - PROCESS | 22534 | RSS: Main: 231534592 20:13:26 INFO - PROCESS | 22534 | 20:16:28 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38126/tests/dromaeo/cssquery-mootools.html) 20:16:29 INFO - PROCESS | 22534 | RSS: Main: 241950720 20:16:29 INFO - PROCESS | 22534 | 20:19:31 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38126/tests/dromaeo/cssquery-prototype.html) 20:19:31 INFO - PROCESS | 22534 | RSS: Main: 206286848 20:19:31 INFO - PROCESS | 22534 | 20:22:34 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38126/tests/dromaeo/cssquery-yui.html) 20:22:34 INFO - PROCESS | 22534 | RSS: Main: 217292800 20:22:34 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | Cycle 1(1): loaded http://localhost:38126/tests/dromaeo/cssquery-yui.html (next: http://localhost:38126/tests/dromaeo/cssquery-dojo.html) 20:25:37 INFO - PROCESS | 22534 | RSS: Main: 285437952 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | __start_tp_report 20:25:37 INFO - PROCESS | 22534 | _x_x_mozilla_page_load 20:25:37 INFO - PROCESS | 22534 | _x_x_mozilla_page_load_details 20:25:37 INFO - PROCESS | 22534 | |i|pagename|runs| 20:25:37 INFO - PROCESS | 22534 | |0;dojo.html;3079.0454958962714;3142.465780817261;3192.7445804335657;3194.2812867104903;3222.5971753530816;4969.826056088038;5051.065552872721;5053.494650534944;5056.367954005749;5070.41690205626;4882.438519570242;4926.45808961014;4983.700977941326;4984.37695288089;4984.4517103118715;4523.140603285366;4541.65937554683;4575.29082992135;4616.0075583749485;4796.880077998043;4718.764061796896;4769.785359658807;4774.7612619369065;4776.713397196162;4777.904441911177;4606.907861842761;4634;4693.507181745902;4716.504766999485;4722.05558888222;4483.170613436525;4485.551444855521;4493.5506449355125;4495.707778994355;4513.932291015604;4464.374987501752;4471.552844715535;4480.955190448119;4488.192125417424;4514.887127821798;4843.903121937541;4926;4983.152864013126;5009.949900500985;5017.573506251973;5406.324209473816;5431.375391829951;5433.4566543345745;5437.157240627709;5449.536789372908;5312.335958005249;5456.345238571357;5492;5493.148561972901;5526.171074338841;5119.104156772587;5146.871328216787;5202.843914682566;5204.375474942994;5204.76578553966;5501.229827824108;5502.2296878437055;5502.752376143083;5504.146857237135;5506.03644362243;5203.869903252374;5219.217117432339;5319.361676598755;5322.946770532322;5325.547328477122;5472.534834539029;5480.561555075664;5492.642978206404;5492.670439773547;5530.446955304437;5430.402655707869;5462.7268636568015;5462.863428414322;5466.535344495683;5469.863253418617;5197.194434862602;5402.621816472809;5468.207109969032;5490.039243132436;5497.917531237034;4089.3252613319064;4098.405731169023;4102.876913692594;4137.627613514798;4148.502179738391;3713.498677678479;3716.7026637868908;3720;3755.6995440364703;3762.2851658185405;4919.163742163769;4997.225430058346;5018.447970723218;5039.722815245197;5075.644704870623;5140.280360749498;5167.509086636764;5209.322788037531;5213.035588416155;5242.18746094356;4887.3890763654545;4926.064047830901;4927.113119638428;4927.556519913225;4998.2002879539095;4531.501534831166;4619.076184763061;4655.906881862344;4680.227762419231;4686.976565117221;5520.282363292747;5532.585056120726;5539.25220095282;5543.334799824047;5544.251526043932;5282.207668849704;5283.7093959831045;5286.048511268009;5351.732413379237;5351.732413379394;5501.697406642673;5527.198556209408;5549.750261238335;5561.277033985718;5639.689817060101;5207.4271830099415;5224.451432599674;5225.085610018155;5226.268322434787;5280.366356037146;5163.638545301793;5296.179092240709;5311.654742441729;5326.067938110893;5329.520343169133;5211.71335576547;5228.058949389147;5233.371995360581;5263.421023687468;5286.418493965583;5150.253213283978;5194.298769666198;5195.92206116901;5222.6083043771105;5244.056069907453;5099.5410413063;5122.206058061007;5129.58963282929;5137.794488220429;5180.637355385087;5334.093204155225;5334.73326333674;5358.490943360374;5359.14253719403;5403.405625381126;5230.555402790653;5244.213367994678;5244.318238628954;5245.344331958505;5246.239295302236 20:25:37 INFO - PROCESS | 22534 | |1;ext.html;506.7719526213205;526.2816255810815;529.4255732530205;538.5691446842525;555.3973938276968;28513.714862851364;36063.81968090159;36394.272114557694;36530.63469365305;36589;39789;40572;40699;40733.18533629326;40786.59213407865;7424.851502969937;8395.370347223938;8597.226249637532;9910.454924979123;10082.193424526056;10024.54889529973;10175.59297628094;10179;10188.962207558481;10189.235807314444;10199.337043092175;10294.073533381994;10317.32937359073;10318.742031449236;10319.43243121628;10392.428416437093;10496.632617858377;10500.107490863247;10502.842457363146;10504.422256775873;10197;10355.068043876086;10367.844482332772;10369.740756481073;10370;40277.19445611101;40612.39081413781;40738.38892416616;40767.961601919786;40782.388264176065;3308.503724441329;3334.5998480182293;3680.5468925426226;4063.6545893599077;4124.546299907008;30688;31105.688943110505;31307.373852522822;31458.37083258322;31662.05013849588;3880.708946828999;3991.1818077294083;3997.8400863965408;4031.9113839263528;4080.5715399882884;274597;275262;275337.999999998;276153;276263;56869.43130568641;57008.42991570031;57176;57221.427785722444;57377.71311143501;55031;55839.44160558424;55844.16233756497;65179;66143.66928165329;13705.177689338672;13978.370973306226;13996.650083747783;14035;14051.227182505061;10311.278210525192;10490;10490.475476226158;10494.68515944523;10505.579776808994;19662.70505942412;19927.60144797096;20005.799942000685;20016.49958751043;20024.199032038847;7725.922740772633;7991.440599158003;8028.438009339407;8132.861399404088;8155.184481551916;951.1867353412871;995.621663767778;1005.7133716890797;1020.9132223761063;1061.7239517725293;27750.583741243896;28175.71824281772;28201.858990705325;28588.428231435253;28738.425231495672;1022.805666923297;1053.3890343600692;1098.6264670012074;1114.6210288501948;1141.8801025892328;14708.411663533552;14785.778213326808;14876.70246595062;15097.773533397009;15169.317380717894;314111;314463;315184;318646;319186;50336.748316258185;51587.74206128946;51715.48284517182;51753.48246517562;51887;1150.7295785490403;1303.2831942431624;1318.6769241535694;1323.993380033113;1350.1156742333787;25145.622815657414;26370.604440933785;26707.19878403651;26782.464350713268;28351.432971340044;48021.75989120032;49225.50774492209;49239.26141107814;49273.75363123305;49287.26069109038;237633;243956;244292;244479;244500;38945;39881.00297492586;41766.79116604398;43157.13685726331;43432.131357373306;40413.191736164525;40475.3928691064;40480.1903961925;40656.59343406528;41204.58795412008;34859.4771078429;36033.81983090068;36610;36944;37080.62919370772;36051.278974420886;36279.81860090682;36350.63649363472;36388.81805591061;36942.076448089014;35648.4652730204;35664;36169.81915090408;36494.81752591326;36795.08012299714;30747;32240.67759322377;33164.83417582897;33230.50154247737;33309;24687.012519499018;24820.50358992774;25139.120130796065;25240.495190095728;25733.485330293664 20:25:37 INFO - PROCESS | 22534 | |2;jquery.html;352.9417646088397;360.3945371775417;360.9566851977762;368.62584476756115;370.9295233905558;16453.341866325347;16744.330226790928;18241.27034918605;18267.360642377487;18290.268389264445;16662;17331.740023899652;17398;17425.47723568295;17465.388711395102;4921.999999999991;5359.866003349908;5402.648827826179;5404.648697834628;5409.594280428964;3931.4889064421727;5307.310049693554;5564.86087847803;5755.39568345324;5778.682172480512;5730.742116604742;5740.282464691913;5747.224124743168;5752.626079304831;5752.856178595548;5490.835274941758;5704.543636509069;5704.714764261812;5706.087026075828;5729.255196824407;3495.598006229265;4807.254875494304;5006.998600279959;5009.148444764399;5110.029094472038;18992.5251868703;19073.80926190748;19367.51581210467;19424.708629370572;19428.320008799623;2061.494933741243;2063.938081857547;2178.68409080684;2303.6314189729565;2487.4900645367657;8000.439969202158;8089.271965523131;8154.469959452616;8728.563571821383;8733.606987685569;1771.645670865832;1800.918958646851;1857.4334827877492;1982.9702554461694;2090.174381119449;67574.32425675778;71037.93443098306;72197.27802721958;74187;75458.49083018364;14980.400783968737;15080.170590617621;15217.771733424008;15451.690966180613;15839.366425343087;24602;24794.132205372724;24812.25563233106;24823.875880620482;24956.750432495443;8078.23256790604;8224.588770561568;8539.871901921477;8670.176333248332;8706;7301.342879140902;7327.63361831917;7447.218042105609;7451.776446706607;7461.067366579177;7788.4548081634875;7850.6859725611475;7884.881726774103;7889.644965976545;7936.404769642185;2582.3156863431204;2935.427591619614;3049.6542427041377;3068.861901214451;3079.3533357994625;857.7298151082514;915.4141349536302;942.9811403771886;965.4593427680381;1047.423916845747;15874;16199.271032803552;16458.42395516151;16757.91621041887;16933.068681222652;942.5381563034064;948.151404492975;953.4374718915734;988.229181238635;1030.9793804123876;6142.539309551801;9438.244940404751;9479.47862867549;9584.37701549397;9638.90361096394;419593;422000;430095;431219;432330;75138;77050;77915.61042194866;78480.60759696279;78988;939.793245485992;974.4104816586005;978.8874279457954;984.4241118945354;988.8566157907063;14079.225642589756;14741;14761.92619036898;14825.481108161162;14942.178180200193;27425.588616170375;32225.838870805495;33355.332893342485;33616.49575256422;33708.32583348369;43720.78139609282;46419.76790116163;47385;47677.28484072672;47800.7609961948;7203.2076471589135;7218.169910460154;7235.3488186063505;7327.560346379234;7348.228436014356;8994.370394072352;9075.636974521209;11973.640790776291;12209.450574724337;12275.93862030684;10253.231007674603;10466.581336746445;10468.110210631878;10525.210609204187;10608.681739547827;10691;10804.783904322027;10821.188410869374;10860.782784344427;10998.450077495932;10923.344599324066;10960.835587466354;11146.777064458827;11173.608923687632;11348.54605815758;7293.307135822089;7362.5214361066355;7426.480146389701;7577.242275772379;7893.1317555070045;8222.83554328922;11040.116790656568;11153.553857845594;11192.776144477228;11361.318320900773 20:25:37 INFO - PROCESS | 22534 | |3;mootools.html;1316.5721140629287;1432.3840748478153;1443.559714287142;1597.8162511311202;1789.1412122181353;7096.396806271467;7315.158756742976;7317.048783658131;7325.816854578625;7329.926700732991;7112.573245605255;7212.026376439192;7245.637718114086;7250.238724933885;7265.200827908926;1874.8687591868575;2126.6809978503193;2140.957180856382;2177.150911144655;2194.4952660887925;2193.9232126875563;2202;2203.316971738758;2203.6143674856835;2204.1403852497538;2121.872687638739;2171.9782802172012;2172.0443005077796;2173.369722780392;2175.086463685256;2121.872687638739;2150.0862133593237;2151;2174.010825074587;2175.9347219583437;2150.634392153322;2165.566886622666;2173.793489618484;2176.684380764796;2184.71598692169;7358.926410735878;7477.551346919148;7491.32578067971;7500.137484189334;7501.062367204099;4371.9781401093105;4507.391502147201;4509.819607215707;4514.480834703985;4516.23224051912;2800.4679110969055;2867.240181351943;2908.171171216193;2909.5926570280176;2913.6357955255594;894.9105089491064;898.3935843305743;903.3811838890381;936.4053825820585;1872.896990665513;9794.16749576287;9814.803703925882;9834.901650983542;9864.950675246579;9872.950635246778;3823.636754508317;3846.9615303847163;3863.1887303666545;3916.353801622757;4049.6962727794944;7978.401619878532;8062.919370806334;8070.192980701883;8071.919280807234;8077.111517733045;3915.882523524299;4360.49854266757;4397.076613911115;4399.098184872094;4399.802008909607;3953.486046813896;4017.6183262590007;4024.0342317844093;4037.7577345359373;4084.81618327176;3238.0933338665213;3295.8352082395786;3308.9907578188404;3336.9499457508155;3385.7629965902643;970.6699722094522;1015.137133436573;1019.7603563162651;1027.8612387327764;1029.1818004686293;1320.2687901483173;1321.4714114354335;1353.2692346133174;1356;1366.549038817188;7150.353319806936;7255.310745479171;7277.9636101820215;7296.854062918712;7299.59852208123;446.3795324498949;451.0572902633446;451.5687518419901;452.14770158251275;453;5361.571074314045;5442.619016668795;5447.673139611636;5664.376918538957;5747.109198074305;8770.51762153075;8807;8950.104989500998;8959.820803584022;8961.731148065568;8319.334453243726;8718.433301835486;8793.428427152214;8822.51476168817;8827.470351778913;6758.324167583202;6900.930990690129;6904.585724856524;6909.7581584644295;6981.3367730065565;6878.931210688029;6891.793246202622;6989.545679530815;6991;7003.264657211123;7744.845103097794;7872.37021038327;7935.1271360151495;8026.919730802617;8058.355331573577;8071;8099.190080991853;8233.17668233172;8467.576621168793;8521.701740439055;5950.910736338872;6452.483801295791;6616.669166541557;6766.052752614736;6870;7109.360157585842;7123.180834204133;7158.498905076803;7160.606166660884;7173.390261827803;6308.621482711052;6369.777057802955;6455.515836312202;6535.248446428722;6642.535022548375;6338.619682819046;6388.041793730792;6483.578567393104;6510.153680021567;6563.310852360433;6685.364890335411;6716.5634233774645;6748.122744043243;6749.055132281386;6751.054852320777;6086.1175129606845;6236.314005459487;6256.687165641791;6291.559590828598;6313.589616674902;6169.84575385601;6180.505559555135;6217.440430361289;6265.27949285838;6280.717367718372 20:25:37 INFO - PROCESS | 22534 | |4;prototype.html;305.6271348954276;308.46173427369246;308.9289463423414;309.5032472881025;313.1622908719177;5813.883722325551;5861.384554621767;5908.881822363555;5946.583739138262;6001.33985261622;5823.155642431845;5830.621009634371;5858.033424484955;5861;5863.413658634135;4190.51809041961;4375.496817865955;4461.107778444308;4475.910481790363;4494.235979883411;4467.82128714851;4474.485434175062;4491.977540112295;4495.303227999665;4496.9775151124195;4428.250840917852;4442.97778511107;4443.22243607369;4447.11057788442;4459.375687403766;4177.874663760077;4294.248506511348;4392.582704643086;4408.493023302297;4414.889627759299;3797.9810100949594;3802.524684414448;3809.5619003814363;3814.141818090935;3822.3884178531302;5555.777768889239;5564.944350556483;5564.972175139139;5572.749226284827;5573.386927437979;5130.153524668425;5159.303494028296;5163.406208286057;5168.069747445458;5169.405518365398;6203.844903877394;6222.875542489171;6225.128482012522;6228.750849965996;6231.719572619243;4053.837846486137;4212.726172798758;4216.156768646283;4258;4264.466941632296;6389.584676996027;6418.03729440583;6445.903311450332;6448.290688024361;6455.515836312248;4243.172581346607;4245.3207486802585;4247.3628955656895;4247.68142389322;4249.638780703613;4295.055087880662;4295.098029413858;4296.806643701041;4297.72064815786;4302.247106756305;5047.091523525801;5058.822941197041;5059.367579052619;5061;5068.923966140511;6007.789727359609;6184.876302474016;6186.783462578788;6208.596441231305;6214.130021796952;1504.1501551623298;1525.3364786317986;1527.2745445913101;1527.3814105287377;1533.6319283372134;900.7703035725848;971.9562619682131;983.4885859353096;984.9803003940025;987.782687808681;5881.088431293157;5895.911561326498;5933.258342707161;5953.196318497034;5955.225820643289;6379.936200638027;6385.616862988236;6387.041943708388;6387.201599800025;6397.840053998687;5941.197938278364;5942.138389933435;5942.168096466498;5942.227510423617;5944.762209511658;3416.8120753358307;3450.447928331455;3452.7928324300624;3455.5335029771163;3455.7235421166247;6538.378854008862;6647.634380109141;6749.257581666013;6755.729770809211;6783.321667833276;6505.902411463831;6519.706613202417;6532.118164047888;6541.34586541342;6541.8691626168165;6714.589936113373;6720.059191713164;6722.899156512656;6723.2604413515455;6736.730530778812;6355.3326900674765;6355.491560675227;6362.904556431565;6368.203974503187;6415.166028416463;6103.8779224414375;6316.589421687576;6343.397377249154;6347.841303967438;6356.650384228912;6696.464282857457;6721.865562688621;6728.058071869844;6728.394444500019;6735.090762746966;4277.230098582285;4283.186194623012;4283.357496375568;4288.721233119837;4294.248506511411;6420.133282006869;6443.355664433519;6444.645544494911;6450.0969864218105;6451.1936007999;6134.539909506716;6181.938180618136;6189.84525386869;6192.256929168529;6196.349383314687;5937.703114844327;6092.482139018233;6182.6599537025895;6188.969055154876;6191.876162476815;6032.517398608188;6067.180930574316;6079.817605471843;6081.969590152021;6089.725962331794;6218.751249949952;6219.689015549295;6229.470495007975;6230.376962303733;6231.626102433868;5937.5249980000635;6022.915875142517;6079.3008803988105;6080.0575910733905;6095.969520152371 20:25:37 INFO - PROCESS | 22534 | |5;yui.html;718.9209186989431;798.4690181029615;804.2239239134234;818.6929901287021;848.8259906719121;13551.322433878304;13759.65600859979;13765.518206862762;13780.862191378083;13785.241811700353;12295;12317.93841030796;12319.753604927897;12342.197757145801;12360.50557977682;670.17568390879;806.7902345390212;808.1312588966855;819.1399031017438;820.4052062254877;825.7275099217244;826.8677011678133;827.3877330775213;828.846663367279;829.2122483640535;860.27736701171;867.1415298854121;869.6304070769897;870.3950754225816;871.2855458524012;706.099722853361;855.6064210463195;856.2379482260761;860.9397342186049;861.543382007537;629.9401556852138;634.403660559073;635.7711223959371;636.1793286660203;636.2714691678003;13319.73360532784;13357.33213339329;13363.331833408389;13379.331033448387;13379.397927093305;12122.090843186796;12176.330301833395;12627.684307892285;13368.33158342079;13425;10309.946182977936;10461.424621645807;10470.267081304311;10493.632722854663;10536.157107431387;3585.2650206707563;3592.7844329340323;3661.21283923955;3683.0424089736593;3742.850285988557;46290.76854615705;46326.30510542311;46995;47059.764701176275;47266;9702.95148524267;9935.112328657531;10030.197584193247;10116.898831011596;10262.384256944608;17517;17608.559786005197;17619;17623.911880440774;17646.117694115244;7214.350708436161;7297.233790452032;7317.451191160684;7371.262873712586;7452.21751716062;4422.557744225552;4431.778411079497;4540.545945405499;4701;4708.176069187878;3031.030070377502;3036.6052413186144;3038.3771326877936;3048.0703385467646;3061.3265081681993;523.853321070101;529.2854646227562;534.9465053494697;542.0649379819779;547.026293198108;611.541343992006;614.529884638252;631.5989346764745;633.3255083336232;645.7191121862005;7581.3934885209055;7829.256220659028;8000.399970002273;8043.919560804317;8107.432479726481;629.8079085878759;639.2329204954074;658.2989116590911;661.153723234261;661.5336187987457;3699.204670995749;3742.6257374262354;3796.772193668389;3861.942070868939;3879.592642772525;56052;57305;57380;57390.27829165132;57530.42469575335;48304.5169548307;49245.50754492481;49654;49841.75079124581;51001.489985100416;46571.30143047857;46757.532424676;46984.295235571495;47073.76463117662;47200.29199562009;7763.340116090196;7774.339181169664;7816.257455541714;7943.960280198562;7970.362371010189;34186.65813341835;34252.31495370129;34610.48084278688;35428;35446.822765886005;39928.201435970535;42187;44445.333319999576;44492.55507444884;44814;9947.701568952943;9995.350302230332;11674.416279185836;12117.81823272634;12228.75542489163;12090.45592948337;12344.75310493803;12353.505859765868;12550;12583.119181657195;11288;11969.222000569935;11986.76026479483;12091;12118.394080295773;11416.94291528537;11925.284482931052;11949;12292.139550231755;12348.320842353756;11767.76464470723;11966.880331196577;12015.577223788148;12119.333436661069;12165.087618428477;9321.673741419017;9581.129250554171;9691;9785.510724463891;9855.040676343835;8248.876266856121;9150.176484116462;9235.538223088954;9365.203957663402;9389.38968967015 20:25:37 INFO - PROCESS | 22534 | __end_tp_report 20:25:37 INFO - PROCESS | 22534 | __start_cc_report 20:25:37 INFO - PROCESS | 22534 | _x_x_mozilla_cycle_collect,803 20:25:37 INFO - PROCESS | 22534 | __end_cc_report 20:25:37 INFO - PROCESS | 22534 | __startTimestamp1456979137754__endTimestamp 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | ------- Summary: start ------- 20:25:37 INFO - PROCESS | 22534 | Number of tests: 6 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#0] dojo.html Cycles:165 Average:5002.20 Median:5195.92 stddev:533.76 (10.3%) stddev-sans-first:513.63 20:25:37 INFO - PROCESS | 22534 | Values: 3079.0 3142.5 3192.7 3194.3 3222.6 4969.8 5051.1 5053.5 5056.4 5070.4 4882.4 4926.5 4983.7 4984.4 4984.5 4523.1 4541.7 4575.3 4616.0 4796.9 4718.8 4769.8 4774.8 4776.7 4777.9 4606.9 4634.0 4693.5 4716.5 4722.1 4483.2 4485.6 4493.6 4495.7 4513.9 4464.4 4471.6 4481.0 4488.2 4514.9 4843.9 4926.0 4983.2 5009.9 5017.6 5406.3 5431.4 5433.5 5437.2 5449.5 5312.3 5456.3 5492.0 5493.1 5526.2 5119.1 5146.9 5202.8 5204.4 5204.8 5501.2 5502.2 5502.8 5504.1 5506.0 5203.9 5219.2 5319.4 5322.9 5325.5 5472.5 5480.6 5492.6 5492.7 5530.4 5430.4 5462.7 5462.9 5466.5 5469.9 5197.2 5402.6 5468.2 5490.0 5497.9 4089.3 4098.4 4102.9 4137.6 4148.5 3713.5 3716.7 3720.0 3755.7 3762.3 4919.2 4997.2 5018.4 5039.7 5075.6 5140.3 5167.5 5209.3 5213.0 5242.2 4887.4 4926.1 4927.1 4927.6 4998.2 4531.5 4619.1 4655.9 4680.2 4687.0 5520.3 5532.6 5539.3 5543.3 5544.3 5282.2 5283.7 5286.0 5351.7 5351.7 5501.7 5527.2 5549.8 5561.3 5639.7 5207.4 5224.5 5225.1 5226.3 5280.4 5163.6 5296.2 5311.7 5326.1 5329.5 5211.7 5228.1 5233.4 5263.4 5286.4 5150.3 5194.3 5195.9 5222.6 5244.1 5099.5 5122.2 5129.6 5137.8 5180.6 5334.1 5334.7 5358.5 5359.1 5403.4 5230.6 5244.2 5244.3 5245.3 5246.2 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#1] ext.html Cycles:180 Average:45328.36 Median:175713.34 stddev:72944.48 (41.5%) stddev-sans-first:73071.48 20:25:37 INFO - PROCESS | 22534 | Values: 506.8 526.3 529.4 538.6 555.4 28513.7 36063.8 36394.3 36530.6 36589.0 39789.0 40572.0 40699.0 40733.2 40786.6 7424.9 8395.4 8597.2 9910.5 10082.2 10024.5 10175.6 10179.0 10189.0 10189.2 10199.3 10294.1 10317.3 10318.7 10319.4 10392.4 10496.6 10500.1 10502.8 10504.4 10197.0 10355.1 10367.8 10369.7 10370.0 40277.2 40612.4 40738.4 40768.0 40782.4 3308.5 3334.6 3680.5 4063.7 4124.5 30688.0 31105.7 31307.4 31458.4 31662.1 3880.7 3991.2 3997.8 4031.9 4080.6 274597.0 275262.0 275338.0 276153.0 276263.0 56869.4 57008.4 57176.0 57221.4 57377.7 55031.0 55839.4 55844.2 65179.0 66143.7 13705.2 13978.4 13996.7 14035.0 14051.2 10311.3 10490.0 10490.5 10494.7 10505.6 19662.7 19927.6 20005.8 20016.5 20024.2 7725.9 7991.4 8028.4 8132.9 8155.2 951.2 995.6 1005.7 1020.9 1061.7 27750.6 28175.7 28201.9 28588.4 28738.4 1022.8 1053.4 1098.6 1114.6 1141.9 14708.4 14785.8 14876.7 15097.8 15169.3 314111.0 314463.0 315184.0 318646.0 319186.0 50336.7 51587.7 51715.5 51753.5 51887.0 1150.7 1303.3 1318.7 1324.0 1350.1 25145.6 26370.6 26707.2 26782.5 28351.4 48021.8 49225.5 49239.3 49273.8 49287.3 237633.0 243956.0 244292.0 244479.0 244500.0 38945.0 39881.0 41766.8 43157.1 43432.1 40413.2 40475.4 40480.2 40656.6 41204.6 34859.5 36033.8 36610.0 36944.0 37080.6 36051.3 36279.8 36350.6 36388.8 36942.1 35648.5 35664.0 36169.8 36494.8 36795.1 30747.0 32240.7 33164.8 33230.5 33309.0 24687.0 24820.5 25139.1 25240.5 25733.5 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#2] jquery.html Cycles:180 Average:25756.62 Median:238025.39 stddev:70204.81 (29.5%) stddev-sans-first:70375.84 20:25:37 INFO - PROCESS | 22534 | Values: 352.9 360.4 361.0 368.6 370.9 16453.3 16744.3 18241.3 18267.4 18290.3 16662.0 17331.7 17398.0 17425.5 17465.4 4922.0 5359.9 5402.6 5404.6 5409.6 3931.5 5307.3 5564.9 5755.4 5778.7 5730.7 5740.3 5747.2 5752.6 5752.9 5490.8 5704.5 5704.7 5706.1 5729.3 3495.6 4807.3 5007.0 5009.1 5110.0 18992.5 19073.8 19367.5 19424.7 19428.3 2061.5 2063.9 2178.7 2303.6 2487.5 8000.4 8089.3 8154.5 8728.6 8733.6 1771.6 1800.9 1857.4 1983.0 2090.2 67574.3 71037.9 72197.3 74187.0 75458.5 14980.4 15080.2 15217.8 15451.7 15839.4 24602.0 24794.1 24812.3 24823.9 24956.8 8078.2 8224.6 8539.9 8670.2 8706.0 7301.3 7327.6 7447.2 7451.8 7461.1 7788.5 7850.7 7884.9 7889.6 7936.4 2582.3 2935.4 3049.7 3068.9 3079.4 857.7 915.4 943.0 965.5 1047.4 15874.0 16199.3 16458.4 16757.9 16933.1 942.5 948.2 953.4 988.2 1031.0 6142.5 9438.2 9479.5 9584.4 9638.9 419593.0 422000.0 430095.0 431219.0 432330.0 75138.0 77050.0 77915.6 78480.6 78988.0 939.8 974.4 978.9 984.4 988.9 14079.2 14741.0 14761.9 14825.5 14942.2 27425.6 32225.8 33355.3 33616.5 33708.3 43720.8 46419.8 47385.0 47677.3 47800.8 7203.2 7218.2 7235.3 7327.6 7348.2 8994.4 9075.6 11973.6 12209.5 12275.9 10253.2 10466.6 10468.1 10525.2 10608.7 10691.0 10804.8 10821.2 10860.8 10998.5 10923.3 10960.8 11146.8 11173.6 11348.5 7293.3 7362.5 7426.5 7577.2 7893.1 8222.8 11040.1 11153.6 11192.8 11361.3 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#3] mootools.html Cycles:180 Average:5143.52 Median:6311.11 stddev:2667.33 (42.3%) stddev-sans-first:2659.30 20:25:37 INFO - PROCESS | 22534 | Values: 1316.6 1432.4 1443.6 1597.8 1789.1 7096.4 7315.2 7317.0 7325.8 7329.9 7112.6 7212.0 7245.6 7250.2 7265.2 1874.9 2126.7 2141.0 2177.2 2194.5 2193.9 2202.0 2203.3 2203.6 2204.1 2121.9 2172.0 2172.0 2173.4 2175.1 2121.9 2150.1 2151.0 2174.0 2175.9 2150.6 2165.6 2173.8 2176.7 2184.7 7358.9 7477.6 7491.3 7500.1 7501.1 4372.0 4507.4 4509.8 4514.5 4516.2 2800.5 2867.2 2908.2 2909.6 2913.6 894.9 898.4 903.4 936.4 1872.9 9794.2 9814.8 9834.9 9865.0 9873.0 3823.6 3847.0 3863.2 3916.4 4049.7 7978.4 8062.9 8070.2 8071.9 8077.1 3915.9 4360.5 4397.1 4399.1 4399.8 3953.5 4017.6 4024.0 4037.8 4084.8 3238.1 3295.8 3309.0 3336.9 3385.8 970.7 1015.1 1019.8 1027.9 1029.2 1320.3 1321.5 1353.3 1356.0 1366.5 7150.4 7255.3 7278.0 7296.9 7299.6 446.4 451.1 451.6 452.1 453.0 5361.6 5442.6 5447.7 5664.4 5747.1 8770.5 8807.0 8950.1 8959.8 8961.7 8319.3 8718.4 8793.4 8822.5 8827.5 6758.3 6900.9 6904.6 6909.8 6981.3 6878.9 6891.8 6989.5 6991.0 7003.3 7744.8 7872.4 7935.1 8026.9 8058.4 8071.0 8099.2 8233.2 8467.6 8521.7 5950.9 6452.5 6616.7 6766.1 6870.0 7109.4 7123.2 7158.5 7160.6 7173.4 6308.6 6369.8 6455.5 6535.2 6642.5 6338.6 6388.0 6483.6 6510.2 6563.3 6685.4 6716.6 6748.1 6749.1 6751.1 6086.1 6236.3 6256.7 6291.6 6313.6 6169.8 6180.5 6217.4 6265.3 6280.7 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#4] prototype.html Cycles:180 Average:5160.25 Median:5942.20 stddev:1590.21 (26.8%) stddev-sans-first:1552.36 20:25:37 INFO - PROCESS | 22534 | Values: 305.6 308.5 308.9 309.5 313.2 5813.9 5861.4 5908.9 5946.6 6001.3 5823.2 5830.6 5858.0 5861.0 5863.4 4190.5 4375.5 4461.1 4475.9 4494.2 4467.8 4474.5 4492.0 4495.3 4497.0 4428.3 4443.0 4443.2 4447.1 4459.4 4177.9 4294.2 4392.6 4408.5 4414.9 3798.0 3802.5 3809.6 3814.1 3822.4 5555.8 5564.9 5565.0 5572.7 5573.4 5130.2 5159.3 5163.4 5168.1 5169.4 6203.8 6222.9 6225.1 6228.8 6231.7 4053.8 4212.7 4216.2 4258.0 4264.5 6389.6 6418.0 6445.9 6448.3 6455.5 4243.2 4245.3 4247.4 4247.7 4249.6 4295.1 4295.1 4296.8 4297.7 4302.2 5047.1 5058.8 5059.4 5061.0 5068.9 6007.8 6184.9 6186.8 6208.6 6214.1 1504.2 1525.3 1527.3 1527.4 1533.6 900.8 972.0 983.5 985.0 987.8 5881.1 5895.9 5933.3 5953.2 5955.2 6379.9 6385.6 6387.0 6387.2 6397.8 5941.2 5942.1 5942.2 5942.2 5944.8 3416.8 3450.4 3452.8 3455.5 3455.7 6538.4 6647.6 6749.3 6755.7 6783.3 6505.9 6519.7 6532.1 6541.3 6541.9 6714.6 6720.1 6722.9 6723.3 6736.7 6355.3 6355.5 6362.9 6368.2 6415.2 6103.9 6316.6 6343.4 6347.8 6356.7 6696.5 6721.9 6728.1 6728.4 6735.1 4277.2 4283.2 4283.4 4288.7 4294.2 6420.1 6443.4 6444.6 6450.1 6451.2 6134.5 6181.9 6189.8 6192.3 6196.3 5937.7 6092.5 6182.7 6189.0 6191.9 6032.5 6067.2 6079.8 6082.0 6089.7 6218.8 6219.7 6229.5 6230.4 6231.6 5937.5 6022.9 6079.3 6080.1 6096.0 20:25:37 INFO - PROCESS | 22534 | 20:25:37 INFO - PROCESS | 22534 | [#5] yui.html Cycles:180 Average:13653.31 Median:25880.38 stddev:15687.48 (60.6%) stddev-sans-first:15701.41 20:25:37 INFO - PROCESS | 22534 | Values: 718.9 798.5 804.2 818.7 848.8 13551.3 13759.7 13765.5 13780.9 13785.2 12295.0 12317.9 12319.8 12342.2 12360.5 670.2 806.8 808.1 819.1 820.4 825.7 826.9 827.4 828.8 829.2 860.3 867.1 869.6 870.4 871.3 706.1 855.6 856.2 860.9 861.5 629.9 634.4 635.8 636.2 636.3 13319.7 13357.3 13363.3 13379.3 13379.4 12122.1 12176.3 12627.7 13368.3 13425.0 10309.9 10461.4 10470.3 10493.6 10536.2 3585.3 3592.8 3661.2 3683.0 3742.9 46290.8 46326.3 46995.0 47059.8 47266.0 9703.0 9935.1 10030.2 10116.9 10262.4 17517.0 17608.6 17619.0 17623.9 17646.1 7214.4 7297.2 7317.5 7371.3 7452.2 4422.6 4431.8 4540.5 4701.0 4708.2 3031.0 3036.6 3038.4 3048.1 3061.3 523.9 529.3 534.9 542.1 547.0 611.5 614.5 631.6 633.3 645.7 7581.4 7829.3 8000.4 8043.9 8107.4 629.8 639.2 658.3 661.2 661.5 3699.2 3742.6 3796.8 3861.9 3879.6 56052.0 57305.0 57380.0 57390.3 57530.4 48304.5 49245.5 49654.0 49841.8 51001.5 46571.3 46757.5 46984.3 47073.8 47200.3 7763.3 7774.3 7816.3 7944.0 7970.4 34186.7 34252.3 34610.5 35428.0 35446.8 39928.2 42187.0 44445.3 44492.6 44814.0 9947.7 9995.4 11674.4 12117.8 12228.8 12090.5 12344.8 12353.5 12550.0 12583.1 11288.0 11969.2 11986.8 12091.0 12118.4 11416.9 11925.3 11949.0 12292.1 12348.3 11767.8 11966.9 12015.6 12119.3 12165.1 9321.7 9581.1 9691.0 9785.5 9855.0 8248.9 9150.2 9235.5 9365.2 9389.4 20:25:37 INFO - PROCESS | 22534 | -------- Summary: end -------- 20:25:37 INFO - PROCESS | 22534 | 20:25:38 INFO - TEST-INFO | 22534: exit 0 20:25:38 INFO - TEST-OK | dromaeo_css | took 1112554ms 20:25:38 INFO - TEST-START | kraken 20:25:38 INFO - operating with platform_type : linux_ 20:25:38 INFO - Initialising browser for kraken test... 20:25:38 INFO - TEST-INFO | started process 22726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplgoHpq/profile http://localhost:38126/getInfo.html) 20:25:42 INFO - PROCESS | 22726 | __metrics Screen width/height:1600/1200 20:25:42 INFO - PROCESS | 22726 | colorDepth:24 20:25:42 INFO - PROCESS | 22726 | Browser inner width/height: 1024/697 20:25:42 INFO - PROCESS | 22726 | __metrics 20:25:43 INFO - PROCESS | 22726 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:44 INFO - TEST-INFO | 22726: exit 0 20:25:44 INFO - Browser initialized. 20:25:44 INFO - Running cycle 1/1 for kraken test... 20:25:44 INFO - TEST-INFO | started process 22808 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplgoHpq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:56 INFO - PROCESS | 22808 | RSS: Main: 152875008 20:25:56 INFO - PROCESS | 22808 | 20:25:58 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38126/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:59 INFO - PROCESS | 22808 | RSS: Main: 198815744 20:25:59 INFO - PROCESS | 22808 | 20:26:02 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38126/tests/kraken/driver.html?testName=audio-dft) 20:26:02 INFO - PROCESS | 22808 | RSS: Main: 187969536 20:26:02 INFO - PROCESS | 22808 | 20:26:05 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38126/tests/kraken/driver.html?testName=audio-fft) 20:26:06 INFO - PROCESS | 22808 | RSS: Main: 170360832 20:26:06 INFO - PROCESS | 22808 | 20:26:08 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38126/tests/kraken/driver.html?testName=audio-oscillator) 20:26:08 INFO - PROCESS | 22808 | RSS: Main: 173629440 20:26:08 INFO - PROCESS | 22808 | 20:26:10 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:11 INFO - PROCESS | 22808 | RSS: Main: 173682688 20:26:11 INFO - PROCESS | 22808 | 20:26:14 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38126/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:15 INFO - PROCESS | 22808 | RSS: Main: 174989312 20:26:15 INFO - PROCESS | 22808 | 20:26:18 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38126/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:19 INFO - PROCESS | 22808 | RSS: Main: 176320512 20:26:19 INFO - PROCESS | 22808 | 20:26:21 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38126/tests/kraken/driver.html?testName=json-parse-financial) 20:26:22 INFO - PROCESS | 22808 | RSS: Main: 175927296 20:26:22 INFO - PROCESS | 22808 | 20:26:23 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:24 INFO - PROCESS | 22808 | RSS: Main: 187445248 20:26:24 INFO - PROCESS | 22808 | 20:26:26 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:26 INFO - PROCESS | 22808 | RSS: Main: 185372672 20:26:26 INFO - PROCESS | 22808 | 20:26:28 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:29 INFO - PROCESS | 22808 | RSS: Main: 192671744 20:26:29 INFO - PROCESS | 22808 | 20:26:31 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:32 INFO - PROCESS | 22808 | RSS: Main: 199921664 20:26:32 INFO - PROCESS | 22808 | 20:26:35 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:35 INFO - PROCESS | 22808 | RSS: Main: 197160960 20:26:35 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | Cycle 1(1): loaded http://localhost:38126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38126/tests/kraken/driver.html?testName=ai-astar) 20:26:37 INFO - PROCESS | 22808 | RSS: Main: 257548288 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | __start_tp_report 20:26:37 INFO - PROCESS | 22808 | _x_x_mozilla_page_load 20:26:37 INFO - PROCESS | 22808 | _x_x_mozilla_page_load_details 20:26:37 INFO - PROCESS | 22808 | |i|pagename|runs| 20:26:37 INFO - PROCESS | 22808 | |0;ai-astar;110;110;105;110;111;110;100;111;110;109 20:26:37 INFO - PROCESS | 22808 | |1;audio-beat-detection;155;129;154;182;127;153;155;128;173;133 20:26:37 INFO - PROCESS | 22808 | |2;audio-dft;162;162;161;160;161;160;159;163;161;161 20:26:37 INFO - PROCESS | 22808 | |3;audio-fft;77;78;129;94;76;72;73;114;100;72 20:26:37 INFO - PROCESS | 22808 | |4;audio-oscillator;93;94;141;93;94;94;145;92;93;147 20:26:37 INFO - PROCESS | 22808 | |5;imaging-gaussian-blur;117;117;117;116;117;116;116;117;117;117 20:26:37 INFO - PROCESS | 22808 | |6;imaging-darkroom;146;145;145;145;147;144;145;145;145;144 20:26:37 INFO - PROCESS | 22808 | |7;imaging-desaturate;96;96;96;97;95;95;96;96;95;96 20:26:37 INFO - PROCESS | 22808 | |8;json-parse-financial;55;56;56;57;58;56;57;63;53;53 20:26:37 INFO - PROCESS | 22808 | |9;json-stringify-tinderbox;67;68;68;68;68;68;68;69;68;69 20:26:37 INFO - PROCESS | 22808 | |10;stanford-crypto-aes;82;89;82;83;84;84;83;89;81;82 20:26:37 INFO - PROCESS | 22808 | |11;stanford-crypto-ccm;118;116;117;114;126;122;122;123;117;117 20:26:37 INFO - PROCESS | 22808 | |12;stanford-crypto-pbkdf2;152;143;150;160;152;147;150;151;149;146 20:26:37 INFO - PROCESS | 22808 | |13;stanford-crypto-sha256-iterative;69;68;69;68;70;69;66;68;67;68 20:26:37 INFO - PROCESS | 22808 | __end_tp_report 20:26:37 INFO - PROCESS | 22808 | __start_cc_report 20:26:37 INFO - PROCESS | 22808 | _x_x_mozilla_cycle_collect,1079 20:26:37 INFO - PROCESS | 22808 | __end_cc_report 20:26:37 INFO - PROCESS | 22808 | __startTimestamp1456979197693__endTimestamp 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | ------- Summary: start ------- 20:26:37 INFO - PROCESS | 22808 | Number of tests: 14 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.47 (3.2%) stddev-sans-first:3.64 20:26:37 INFO - PROCESS | 22808 | Values: 110.0 110.0 105.0 110.0 111.0 110.0 100.0 111.0 110.0 109.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:19.32 (12.5%) stddev-sans-first:20.36 20:26:37 INFO - PROCESS | 22808 | Values: 155.0 129.0 154.0 182.0 127.0 153.0 155.0 128.0 173.0 133.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 20:26:37 INFO - PROCESS | 22808 | Values: 162.0 162.0 161.0 160.0 161.0 160.0 159.0 163.0 161.0 161.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#3] audio-fft Cycles:10 Average:88.50 Median:74.50 stddev:20.10 (27.0%) stddev-sans-first:20.89 20:26:37 INFO - PROCESS | 22808 | Values: 77.0 78.0 129.0 94.0 76.0 72.0 73.0 114.0 100.0 72.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.71 (26.6%) stddev-sans-first:25.55 20:26:37 INFO - PROCESS | 22808 | Values: 93.0 94.0 141.0 93.0 94.0 94.0 145.0 92.0 93.0 147.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:26:37 INFO - PROCESS | 22808 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 20:26:37 INFO - PROCESS | 22808 | Values: 146.0 145.0 145.0 145.0 147.0 144.0 145.0 145.0 145.0 144.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 20:26:37 INFO - PROCESS | 22808 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 96.0 96.0 95.0 96.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:2.84 (5.0%) stddev-sans-first:2.96 20:26:37 INFO - PROCESS | 22808 | Values: 55.0 56.0 56.0 57.0 58.0 56.0 57.0 63.0 53.0 53.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 20:26:37 INFO - PROCESS | 22808 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 69.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.85 (3.4%) stddev-sans-first:2.93 20:26:37 INFO - PROCESS | 22808 | Values: 82.0 89.0 82.0 83.0 84.0 84.0 83.0 89.0 81.0 82.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:3.79 (3.2%) stddev-sans-first:4.00 20:26:37 INFO - PROCESS | 22808 | Values: 118.0 116.0 117.0 114.0 126.0 122.0 122.0 123.0 117.0 117.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:150.50 stddev:4.52 (3.0%) stddev-sans-first:4.74 20:26:37 INFO - PROCESS | 22808 | Values: 152.0 143.0 150.0 160.0 152.0 147.0 150.0 151.0 149.0 146.0 20:26:37 INFO - PROCESS | 22808 | 20:26:37 INFO - PROCESS | 22808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 20:26:37 INFO - PROCESS | 22808 | Values: 69.0 68.0 69.0 68.0 70.0 69.0 66.0 68.0 67.0 68.0 20:26:37 INFO - PROCESS | 22808 | -------- Summary: end -------- 20:26:37 INFO - PROCESS | 22808 | 20:26:38 INFO - TEST-INFO | 22808: exit 0 20:26:38 INFO - TEST-OK | kraken | took 60107ms 20:26:38 INFO - SUITE-END | took 1172s 20:26:38 INFO - Completed test suite (00:19:32) 20:26:38 INFO - Working with test: dromaeo_css 20:26:38 INFO - Generating results file: dromaeo_css 20:26:38 INFO - Working with test: kraken 20:26:38 INFO - Generating results file: kraken 20:26:38 INFO - javascript benchmark 20:26:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:26:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:26:38 INFO - process_Request line: dromaeo_css 6799.23 graph.html#tests=[[72,64,35]] 20:26:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:26:38 INFO - process_Request line: kraken 1519.00 graph.html#tests=[[232,64,35]] 20:26:38 INFO - RETURN: dromaeo_css: 6799.23 20:26:38 INFO - RETURN: kraken: 1519.00 20:26:38 INFO - javascript benchmark 20:26:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3079.0454958962714, 3142.465780817261, 3192.7445804335657, 3194.2812867104903, 3222.5971753530816, 4969.826056088038, 5051.065552872721, 5053.494650534944, 5056.367954005749, 5070.41690205626, 4882.438519570242, 4926.45808961014, 4983.700977941326, 4984.37695288089, 4984.4517103118715, 4523.140603285366, 4541.65937554683, 4575.29082992135, 4616.0075583749485, 4796.880077998043, 4718.764061796896, 4769.785359658807, 4774.7612619369065, 4776.713397196162, 4777.904441911177, 4606.907861842761, 4634.0, 4693.507181745902, 4716.504766999485, 4722.05558888222, 4483.170613436525, 4485.551444855521, 4493.5506449355125, 4495.707778994355, 4513.932291015604, 4464.374987501752, 4471.552844715535, 4480.955190448119, 4488.192125417424, 4514.887127821798, 4843.903121937541, 4926.0, 4983.152864013126, 5009.949900500985, 5017.573506251973, 5406.324209473816, 5431.375391829951, 5433.4566543345745, 5437.157240627709, 5449.536789372908, 5312.335958005249, 5456.345238571357, 5492.0, 5493.148561972901, 5526.171074338841, 5119.104156772587, 5146.871328216787, 5202.843914682566, 5204.375474942994, 5204.76578553966, 5501.229827824108, 5502.2296878437055, 5502.752376143083, 5504.146857237135, 5506.03644362243, 5203.869903252374, 5219.217117432339, 5319.361676598755, 5322.946770532322, 5325.547328477122, 5472.534834539029, 5480.561555075664, 5492.642978206404, 5492.670439773547, 5530.446955304437, 5430.402655707869, 5462.7268636568015, 5462.863428414322, 5466.535344495683, 5469.863253418617, 5197.194434862602, 5402.621816472809, 5468.207109969032, 5490.039243132436, 5497.917531237034, 4089.3252613319064, 4098.405731169023, 4102.876913692594, 4137.627613514798, 4148.502179738391, 3713.498677678479, 3716.7026637868908, 3720.0, 3755.6995440364703, 3762.2851658185405, 4919.163742163769, 4997.225430058346, 5018.447970723218, 5039.722815245197, 5075.644704870623, 5140.280360749498, 5167.509086636764, 5209.322788037531, 5213.035588416155, 5242.18746094356, 4887.3890763654545, 4926.064047830901, 4927.113119638428, 4927.556519913225, 4998.2002879539095, 4531.501534831166, 4619.076184763061, 4655.906881862344, 4680.227762419231, 4686.976565117221, 5520.282363292747, 5532.585056120726, 5539.25220095282, 5543.334799824047, 5544.251526043932, 5282.207668849704, 5283.7093959831045, 5286.048511268009, 5351.732413379237, 5351.732413379394, 5501.697406642673, 5527.198556209408, 5549.750261238335, 5561.277033985718, 5639.689817060101, 5207.4271830099415, 5224.451432599674, 5225.085610018155, 5226.268322434787, 5280.366356037146, 5163.638545301793, 5296.179092240709, 5311.654742441729, 5326.067938110893, 5329.520343169133, 5211.71335576547, 5228.058949389147, 5233.371995360581, 5263.421023687468, 5286.418493965583, 5150.253213283978, 5194.298769666198, 5195.92206116901, 5222.6083043771105, 5244.056069907453, 5099.5410413063, 5122.206058061007, 5129.58963282929, 5137.794488220429, 5180.637355385087, 5334.093204155225, 5334.73326333674, 5358.490943360374, 5359.14253719403, 5403.405625381126, 5230.555402790653, 5244.213367994678, 5244.318238628954, 5245.344331958505, 5246.239295302236], "unit": "score", "name": "dojo.html", "value": 4969.613705520318}, {"lowerIsBetter": false, "replicates": [506.7719526213205, 526.2816255810815, 529.4255732530205, 538.5691446842525, 555.3973938276968, 28513.714862851364, 36063.81968090159, 36394.272114557694, 36530.63469365305, 36589.0, 39789.0, 40572.0, 40699.0, 40733.18533629326, 40786.59213407865, 7424.851502969937, 8395.370347223938, 8597.226249637532, 9910.454924979123, 10082.193424526056, 10024.54889529973, 10175.59297628094, 10179.0, 10188.962207558481, 10189.235807314444, 10199.337043092175, 10294.073533381994, 10317.32937359073, 10318.742031449236, 10319.43243121628, 10392.428416437093, 10496.632617858377, 10500.107490863247, 10502.842457363146, 10504.422256775873, 10197.0, 10355.068043876086, 10367.844482332772, 10369.740756481073, 10370.0, 40277.19445611101, 40612.39081413781, 40738.38892416616, 40767.961601919786, 40782.388264176065, 3308.503724441329, 3334.5998480182293, 3680.5468925426226, 4063.6545893599077, 4124.546299907008, 30688.0, 31105.688943110505, 31307.373852522822, 31458.37083258322, 31662.05013849588, 3880.708946828999, 3991.1818077294083, 3997.8400863965408, 4031.9113839263528, 4080.5715399882884, 274597.0, 275262.0, 275337.999999998, 276153.0, 276263.0, 56869.43130568641, 57008.42991570031, 57176.0, 57221.427785722444, 57377.71311143501, 55031.0, 55839.44160558424, 55844.16233756497, 65179.0, 66143.66928165329, 13705.177689338672, 13978.370973306226, 13996.650083747783, 14035.0, 14051.227182505061, 10311.278210525192, 10490.0, 10490.475476226158, 10494.68515944523, 10505.579776808994, 19662.70505942412, 19927.60144797096, 20005.799942000685, 20016.49958751043, 20024.199032038847, 7725.922740772633, 7991.440599158003, 8028.438009339407, 8132.861399404088, 8155.184481551916, 951.1867353412871, 995.621663767778, 1005.7133716890797, 1020.9132223761063, 1061.7239517725293, 27750.583741243896, 28175.71824281772, 28201.858990705325, 28588.428231435253, 28738.425231495672, 1022.805666923297, 1053.3890343600692, 1098.6264670012074, 1114.6210288501948, 1141.8801025892328, 14708.411663533552, 14785.778213326808, 14876.70246595062, 15097.773533397009, 15169.317380717894, 314111.0, 314463.0, 315184.0, 318646.0, 319186.0, 50336.748316258185, 51587.74206128946, 51715.48284517182, 51753.48246517562, 51887.0, 1150.7295785490403, 1303.2831942431624, 1318.6769241535694, 1323.993380033113, 1350.1156742333787, 25145.622815657414, 26370.604440933785, 26707.19878403651, 26782.464350713268, 28351.432971340044, 48021.75989120032, 49225.50774492209, 49239.26141107814, 49273.75363123305, 49287.26069109038, 237633.0, 243956.0, 244292.0, 244479.0, 244500.0, 38945.0, 39881.00297492586, 41766.79116604398, 43157.13685726331, 43432.131357373306, 40413.191736164525, 40475.3928691064, 40480.1903961925, 40656.59343406528, 41204.58795412008, 34859.4771078429, 36033.81983090068, 36610.0, 36944.0, 37080.62919370772, 36051.278974420886, 36279.81860090682, 36350.63649363472, 36388.81805591061, 36942.076448089014, 35648.4652730204, 35664.0, 36169.81915090408, 36494.81752591326, 36795.08012299714, 30747.0, 32240.67759322377, 33164.83417582897, 33230.50154247737, 33309.0, 24687.012519499018, 24820.50358992774, 25139.120130796065, 25240.495190095728, 25733.485330293664], "unit": "score", "name": "ext.html", "value": 18714.593223477994}, {"lowerIsBetter": false, "replicates": [352.9417646088397, 360.3945371775417, 360.9566851977762, 368.62584476756115, 370.9295233905558, 16453.341866325347, 16744.330226790928, 18241.27034918605, 18267.360642377487, 18290.268389264445, 16662.0, 17331.740023899652, 17398.0, 17425.47723568295, 17465.388711395102, 4921.999999999991, 5359.866003349908, 5402.648827826179, 5404.648697834628, 5409.594280428964, 3931.4889064421727, 5307.310049693554, 5564.86087847803, 5755.39568345324, 5778.682172480512, 5730.742116604742, 5740.282464691913, 5747.224124743168, 5752.626079304831, 5752.856178595548, 5490.835274941758, 5704.543636509069, 5704.714764261812, 5706.087026075828, 5729.255196824407, 3495.598006229265, 4807.254875494304, 5006.998600279959, 5009.148444764399, 5110.029094472038, 18992.5251868703, 19073.80926190748, 19367.51581210467, 19424.708629370572, 19428.320008799623, 2061.494933741243, 2063.938081857547, 2178.68409080684, 2303.6314189729565, 2487.4900645367657, 8000.439969202158, 8089.271965523131, 8154.469959452616, 8728.563571821383, 8733.606987685569, 1771.645670865832, 1800.918958646851, 1857.4334827877492, 1982.9702554461694, 2090.174381119449, 67574.32425675778, 71037.93443098306, 72197.27802721958, 74187.0, 75458.49083018364, 14980.400783968737, 15080.170590617621, 15217.771733424008, 15451.690966180613, 15839.366425343087, 24602.0, 24794.132205372724, 24812.25563233106, 24823.875880620482, 24956.750432495443, 8078.23256790604, 8224.588770561568, 8539.871901921477, 8670.176333248332, 8706.0, 7301.342879140902, 7327.63361831917, 7447.218042105609, 7451.776446706607, 7461.067366579177, 7788.4548081634875, 7850.6859725611475, 7884.881726774103, 7889.644965976545, 7936.404769642185, 2582.3156863431204, 2935.427591619614, 3049.6542427041377, 3068.861901214451, 3079.3533357994625, 857.7298151082514, 915.4141349536302, 942.9811403771886, 965.4593427680381, 1047.423916845747, 15874.0, 16199.271032803552, 16458.42395516151, 16757.91621041887, 16933.068681222652, 942.5381563034064, 948.151404492975, 953.4374718915734, 988.229181238635, 1030.9793804123876, 6142.539309551801, 9438.244940404751, 9479.47862867549, 9584.37701549397, 9638.90361096394, 419593.0, 422000.0, 430095.0, 431219.0, 432330.0, 75138.0, 77050.0, 77915.61042194866, 78480.60759696279, 78988.0, 939.793245485992, 974.4104816586005, 978.8874279457954, 984.4241118945354, 988.8566157907063, 14079.225642589756, 14741.0, 14761.92619036898, 14825.481108161162, 14942.178180200193, 27425.588616170375, 32225.838870805495, 33355.332893342485, 33616.49575256422, 33708.32583348369, 43720.78139609282, 46419.76790116163, 47385.0, 47677.28484072672, 47800.7609961948, 7203.2076471589135, 7218.169910460154, 7235.3488186063505, 7327.560346379234, 7348.228436014356, 8994.370394072352, 9075.636974521209, 11973.640790776291, 12209.450574724337, 12275.93862030684, 10253.231007674603, 10466.581336746445, 10468.110210631878, 10525.210609204187, 10608.681739547827, 10691.0, 10804.783904322027, 10821.188410869374, 10860.782784344427, 10998.450077495932, 10923.344599324066, 10960.835587466354, 11146.777064458827, 11173.608923687632, 11348.54605815758, 7293.307135822089, 7362.5214361066355, 7426.480146389701, 7577.242275772379, 7893.1317555070045, 8222.83554328922, 11040.116790656568, 11153.553857845594, 11192.776144477228, 11361.318320900773], "unit": "score", "name": "jquery.html", "value": 8787.206989467437}, {"lowerIsBetter": false, "replicates": [1316.5721140629287, 1432.3840748478153, 1443.559714287142, 1597.8162511311202, 1789.1412122181353, 7096.396806271467, 7315.158756742976, 7317.048783658131, 7325.816854578625, 7329.926700732991, 7112.573245605255, 7212.026376439192, 7245.637718114086, 7250.238724933885, 7265.200827908926, 1874.8687591868575, 2126.6809978503193, 2140.957180856382, 2177.150911144655, 2194.4952660887925, 2193.9232126875563, 2202.0, 2203.316971738758, 2203.6143674856835, 2204.1403852497538, 2121.872687638739, 2171.9782802172012, 2172.0443005077796, 2173.369722780392, 2175.086463685256, 2121.872687638739, 2150.0862133593237, 2151.0, 2174.010825074587, 2175.9347219583437, 2150.634392153322, 2165.566886622666, 2173.793489618484, 2176.684380764796, 2184.71598692169, 7358.926410735878, 7477.551346919148, 7491.32578067971, 7500.137484189334, 7501.062367204099, 4371.9781401093105, 4507.391502147201, 4509.819607215707, 4514.480834703985, 4516.23224051912, 2800.4679110969055, 2867.240181351943, 2908.171171216193, 2909.5926570280176, 2913.6357955255594, 894.9105089491064, 898.3935843305743, 903.3811838890381, 936.4053825820585, 1872.896990665513, 9794.16749576287, 9814.803703925882, 9834.901650983542, 9864.950675246579, 9872.950635246778, 3823.636754508317, 3846.9615303847163, 3863.1887303666545, 3916.353801622757, 4049.6962727794944, 7978.401619878532, 8062.919370806334, 8070.192980701883, 8071.919280807234, 8077.111517733045, 3915.882523524299, 4360.49854266757, 4397.076613911115, 4399.098184872094, 4399.802008909607, 3953.486046813896, 4017.6183262590007, 4024.0342317844093, 4037.7577345359373, 4084.81618327176, 3238.0933338665213, 3295.8352082395786, 3308.9907578188404, 3336.9499457508155, 3385.7629965902643, 970.6699722094522, 1015.137133436573, 1019.7603563162651, 1027.8612387327764, 1029.1818004686293, 1320.2687901483173, 1321.4714114354335, 1353.2692346133174, 1356.0, 1366.549038817188, 7150.353319806936, 7255.310745479171, 7277.9636101820215, 7296.854062918712, 7299.59852208123, 446.3795324498949, 451.0572902633446, 451.5687518419901, 452.14770158251275, 453.0, 5361.571074314045, 5442.619016668795, 5447.673139611636, 5664.376918538957, 5747.109198074305, 8770.51762153075, 8807.0, 8950.104989500998, 8959.820803584022, 8961.731148065568, 8319.334453243726, 8718.433301835486, 8793.428427152214, 8822.51476168817, 8827.470351778913, 6758.324167583202, 6900.930990690129, 6904.585724856524, 6909.7581584644295, 6981.3367730065565, 6878.931210688029, 6891.793246202622, 6989.545679530815, 6991.0, 7003.264657211123, 7744.845103097794, 7872.37021038327, 7935.1271360151495, 8026.919730802617, 8058.355331573577, 8071.0, 8099.190080991853, 8233.17668233172, 8467.576621168793, 8521.701740439055, 5950.910736338872, 6452.483801295791, 6616.669166541557, 6766.052752614736, 6870.0, 7109.360157585842, 7123.180834204133, 7158.498905076803, 7160.606166660884, 7173.390261827803, 6308.621482711052, 6369.777057802955, 6455.515836312202, 6535.248446428722, 6642.535022548375, 6338.619682819046, 6388.041793730792, 6483.578567393104, 6510.153680021567, 6563.310852360433, 6685.364890335411, 6716.5634233774645, 6748.122744043243, 6749.055132281386, 6751.054852320777, 6086.1175129606845, 6236.314005459487, 6256.687165641791, 6291.559590828598, 6313.589616674902, 6169.84575385601, 6180.505559555135, 6217.440430361289, 6265.27949285838, 6280.717367718372], "unit": "score", "name": "mootools.html", "value": 4171.303161813727}, {"lowerIsBetter": false, "replicates": [305.6271348954276, 308.46173427369246, 308.9289463423414, 309.5032472881025, 313.1622908719177, 5813.883722325551, 5861.384554621767, 5908.881822363555, 5946.583739138262, 6001.33985261622, 5823.155642431845, 5830.621009634371, 5858.033424484955, 5861.0, 5863.413658634135, 4190.51809041961, 4375.496817865955, 4461.107778444308, 4475.910481790363, 4494.235979883411, 4467.82128714851, 4474.485434175062, 4491.977540112295, 4495.303227999665, 4496.9775151124195, 4428.250840917852, 4442.97778511107, 4443.22243607369, 4447.11057788442, 4459.375687403766, 4177.874663760077, 4294.248506511348, 4392.582704643086, 4408.493023302297, 4414.889627759299, 3797.9810100949594, 3802.524684414448, 3809.5619003814363, 3814.141818090935, 3822.3884178531302, 5555.777768889239, 5564.944350556483, 5564.972175139139, 5572.749226284827, 5573.386927437979, 5130.153524668425, 5159.303494028296, 5163.406208286057, 5168.069747445458, 5169.405518365398, 6203.844903877394, 6222.875542489171, 6225.128482012522, 6228.750849965996, 6231.719572619243, 4053.837846486137, 4212.726172798758, 4216.156768646283, 4258.0, 4264.466941632296, 6389.584676996027, 6418.03729440583, 6445.903311450332, 6448.290688024361, 6455.515836312248, 4243.172581346607, 4245.3207486802585, 4247.3628955656895, 4247.68142389322, 4249.638780703613, 4295.055087880662, 4295.098029413858, 4296.806643701041, 4297.72064815786, 4302.247106756305, 5047.091523525801, 5058.822941197041, 5059.367579052619, 5061.0, 5068.923966140511, 6007.789727359609, 6184.876302474016, 6186.783462578788, 6208.596441231305, 6214.130021796952, 1504.1501551623298, 1525.3364786317986, 1527.2745445913101, 1527.3814105287377, 1533.6319283372134, 900.7703035725848, 971.9562619682131, 983.4885859353096, 984.9803003940025, 987.782687808681, 5881.088431293157, 5895.911561326498, 5933.258342707161, 5953.196318497034, 5955.225820643289, 6379.936200638027, 6385.616862988236, 6387.041943708388, 6387.201599800025, 6397.840053998687, 5941.197938278364, 5942.138389933435, 5942.168096466498, 5942.227510423617, 5944.762209511658, 3416.8120753358307, 3450.447928331455, 3452.7928324300624, 3455.5335029771163, 3455.7235421166247, 6538.378854008862, 6647.634380109141, 6749.257581666013, 6755.729770809211, 6783.321667833276, 6505.902411463831, 6519.706613202417, 6532.118164047888, 6541.34586541342, 6541.8691626168165, 6714.589936113373, 6720.059191713164, 6722.899156512656, 6723.2604413515455, 6736.730530778812, 6355.3326900674765, 6355.491560675227, 6362.904556431565, 6368.203974503187, 6415.166028416463, 6103.8779224414375, 6316.589421687576, 6343.397377249154, 6347.841303967438, 6356.650384228912, 6696.464282857457, 6721.865562688621, 6728.058071869844, 6728.394444500019, 6735.090762746966, 4277.230098582285, 4283.186194623012, 4283.357496375568, 4288.721233119837, 4294.248506511411, 6420.133282006869, 6443.355664433519, 6444.645544494911, 6450.0969864218105, 6451.1936007999, 6134.539909506716, 6181.938180618136, 6189.84525386869, 6192.256929168529, 6196.349383314687, 5937.703114844327, 6092.482139018233, 6182.6599537025895, 6188.969055154876, 6191.876162476815, 6032.517398608188, 6067.180930574316, 6079.817605471843, 6081.969590152021, 6089.725962331794, 6218.751249949952, 6219.689015549295, 6229.470495007975, 6230.376962303733, 6231.626102433868, 5937.5249980000635, 6022.915875142517, 6079.3008803988105, 6080.0575910733905, 6095.969520152371], "unit": "score", "name": "prototype.html", "value": 4630.492091473545}, {"lowerIsBetter": false, "replicates": [718.9209186989431, 798.4690181029615, 804.2239239134234, 818.6929901287021, 848.8259906719121, 13551.322433878304, 13759.65600859979, 13765.518206862762, 13780.862191378083, 13785.241811700353, 12295.0, 12317.93841030796, 12319.753604927897, 12342.197757145801, 12360.50557977682, 670.17568390879, 806.7902345390212, 808.1312588966855, 819.1399031017438, 820.4052062254877, 825.7275099217244, 826.8677011678133, 827.3877330775213, 828.846663367279, 829.2122483640535, 860.27736701171, 867.1415298854121, 869.6304070769897, 870.3950754225816, 871.2855458524012, 706.099722853361, 855.6064210463195, 856.2379482260761, 860.9397342186049, 861.543382007537, 629.9401556852138, 634.403660559073, 635.7711223959371, 636.1793286660203, 636.2714691678003, 13319.73360532784, 13357.33213339329, 13363.331833408389, 13379.331033448387, 13379.397927093305, 12122.090843186796, 12176.330301833395, 12627.684307892285, 13368.33158342079, 13425.0, 10309.946182977936, 10461.424621645807, 10470.267081304311, 10493.632722854663, 10536.157107431387, 3585.2650206707563, 3592.7844329340323, 3661.21283923955, 3683.0424089736593, 3742.850285988557, 46290.76854615705, 46326.30510542311, 46995.0, 47059.764701176275, 47266.0, 9702.95148524267, 9935.112328657531, 10030.197584193247, 10116.898831011596, 10262.384256944608, 17517.0, 17608.559786005197, 17619.0, 17623.911880440774, 17646.117694115244, 7214.350708436161, 7297.233790452032, 7317.451191160684, 7371.262873712586, 7452.21751716062, 4422.557744225552, 4431.778411079497, 4540.545945405499, 4701.0, 4708.176069187878, 3031.030070377502, 3036.6052413186144, 3038.3771326877936, 3048.0703385467646, 3061.3265081681993, 523.853321070101, 529.2854646227562, 534.9465053494697, 542.0649379819779, 547.026293198108, 611.541343992006, 614.529884638252, 631.5989346764745, 633.3255083336232, 645.7191121862005, 7581.3934885209055, 7829.256220659028, 8000.399970002273, 8043.919560804317, 8107.432479726481, 629.8079085878759, 639.2329204954074, 658.2989116590911, 661.153723234261, 661.5336187987457, 3699.204670995749, 3742.6257374262354, 3796.772193668389, 3861.942070868939, 3879.592642772525, 56052.0, 57305.0, 57380.0, 57390.27829165132, 57530.42469575335, 48304.5169548307, 49245.50754492481, 49654.0, 49841.75079124581, 51001.489985100416, 46571.30143047857, 46757.532424676, 46984.295235571495, 47073.76463117662, 47200.29199562009, 7763.340116090196, 7774.339181169664, 7816.257455541714, 7943.960280198562, 7970.362371010189, 34186.65813341835, 34252.31495370129, 34610.48084278688, 35428.0, 35446.822765886005, 39928.201435970535, 42187.0, 44445.333319999576, 44492.55507444884, 44814.0, 9947.701568952943, 9995.350302230332, 11674.416279185836, 12117.81823272634, 12228.75542489163, 12090.45592948337, 12344.75310493803, 12353.505859765868, 12550.0, 12583.119181657195, 11288.0, 11969.222000569935, 11986.76026479483, 12091.0, 12118.394080295773, 11416.94291528537, 11925.284482931052, 11949.0, 12292.139550231755, 12348.320842353756, 11767.76464470723, 11966.880331196577, 12015.577223788148, 12119.333436661069, 12165.087618428477, 9321.673741419017, 9581.129250554171, 9691.0, 9785.510724463891, 9855.040676343835, 8248.876266856121, 9150.176484116462, 9235.538223088954, 9365.203957663402, 9389.38968967015], "unit": "score", "name": "yui.html", "value": 6258.357111133609}], "name": "dromaeo_css", "value": 6799.226843065947}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 111.0, 110.0, 100.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [155.0, 129.0, 154.0, 182.0, 127.0, 153.0, 155.0, 128.0, 173.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 129.0, 94.0, 76.0, 72.0, 73.0, 114.0, 100.0, 72.0], "unit": "score", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 141.0, 93.0, 94.0, 94.0, 145.0, 92.0, 93.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 147.0, 144.0, 145.0, 145.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 56.0, 57.0, 58.0, 56.0, 57.0, 63.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 82.0, 83.0, 84.0, 84.0, 83.0, 89.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 117.0, 114.0, 126.0, 122.0, 122.0, 123.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [152.0, 143.0, 150.0, 160.0, 152.0, 147.0, 150.0, 151.0, 149.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 69.0, 68.0, 70.0, 69.0, 66.0, 68.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1519.0000000000002}]} 20:26:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6799.23"}}} 20:26:39 INFO - Return code: 0 20:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:39 INFO - # TBPL SUCCESS # 20:26:39 INFO - Running post-action listener: _resource_record_post_action 20:26:39 INFO - Running post-run listener: _resource_record_post_run 20:26:40 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 546594816; Read time: 0; Write time: 567612 20:26:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252706816; Read time: 0; Write time: 314136 20:26:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293621760; Read time: 0; Write time: 253452 20:26:40 INFO - Running post-run listener: _upload_blobber_files 20:26:40 INFO - Blob upload gear active. 20:26:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:26:40 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 20:26:40 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'] 20:26:40 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 20:26:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:41 INFO - (blobuploader) - INFO - Done attempting. 20:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:42 INFO - (blobuploader) - INFO - Done attempting. 20:26:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:42 INFO - Return code: 0 20:26:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:26:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4918a5d9ab7ae9bda48398570302453a1db4964370de4e062ec05ff39ee243168dbcd2161b675d9e3e3e7837e5f22852e2093761c9bc97e8b398c06d021896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0120293526e49f9d45d8d3da50ca2355b08010439a5de0f93b4a39b4b13696c3dd87d28ff7219b57cd1ebaa6d025d18b7ddfb77abe3db225469213ffbaa43404"} 20:26:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:26:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:26:42 INFO - Contents: 20:26:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4918a5d9ab7ae9bda48398570302453a1db4964370de4e062ec05ff39ee243168dbcd2161b675d9e3e3e7837e5f22852e2093761c9bc97e8b398c06d021896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0120293526e49f9d45d8d3da50ca2355b08010439a5de0f93b4a39b4b13696c3dd87d28ff7219b57cd1ebaa6d025d18b7ddfb77abe3db225469213ffbaa43404"} 20:26:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:42 INFO - Copying logs to upload dir... 20:26:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:26:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.995476 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-03-02 20:26:42.028498) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 20:26:42.032501) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4918a5d9ab7ae9bda48398570302453a1db4964370de4e062ec05ff39ee243168dbcd2161b675d9e3e3e7837e5f22852e2093761c9bc97e8b398c06d021896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0120293526e49f9d45d8d3da50ca2355b08010439a5de0f93b4a39b4b13696c3dd87d28ff7219b57cd1ebaa6d025d18b7ddfb77abe3db225469213ffbaa43404"} build_url:https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/Fonu3_qqQgCBih2N3o9bFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df4918a5d9ab7ae9bda48398570302453a1db4964370de4e062ec05ff39ee243168dbcd2161b675d9e3e3e7837e5f22852e2093761c9bc97e8b398c06d021896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0120293526e49f9d45d8d3da50ca2355b08010439a5de0f93b4a39b4b13696c3dd87d28ff7219b57cd1ebaa6d025d18b7ddfb77abe3db225469213ffbaa43404"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 20:26:42.057744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:26:42.058190) ========= 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=00204705a9daa57ed339a427000001b9-1456973331.865956-1911887307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 20:26:42.141938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 20:26:42.142274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 20:26:42.142588) ========= ========= Total master_lag: 0.33 =========