builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1456858894.6 results: success (0) buildid: 20160301083100 builduid: a27a4a3b172142f2a38bca848430a0a3 revision: d6788a70c97b5ed250e65e4d83c435fc6791e3ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.604636) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.605023) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.605301) ========= 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.627557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.627824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.647374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.647663) ========= 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004793 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.704609) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.704871) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.705208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.705475) ========= 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 11:01:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-01 11:01:35 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.915013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.915708) ========= 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017951 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.971346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:34.972140) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6788a70c97b5ed250e65e4d83c435fc6791e3ff --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 d6788a70c97b5ed250e65e4d83c435fc6791e3ff --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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 11:01:35,203 truncating revision to first 12 chars 2016-03-01 11:01:35,203 Setting DEBUG logging. 2016-03-01 11:01:35,203 attempt 1/10 2016-03-01 11:01:35,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6788a70c97b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 11:01:35,479 unpacking tar archive at: fx-team-d6788a70c97b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:35.563051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:35.563390) ========= echo d6788a70c97b5ed250e65e4d83c435fc6791e3ff in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6788a70c97b5ed250e65e4d83c435fc6791e3ff'] 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6788a70c97b5ed250e65e4d83c435fc6791e3ff program finished with exit code 0 elapsedTime=0.004899 script_repo_revision: 'd6788a70c97b5ed250e65e4d83c435fc6791e3ff' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:35.649790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:35.653153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 11:01:35.666125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-03-01 11:01:35.666437) ========= /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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:01:35 INFO - MultiFileLogger online at 20160301 11:01:35 in /builds/slave/test-pgo 11:01:35 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 11:01:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:01:35 INFO - {'append_to_log': False, 11:01:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:01:35 INFO - 'blob_upload_branch': 'Fx-Team', 11:01:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:01:35 INFO - 'branch': 'Fx-Team', 11:01:35 INFO - 'buildbot_json_path': 'buildprops.json', 11:01:35 INFO - 'config_files': ('talos/linux_config.py',), 11:01:35 INFO - 'default_actions': ('clobber', 11:01:35 INFO - 'read-buildbot-config', 11:01:35 INFO - 'download-and-extract', 11:01:35 INFO - 'populate-webroot', 11:01:35 INFO - 'create-virtualenv', 11:01:35 INFO - 'install', 11:01:35 INFO - 'run-tests'), 11:01:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:01:35 INFO - 'download_minidump_stackwalk': True, 11:01:35 INFO - 'download_symbols': 'ondemand', 11:01:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:01:35 INFO - 'tooltool.py': '/tools/tooltool.py', 11:01:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:01:35 INFO - '/tools/misc-python/virtualenv.py')}, 11:01:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:01:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:01:35 INFO - 'installer_path': 'installer.exe', 11:01:35 INFO - 'log_level': 'info', 11:01:35 INFO - 'log_name': 'talos', 11:01:35 INFO - 'log_to_console': True, 11:01:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:01:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:01:35 INFO - 'opt_config_files': (), 11:01:35 INFO - 'pip_index': False, 11:01:35 INFO - 'sps_profile': False, 11:01:35 INFO - 'sps_profile_interval': 0, 11:01:35 INFO - 'suite': 'dromaeojs', 11:01:35 INFO - 'system_bits': '32', 11:01:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:01:35 INFO - 'title': 'talos-linux64-ix-016', 11:01:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:01:35 INFO - 'use_talos_json': True, 11:01:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:01:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:01:35 INFO - 'work_dir': 'build'} 11:01:35 INFO - ##### 11:01:35 INFO - ##### Running clobber step. 11:01:35 INFO - ##### 11:01:35 INFO - Running pre-action listener: _resource_record_pre_action 11:01:35 INFO - Running main action method: clobber 11:01:35 INFO - rmtree: /builds/slave/test-pgo/build 11:01:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:01:36 INFO - Running post-action listener: _resource_record_post_action 11:01:36 INFO - ##### 11:01:36 INFO - ##### Running read-buildbot-config step. 11:01:36 INFO - ##### 11:01:36 INFO - Running pre-action listener: _resource_record_pre_action 11:01:36 INFO - Running main action method: read_buildbot_config 11:01:36 INFO - Using buildbot properties: 11:01:36 INFO - { 11:01:36 INFO - "project": "", 11:01:36 INFO - "product": "firefox", 11:01:36 INFO - "script_repo_revision": "production", 11:01:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:01:36 INFO - "repository": "", 11:01:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:01:36 INFO - "buildid": "20160301083100", 11:01:36 INFO - "pgo_build": "True", 11:01:36 INFO - "basedir": "/builds/slave/test-pgo", 11:01:36 INFO - "buildnumber": 525, 11:01:36 INFO - "slavename": "talos-linux64-ix-016", 11:01:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:01:36 INFO - "platform": "ubuntu64_hw", 11:01:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:01:36 INFO - "branch": "fx-team", 11:01:36 INFO - "repo_path": "integration/fx-team", 11:01:36 INFO - "revision": "d6788a70c97b5ed250e65e4d83c435fc6791e3ff", 11:01:36 INFO - "stage_platform": "linux64-pgo", 11:01:36 INFO - "builduid": "a27a4a3b172142f2a38bca848430a0a3", 11:01:36 INFO - "slavebuilddir": "test" 11:01:36 INFO - } 11:01:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 11:01:36 INFO - Running post-action listener: _resource_record_post_action 11:01:36 INFO - ##### 11:01:36 INFO - ##### Running download-and-extract step. 11:01:36 INFO - ##### 11:01:36 INFO - Running pre-action listener: _resource_record_pre_action 11:01:36 INFO - Running main action method: download_and_extract 11:01:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:36 INFO - https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:37 INFO - Downloaded 1448 bytes. 11:01:37 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 11:01:37 INFO - Using the following test package requirements: 11:01:37 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:37 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:01:37 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:01:37 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'jsshell-linux-x86_64.zip'], 11:01:37 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:01:37 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:37 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:01:37 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:01:37 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:01:37 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 11:01:37 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 11:01:37 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:01:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:37 INFO - https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:38 INFO - Downloaded 23391403 bytes. 11:01:38 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'] 11:01:38 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 11:01:40 INFO - Return code: 0 11:01:40 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 11:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:40 INFO - https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 11:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:42 INFO - Downloaded 23391403 bytes. 11:01:42 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'] 11:01:42 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 11:01:44 INFO - Return code: 0 11:01:44 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')]} 11:01:44 INFO - https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 11:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:46 INFO - Downloaded 10713413 bytes. 11:01:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 11:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 11:01:46 INFO - Return code: 0 11:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:46 INFO - https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:01:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:01:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:01:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/alqfhVFGR6igwqYqMcWsAQ/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 11:01:48 INFO - Downloaded 56148874 bytes. 11:01:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:01:48 INFO - mkdir: /builds/slave/test-pgo/properties 11:01:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:01:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:01:48 INFO - Contents: 11:01:48 INFO - build_url:https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 11:01:48 INFO - Running post-action listener: _resource_record_post_action 11:01:48 INFO - Running post-action listener: set_extra_try_arguments 11:01:48 INFO - ##### 11:01:48 INFO - ##### Running populate-webroot step. 11:01:48 INFO - ##### 11:01:48 INFO - Running pre-action listener: _resource_record_pre_action 11:01:48 INFO - Running main action method: populate_webroot 11:01:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:01:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:01:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:01:48 INFO - '--tppagecycles', 11:01:48 INFO - '7'], 11:01:48 INFO - 'tests': ['tsvgm']}}, 11:01:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:01:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:01:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:01:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:01:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:01:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'tests': ['damp', 'tps']}, 11:01:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['damp', 'tps']}, 11:01:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:01:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:01:48 INFO - 'other': {'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'other_l64': {'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'other_nol64': {'tests': ['a11yr', 11:01:48 INFO - 'ts_paint', 11:01:48 INFO - 'tpaint', 11:01:48 INFO - 'sessionrestore', 11:01:48 INFO - 'sessionrestore_no_auto_restore']}, 11:01:48 INFO - 'svgr': {'tests': ['tsvgx', 11:01:48 INFO - 'tsvgr_opacity', 11:01:48 INFO - 'tart', 11:01:48 INFO - 'tscrollx', 11:01:48 INFO - 'cart']}, 11:01:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['tsvgx', 11:01:48 INFO - 'tsvgr_opacity', 11:01:48 INFO - 'tart', 11:01:48 INFO - 'tscrollx', 11:01:48 INFO - 'cart']}, 11:01:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'tests': ['tp5o']}, 11:01:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'talos_options': ['--e10s'], 11:01:48 INFO - 'tests': ['tp5o']}, 11:01:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'talos_options': ['--xperf_path', 11:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:48 INFO - 'tests': ['tp5n']}, 11:01:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:01:48 INFO - 'talos_options': ['--e10s', 11:01:48 INFO - '--xperf_path', 11:01:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:01:48 INFO - 'tests': ['tp5n']}}, 11:01:48 INFO - 'talos.zip': {'path': '', 11:01:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:01:48 INFO - Running post-action listener: _resource_record_post_action 11:01:48 INFO - ##### 11:01:48 INFO - ##### Running create-virtualenv step. 11:01:48 INFO - ##### 11:01:48 INFO - Running pre-action listener: _resource_record_pre_action 11:01:48 INFO - Running main action method: create_virtualenv 11:01:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:01:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 11:01:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:01:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:01:48 INFO - Using real prefix '/usr' 11:01:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:01:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:01:51 INFO - Installing pip.................done. 11:01:51 INFO - Return code: 0 11:01:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:01:51 INFO - Using env: {'DISPLAY': ':0', 11:01:51 INFO - 'HOME': '/home/cltbld', 11:01:51 INFO - 'LANG': 'en_US.UTF-8', 11:01:51 INFO - 'LANGUAGE': 'en_US:en', 11:01:51 INFO - 'LOGNAME': 'cltbld', 11:01:51 INFO - 'MAIL': '/var/mail/cltbld', 11:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:51 INFO - 'MOZ_NO_REMOTE': '1', 11:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:51 INFO - 'NO_EM_RESTART': '1', 11:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:51 INFO - 'SHELL': '/bin/bash', 11:01:51 INFO - 'SHLVL': '1', 11:01:51 INFO - 'TERM': 'linux', 11:01:51 INFO - 'TMOUT': '86400', 11:01:51 INFO - 'USER': 'cltbld', 11:01:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:51 INFO - '_': '/tools/buildbot/bin/python'} 11:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:01:51 INFO - Cleaning up... 11:01:51 INFO - Return code: 0 11:01:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 11:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:01:51 INFO - Using env: {'DISPLAY': ':0', 11:01:51 INFO - 'HOME': '/home/cltbld', 11:01:51 INFO - 'LANG': 'en_US.UTF-8', 11:01:51 INFO - 'LANGUAGE': 'en_US:en', 11:01:51 INFO - 'LOGNAME': 'cltbld', 11:01:51 INFO - 'MAIL': '/var/mail/cltbld', 11:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:51 INFO - 'MOZ_NO_REMOTE': '1', 11:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:51 INFO - 'NO_EM_RESTART': '1', 11:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:51 INFO - 'SHELL': '/bin/bash', 11:01:51 INFO - 'SHLVL': '1', 11:01:51 INFO - 'TERM': 'linux', 11:01:51 INFO - 'TMOUT': '86400', 11:01:51 INFO - 'USER': 'cltbld', 11:01:51 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:51 INFO - '_': '/tools/buildbot/bin/python'} 11:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:51 INFO - Downloading/unpacking psutil>=0.7.1 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:01:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:53 INFO - Installing collected packages: psutil 11:01:53 INFO - Running setup.py install for psutil 11:01:53 INFO - building 'psutil._psutil_linux' extension 11:01:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:01:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:01:54 INFO - building 'psutil._psutil_posix' extension 11:01:54 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 11:01:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:01:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:01:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:01:54 INFO - Successfully installed psutil 11:01:54 INFO - Cleaning up... 11:01:54 INFO - Return code: 0 11:01:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:01:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 11:01:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:01:54 INFO - Using env: {'DISPLAY': ':0', 11:01:54 INFO - 'HOME': '/home/cltbld', 11:01:54 INFO - 'LANG': 'en_US.UTF-8', 11:01:54 INFO - 'LANGUAGE': 'en_US:en', 11:01:54 INFO - 'LOGNAME': 'cltbld', 11:01:54 INFO - 'MAIL': '/var/mail/cltbld', 11:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:54 INFO - 'MOZ_NO_REMOTE': '1', 11:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:54 INFO - 'NO_EM_RESTART': '1', 11:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:54 INFO - 'SHELL': '/bin/bash', 11:01:54 INFO - 'SHLVL': '1', 11:01:54 INFO - 'TERM': 'linux', 11:01:54 INFO - 'TMOUT': '86400', 11:01:54 INFO - 'USER': 'cltbld', 11:01:54 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:54 INFO - '_': '/tools/buildbot/bin/python'} 11:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:01:56 INFO - Installing collected packages: mozsystemmonitor 11:01:56 INFO - Running setup.py install for mozsystemmonitor 11:01:56 INFO - Successfully installed mozsystemmonitor 11:01:56 INFO - Cleaning up... 11:01:56 INFO - Return code: 0 11:01:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 11:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:01:56 INFO - Using env: {'DISPLAY': ':0', 11:01:56 INFO - 'HOME': '/home/cltbld', 11:01:56 INFO - 'LANG': 'en_US.UTF-8', 11:01:56 INFO - 'LANGUAGE': 'en_US:en', 11:01:56 INFO - 'LOGNAME': 'cltbld', 11:01:56 INFO - 'MAIL': '/var/mail/cltbld', 11:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:56 INFO - 'MOZ_NO_REMOTE': '1', 11:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:56 INFO - 'NO_EM_RESTART': '1', 11:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:56 INFO - 'SHELL': '/bin/bash', 11:01:56 INFO - 'SHLVL': '1', 11:01:56 INFO - 'TERM': 'linux', 11:01:56 INFO - 'TMOUT': '86400', 11:01:56 INFO - 'USER': 'cltbld', 11:01:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:56 INFO - '_': '/tools/buildbot/bin/python'} 11:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:01:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - Downloading blobuploader-1.2.4.tar.gz 11:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:01:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:01:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:01:59 INFO - Downloading docopt-0.6.1.tar.gz 11:01:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:01:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:01:59 INFO - Running setup.py install for blobuploader 11:01:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:01:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:01:59 INFO - Running setup.py install for requests 11:01:59 INFO - Running setup.py install for docopt 11:01:59 INFO - Successfully installed blobuploader requests docopt 11:01:59 INFO - Cleaning up... 11:01:59 INFO - Return code: 0 11:01:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:01:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:01:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 11:01:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:01:59 INFO - Using env: {'DISPLAY': ':0', 11:01:59 INFO - 'HOME': '/home/cltbld', 11:01:59 INFO - 'LANG': 'en_US.UTF-8', 11:01:59 INFO - 'LANGUAGE': 'en_US:en', 11:01:59 INFO - 'LOGNAME': 'cltbld', 11:01:59 INFO - 'MAIL': '/var/mail/cltbld', 11:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:59 INFO - 'MOZ_NO_REMOTE': '1', 11:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:59 INFO - 'NO_EM_RESTART': '1', 11:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 11:01:59 INFO - 'SHELL': '/bin/bash', 11:01:59 INFO - 'SHLVL': '1', 11:01:59 INFO - 'TERM': 'linux', 11:01:59 INFO - 'TMOUT': '86400', 11:01:59 INFO - 'USER': 'cltbld', 11:01:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:59 INFO - '_': '/tools/buildbot/bin/python'} 11:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:00 INFO - Running setup.py (path:/tmp/pip-bSVN7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:00 INFO - Running setup.py (path:/tmp/pip-mQ7kxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:00 INFO - Running setup.py (path:/tmp/pip-0Z6nbN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:00 INFO - Running setup.py (path:/tmp/pip-RtnGGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:00 INFO - Running setup.py (path:/tmp/pip-xvfQwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:00 INFO - Running setup.py (path:/tmp/pip-qJfDxs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:00 INFO - Running setup.py (path:/tmp/pip-z3uwos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:00 INFO - Running setup.py (path:/tmp/pip-qUKChh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:00 INFO - Running setup.py (path:/tmp/pip-odpOE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:00 INFO - Running setup.py (path:/tmp/pip-DghUXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:00 INFO - Running setup.py (path:/tmp/pip-KxbiZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:00 INFO - Running setup.py (path:/tmp/pip-wCK9V3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:01 INFO - Running setup.py (path:/tmp/pip-BtUvLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:01 INFO - Running setup.py (path:/tmp/pip-UweIdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Running setup.py (path:/tmp/pip-esNxKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:01 INFO - Running setup.py (path:/tmp/pip-d6nGt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:01 INFO - Running setup.py (path:/tmp/pip-C2ARnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:02:01 INFO - Running setup.py install for manifestparser 11:02:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:02:01 INFO - Running setup.py install for mozcrash 11:02:01 INFO - Running setup.py install for mozdebug 11:02:01 INFO - Running setup.py install for mozdevice 11:02:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:02:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:02:01 INFO - Running setup.py install for mozfile 11:02:01 INFO - Running setup.py install for mozhttpd 11:02:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozinfo 11:02:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozInstall 11:02:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozleak 11:02:02 INFO - Running setup.py install for mozlog 11:02:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for moznetwork 11:02:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozprocess 11:02:02 INFO - Running setup.py install for mozprofile 11:02:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozrunner 11:02:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:02:02 INFO - Running setup.py install for mozscreenshot 11:02:02 INFO - Running setup.py install for moztest 11:02:03 INFO - Running setup.py install for mozversion 11:02:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:02:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:02:03 INFO - Cleaning up... 11:02:03 INFO - Return code: 0 11:02:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:03 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 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:02:03 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 11:02:03 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 11:02:03 INFO - Using env: {'DISPLAY': ':0', 11:02:03 INFO - 'HOME': '/home/cltbld', 11:02:03 INFO - 'LANG': 'en_US.UTF-8', 11:02:03 INFO - 'LANGUAGE': 'en_US:en', 11:02:03 INFO - 'LOGNAME': 'cltbld', 11:02:03 INFO - 'MAIL': '/var/mail/cltbld', 11:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:03 INFO - 'MOZ_NO_REMOTE': '1', 11:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:03 INFO - 'NO_EM_RESTART': '1', 11:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:03 INFO - 'SHELL': '/bin/bash', 11:02:03 INFO - 'SHLVL': '1', 11:02:03 INFO - 'TERM': 'linux', 11:02:03 INFO - 'TMOUT': '86400', 11:02:03 INFO - 'USER': 'cltbld', 11:02:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:03 INFO - '_': '/tools/buildbot/bin/python'} 11:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:03 INFO - Running setup.py (path:/tmp/pip-491kPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:03 INFO - Running setup.py (path:/tmp/pip-bbv8M9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:03 INFO - Running setup.py (path:/tmp/pip-8iNO2x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:03 INFO - Running setup.py (path:/tmp/pip-wnFzfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:03 INFO - Running setup.py (path:/tmp/pip-T1glQT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:03 INFO - Running setup.py (path:/tmp/pip-6Kr5gP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:03 INFO - Running setup.py (path:/tmp/pip-pHwxr2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:03 INFO - Running setup.py (path:/tmp/pip-Q53NAk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 11:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:03 INFO - Running setup.py (path:/tmp/pip-h_Zg4R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:04 INFO - Running setup.py (path:/tmp/pip-jN14eH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:04 INFO - Running setup.py (path:/tmp/pip-mNEUt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:02:04 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)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:04 INFO - Running setup.py (path:/tmp/pip-gNCmkN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:04 INFO - Running setup.py (path:/tmp/pip-4tqbu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:04 INFO - Running setup.py (path:/tmp/pip-PRiAIT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:04 INFO - Running setup.py (path:/tmp/pip-nIPXam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:04 INFO - Running setup.py (path:/tmp/pip-8M5Ekw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 11:02:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:04 INFO - Running setup.py (path:/tmp/pip-JJPLEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:02:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:06 INFO - Downloading blessings-1.6.tar.gz 11:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:02:06 INFO - Installing collected packages: blessings 11:02:06 INFO - Running setup.py install for blessings 11:02:06 INFO - Successfully installed blessings 11:02:06 INFO - Cleaning up... 11:02:06 INFO - Return code: 0 11:02:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:02:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:02:06 INFO - Reading from file tmpfile_stdout 11:02:06 INFO - Current package versions: 11:02:06 INFO - argparse == 1.2.1 11:02:06 INFO - blessings == 1.6 11:02:06 INFO - blobuploader == 1.2.4 11:02:06 INFO - docopt == 0.6.1 11:02:06 INFO - manifestparser == 1.1 11:02:06 INFO - mozInstall == 1.12 11:02:06 INFO - mozcrash == 0.16 11:02:06 INFO - mozdebug == 0.1 11:02:06 INFO - mozdevice == 0.48 11:02:06 INFO - mozfile == 1.2 11:02:06 INFO - mozhttpd == 0.7 11:02:06 INFO - mozinfo == 0.9 11:02:06 INFO - mozleak == 0.1 11:02:06 INFO - mozlog == 3.1 11:02:06 INFO - moznetwork == 0.27 11:02:06 INFO - mozprocess == 0.22 11:02:06 INFO - mozprofile == 0.28 11:02:06 INFO - mozrunner == 6.11 11:02:06 INFO - mozscreenshot == 0.1 11:02:06 INFO - mozsystemmonitor == 0.0 11:02:06 INFO - moztest == 0.7 11:02:06 INFO - mozversion == 1.4 11:02:06 INFO - psutil == 3.1.1 11:02:06 INFO - requests == 1.2.3 11:02:06 INFO - wsgiref == 0.1.2 11:02:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:02:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 11:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:02:06 INFO - Using env: {'DISPLAY': ':0', 11:02:06 INFO - 'HOME': '/home/cltbld', 11:02:06 INFO - 'LANG': 'en_US.UTF-8', 11:02:06 INFO - 'LANGUAGE': 'en_US:en', 11:02:06 INFO - 'LOGNAME': 'cltbld', 11:02:06 INFO - 'MAIL': '/var/mail/cltbld', 11:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:06 INFO - 'MOZ_NO_REMOTE': '1', 11:02:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:06 INFO - 'NO_EM_RESTART': '1', 11:02:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:06 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:06 INFO - 'SHELL': '/bin/bash', 11:02:06 INFO - 'SHLVL': '1', 11:02:06 INFO - 'TERM': 'linux', 11:02:06 INFO - 'TMOUT': '86400', 11:02:06 INFO - 'USER': 'cltbld', 11:02:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:06 INFO - '_': '/tools/buildbot/bin/python'} 11:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 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)) 11:02:07 INFO - Cleaning up... 11:02:07 INFO - Return code: 0 11:02:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:02:07 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')]} 11:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:07 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')]} 11:02:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:07 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 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:02:07 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 11:02:07 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 11:02:07 INFO - Using env: {'DISPLAY': ':0', 11:02:07 INFO - 'HOME': '/home/cltbld', 11:02:07 INFO - 'LANG': 'en_US.UTF-8', 11:02:07 INFO - 'LANGUAGE': 'en_US:en', 11:02:07 INFO - 'LOGNAME': 'cltbld', 11:02:07 INFO - 'MAIL': '/var/mail/cltbld', 11:02:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:07 INFO - 'MOZ_NO_REMOTE': '1', 11:02:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:07 INFO - 'NO_EM_RESTART': '1', 11:02:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:07 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:07 INFO - 'SHELL': '/bin/bash', 11:02:07 INFO - 'SHLVL': '1', 11:02:07 INFO - 'TERM': 'linux', 11:02:07 INFO - 'TMOUT': '86400', 11:02:07 INFO - 'USER': 'cltbld', 11:02:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:02:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:07 INFO - '_': '/tools/buildbot/bin/python'} 11:02:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:07 INFO - Downloading/unpacking jsonschema 11:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:02:09 INFO - Downloading/unpacking functools32 (from jsonschema) 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:02:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:02:09 INFO - warning: no files found matching '*.txt' 11:02:09 INFO - no previously-included directories found matching 'build' 11:02:09 INFO - no previously-included directories found matching 'dist' 11:02:09 INFO - no previously-included directories found matching '.git*' 11:02:09 INFO - Installing collected packages: jsonschema, functools32 11:02:09 INFO - Running setup.py install for functools32 11:02:09 INFO - warning: no files found matching '*.txt' 11:02:09 INFO - no previously-included directories found matching 'build' 11:02:09 INFO - no previously-included directories found matching 'dist' 11:02:09 INFO - no previously-included directories found matching '.git*' 11:02:09 INFO - Successfully installed jsonschema functools32 11:02:09 INFO - Cleaning up... 11:02:09 INFO - Return code: 0 11:02:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19efe48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, '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-1456853728.616877-1309763706', '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 11:02:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:02:09 INFO - Using env: {'DISPLAY': ':0', 11:02:09 INFO - 'HOME': '/home/cltbld', 11:02:09 INFO - 'LANG': 'en_US.UTF-8', 11:02:09 INFO - 'LANGUAGE': 'en_US:en', 11:02:09 INFO - 'LOGNAME': 'cltbld', 11:02:09 INFO - 'MAIL': '/var/mail/cltbld', 11:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:09 INFO - 'MOZ_NO_REMOTE': '1', 11:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:09 INFO - 'NO_EM_RESTART': '1', 11:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:09 INFO - 'SHELL': '/bin/bash', 11:02:09 INFO - 'SHLVL': '1', 11:02:09 INFO - 'TERM': 'linux', 11:02:09 INFO - 'TMOUT': '86400', 11:02:09 INFO - 'USER': 'cltbld', 11:02:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:09 INFO - '_': '/tools/buildbot/bin/python'} 11:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:09 INFO - Downloading/unpacking flake8 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:02:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:02:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:02:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 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 11:02:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:12 INFO - no previously-included directories found matching 'docs/_build' 11:02:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:02:12 INFO - Running setup.py install for pep8 11:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:02:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:02:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:02:12 INFO - no previously-included directories found matching 'docs/_build' 11:02:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:02:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:02:12 INFO - Cleaning up... 11:02:12 INFO - Return code: 0 11:02:12 INFO - Running post-action listener: _resource_record_post_action 11:02:12 INFO - Running post-action listener: _start_resource_monitoring 11:02:12 INFO - Starting resource monitoring. 11:02:12 INFO - ##### 11:02:12 INFO - ##### Running install step. 11:02:12 INFO - ##### 11:02:12 INFO - Running pre-action listener: _resource_record_pre_action 11:02:12 INFO - Running main action method: install 11:02:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:02:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:02:13 INFO - Reading from file tmpfile_stdout 11:02:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:02:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:02:13 INFO - Reading from file tmpfile_stdout 11:02:13 INFO - Output received: 11:02:13 INFO - Usage: mozinstall [options] installer 11:02:13 INFO - Options: 11:02:13 INFO - -h, --help show this help message and exit 11:02:13 INFO - -d DEST, --destination=DEST 11:02:13 INFO - Directory to install application into. [default: 11:02:13 INFO - "/builds/slave/test-pgo"] 11:02:13 INFO - --app=APP Application being installed. [default: firefox] 11:02:13 INFO - mkdir: /builds/slave/test-pgo/build/application 11:02:13 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'] 11:02:13 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 11:02:29 INFO - Reading from file tmpfile_stdout 11:02:29 INFO - Output received: 11:02:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:02:29 INFO - Running post-action listener: _resource_record_post_action 11:02:29 INFO - ##### 11:02:29 INFO - ##### Running run-tests step. 11:02:29 INFO - ##### 11:02:29 INFO - Running pre-action listener: _resource_record_pre_action 11:02:29 INFO - Running main action method: run_tests 11:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:02:29 INFO - Python 2.7.3 11:02:29 INFO - Return code: 0 11:02:29 INFO - grabbing minidump binary from tooltool 11:02: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')]} 11:02:29 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 0x20e98c0>, '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 0x20ea7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20eac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:02:29 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 11:02:29 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 11:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:02:29 INFO - Return code: 0 11:02:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:02:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:02:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:02:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:02:30 INFO - Return code: 0 11:02:30 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/alqfhVFGR6igwqYqMcWsAQ/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 11:02:30 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/alqfhVFGR6igwqYqMcWsAQ/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 11:02:30 INFO - Using env: {'DISPLAY': ':0', 11:02:30 INFO - 'HOME': '/home/cltbld', 11:02:30 INFO - 'LANG': 'en_US.UTF-8', 11:02:30 INFO - 'LANGUAGE': 'en_US:en', 11:02:30 INFO - 'LOGNAME': 'cltbld', 11:02:30 INFO - 'MAIL': '/var/mail/cltbld', 11:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:30 INFO - 'MOZ_NO_REMOTE': '1', 11:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:30 INFO - 'NO_EM_RESTART': '1', 11:02:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:02:30 INFO - 'PWD': '/builds/slave/test-pgo', 11:02:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:02:30 INFO - 'SHELL': '/bin/bash', 11:02:30 INFO - 'SHLVL': '1', 11:02:30 INFO - 'TERM': 'linux', 11:02:30 INFO - 'TMOUT': '86400', 11:02:30 INFO - 'USER': 'cltbld', 11:02:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1456853728.616877-1309763706', 11:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:30 INFO - '_': '/tools/buildbot/bin/python'} 11:02:30 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/alqfhVFGR6igwqYqMcWsAQ/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 11:02:30 INFO - mozversion application_buildid: 20160301083100 11:02:30 INFO - mozversion application_changeset: d6788a70c97b5ed250e65e4d83c435fc6791e3ff 11:02:30 INFO - mozversion application_display_name: Nightly 11:02:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:02:30 INFO - mozversion application_name: Firefox 11:02:30 INFO - mozversion application_remotingname: firefox 11:02:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:02:30 INFO - mozversion application_vendor: Mozilla 11:02:30 INFO - mozversion application_version: 47.0a1 11:02:30 INFO - mozversion platform_buildid: 20160301083100 11:02:30 INFO - mozversion platform_changeset: d6788a70c97b5ed250e65e4d83c435fc6791e3ff 11:02:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:02:30 INFO - mozversion platform_version: 47.0a1 11:02:30 INFO - using testdate: 1456858950 11:02:30 INFO - actual date: 1456858950 11:02:30 INFO - starting webserver on 'localhost:59270' 11:02:30 INFO - SUITE-START | Running 2 tests 11:02:30 INFO - TEST-START | dromaeo_css 11:02:30 INFO - operating with platform_type : linux_ 11:02:30 INFO - Initialising browser for dromaeo_css test... 11:02:30 INFO - TEST-INFO | started process 2024 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9f1K3R/profile http://localhost:59270/getInfo.html) 11:02:34 INFO - PROCESS | 2024 | __metrics Screen width/height:1600/1200 11:02:34 INFO - PROCESS | 2024 | colorDepth:24 11:02:34 INFO - PROCESS | 2024 | Browser inner width/height: 1024/697 11:02:34 INFO - PROCESS | 2024 | __metrics 11:02:35 INFO - PROCESS | 2024 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:35 INFO - PROCESS | 2024 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:02:36 INFO - TEST-INFO | 2024: exit 0 11:02:36 INFO - Browser initialized. 11:02:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:02:36 INFO - TEST-INFO | started process 2120 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9f1K3R/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:02:48 INFO - PROCESS | 2120 | RSS: Main: 153387008 11:02:48 INFO - PROCESS | 2120 | 11:03:39 INFO - PROCESS | 2120 | 1456859019832 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] 11:05:47 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59270/tests/dromaeo/cssquery-ext.html) 11:05:48 INFO - PROCESS | 2120 | RSS: Main: 266862592 11:05:48 INFO - PROCESS | 2120 | 11:08:51 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-ext.html (next: http://localhost:59270/tests/dromaeo/cssquery-jquery.html) 11:08:51 INFO - PROCESS | 2120 | RSS: Main: 240013312 11:08:51 INFO - PROCESS | 2120 | 11:11:53 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59270/tests/dromaeo/cssquery-mootools.html) 11:11:54 INFO - PROCESS | 2120 | RSS: Main: 240832512 11:11:54 INFO - PROCESS | 2120 | 11:14:56 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59270/tests/dromaeo/cssquery-prototype.html) 11:14:56 INFO - PROCESS | 2120 | RSS: Main: 214470656 11:14:56 INFO - PROCESS | 2120 | 11:17:59 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59270/tests/dromaeo/cssquery-yui.html) 11:18:00 INFO - PROCESS | 2120 | RSS: Main: 221642752 11:18:00 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | Cycle 1(1): loaded http://localhost:59270/tests/dromaeo/cssquery-yui.html (next: http://localhost:59270/tests/dromaeo/cssquery-dojo.html) 11:21:02 INFO - PROCESS | 2120 | RSS: Main: 289456128 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | __start_tp_report 11:21:02 INFO - PROCESS | 2120 | _x_x_mozilla_page_load 11:21:02 INFO - PROCESS | 2120 | _x_x_mozilla_page_load_details 11:21:02 INFO - PROCESS | 2120 | |i|pagename|runs| 11:21:02 INFO - PROCESS | 2120 | |0;dojo.html;3143.5127555228933;3175.936481270376;3196.456602377597;3209.6469388367277;3249.918752031199;5099.158638824599;5111.642185047039;5135.35808023997;5174.560162386197;5215.530602245802;5094.566961808251;5116.104681680709;5133.61497887659;5141.640085194029;5226.2944502492155;4683.437987441494;4691.991221887302;4750.833720819772;4818.036392721452;4877.439094504124;4620.376249206364;4664.790084446191;4808.182608956486;4810.4948980357085;4932.112219800452;4722.291656251556;4733.952660473403;4742.668013239075;4779.115863565216;4782.354382158399;4743.596794272491;4745.454272758642;4746.5490778376;4767.451743049559;4781.665283430161;4599.379083823708;4693.249080147194;4746.976265118687;4775.617950563947;4792.688475249132;5023.773930173151;5044.117279476113;5057.848264552069;5060.569851562622;5087.186050231945;5510.6969116698565;5513.669179849182;5514.779408823642;5531.308586426697;5579.218909352694;5434.809781657663;5501.14732216507;5556.499915007628;5605.103183490622;5645.633033852787;5104.489551044903;5109.978004399098;5112.36095488064;5123.257127716498;5140.614453915971;5493.176023596492;5563.248961390161;5565.916511252334;5569.136783798437;5596.916046259309;5386.542143917811;5418.403975562764;5452.890942181213;5489.752961116759;5521.806736764194;5502.394736578973;5526.088195447706;5528.530074943595;5529.30883639545;5529.806456773994;5326.280952071498;5486.890262194734;5504.6421982571;5561.165825126182;5564.582656300794;5480.479354461319;5482.780688772405;5486.1222204447095;5487;5540.778368865281;4270.786460677016;4272.978635106804;4274.123804620045;4275.1663425631705;4310.439642846472;3789.5642001170218;3793.7723736575895;3831.693464522887;3847.115163512408;3867.1878905430176;5072.822451214263;5084.161113416245;5092.516210959953;5093.465186155475;5143.485651434827;5437.45625437461;5476.12382018883;5478.561715062785;5492.725363731797;5525.917111243334;5043.092243396224;5058.494150584986;5107.259447380109;5143.305653736773;5150.356205474316;4634.791434385461;4647;4647.930281045719;4653.813847446064;4697.976510117496;5675.914861277084;5684.63049901755;5689.971550142305;5694.800681976194;5695.345035320991;5323.0152421802095;5502.0921547945745;5520.365158006881;5569.387367389503;5601.551875849841;5719.628224165416;5730.541556675373;5762.769489220552;5768;5771.1920331154515;5355.973220133875;5456.317960254968;5469.042917489503;5469.316335458067;5476.959377718221;5439.265699130567;5515.944840551543;5516.3380394352935;5519.420460851553;5556.222128901876;5401.702906340189;5401.783928642967;5411.026015317123;5411.323584551931;5416.9729151353995;5364.168553874156;5376.919346209732;5409.999150157233;5413.323334583177;5459.071957767269;5355.919661205007;5361.276227709365;5373.919391209213;5376.569874410116;5425.945740542702;5473.72631368422;5477.287952566141;5478.753456094565;5487.780488780404;5490.3411590609385;5268.920966185434;5367.275417818544;5374.811881584282;5377.677339359651;5454.863628409322 11:21:02 INFO - PROCESS | 2120 | |1;ext.html;532.4249810204979;542.3356388424181;553.0432352030983;553.3525774843433;582.3099626942073;36308.81845590772;36773.44839827405;36820.94969553347;36962;36971.0757231069;39404.60595394045;39650.60349396505;39766.20467590646;39812.60187398125;39889.800550997206;8331.083580806106;8508.914910850905;8522.446041007315;8538.188872057144;8539.615717292736;8672.86990695137;8842.425242359226;8859.5570221489;8859.911400885972;8861.424007439497;8825.470471771681;8898.555072246361;8934.195922366986;8935.195832375084;8939.150780675858;8793.868091978593;8877;8880.777980550472;8886.688965886227;8887.68893088742;8624.4394114383;8746.956265218632;8752.299816014704;8767;8768.254698350647;38814.61185388138;39064.60935390638;39272.607273927184;39298;39402.408963865564;3230.3862266169585;3291.7202037826814;3305.5702758641464;3443.724502039856;3626.7642603230706;29919.5512067317;30138.09585712432;30525.542116868266;30603.081907542808;30621.081367558785;3820.617938206185;3833.769973801581;3925.9214815703813;3964.762114273124;3990.0224445010867;261011;261098;261287;261642;262524;55827.720861395435;56357;56509.43490565124;56512.71743641255;56572;59172.40827591755;59983;60149.09776353358;60167.39832601706;60179.39820601825;15536.145511996723;16060.919695401448;16092.517224483285;16193.676126477405;16250.106244156685;11902.166848320707;11977.221480603734;11981.580644677395;12004.039676826007;12016.459259333351;19517.414477565697;19845.503862403555;19850.305239316556;19871.701924471145;19916.800831991495;7721.8455630887065;7819.882701759479;7931.365490760725;7992.880106798402;8032.156623554442;857.1985193843776;858.2233079063458;974.4056125763278;1000.9849852252222;1094.7263184203948;27215.455690886072;28059;28567.42865142727;28655;28768;1014.4268488304084;1015.6445244164631;1071.4107241017566;1076.4671487613525;1078.4823284823171;13274;13662.248576328397;13916.721665566834;13929.58211253664;13977.091489053179;372021.55956880713;376601;376712;379853;381224;51998.22002669963;52558.73720631372;52607.47392526102;52624;52680;1001.9949900250452;1241.7578572178338;1343.2813444807177;1384.4669802126052;1387.5906607550594;25576.360590985376;26760.59859102154;26980.1905942822;27329.453410932067;27331;39802.40296395614;40064.59935400609;40584.59415405926;40617;41360.79319603503;203122;207006;207217;207378;207485;27018.32454188661;30036;30259;30582.694173057986;31252.531212032292;35678.821605891804;36490.27019459649;36492.270154596226;36987.44518832166;37125.443118352705;30759.53860692136;31001.37997240088;31858.68141318557;32211.677883221804;32331.838340808146;33118.66881331156;34172.65827341695;34237;34788.130296742784;34912.825435873674;33478.33043339168;34078;34110.317793644484;34237;34332.31335373229;30237.848810755804;30243.546346804374;30556;30617.693823062375;30806.691933081278;23066.884665576566;23406.531869362858;23628.645570316803;23740;23787.881060594587 11:21:02 INFO - PROCESS | 2120 | |2;jquery.html;344.43856513882366;357.9767315124517;359.09687136850823;367.2526408758176;372.3706935279376;14004.64988375291;16223.594410139753;16657.58356041098;16901.661966760686;18179.36372226972;16231;16335.509934701948;16691.582710432245;17606.119694015313;17621.823781762178;5411.594130440223;5499.230107784913;5547.972260138694;5572.832815015536;5623.26897503326;3795.35478968576;5196.272521846944;5307.177387504943;5408.405075441718;5509.531689806371;5451.3458384993855;5459.344878614552;5462.644928079682;5465.07093794054;5477.643953143053;5371.81198658047;5435.1847222916485;5443.482869127427;5451.591130665196;5455.454454554552;5151.948480515184;5198.40218374888;5224.425313215544;5232.738363081869;5267.631265811395;11074.778504429867;11592.710182245512;11656.941715291454;12038.217515861528;12088.697782555419;2050.4976280811147;2104.379208133604;2157.8705277683234;2393.916212932539;2576.9434531841853;8686.782830429227;8950.283977281802;9141.131592498701;9186.86219706705;12279.570215042431;1798.0739918941756;1836.1645451319619;1845.1881172284286;1867.9533011674816;1875.3436297295973;59534.404655953316;64784;65849;66884.99999999952;67361.66319168422;9928.751781205528;10173.237007224488;10286.382817031003;10322.48387580618;10467.895321046692;13651.795223071662;13756.17462952206;13774.862251377559;13775.862241377657;13777;7598.544087354777;7746.30283274508;7753.651085701157;7864.606769661494;7876.251756083163;7539.472236943361;7584.241575842371;7701.191374905667;7725.690972361155;7733.729319473791;4439.223135951195;4504.189245935763;4507.098580283956;4553.590176884097;4582.175208462442;1715.1681434504255;1728.7579738836573;1728.9049102299493;1742.4685470931233;1753.6054387762906;888.8711136885115;896.4352457951579;898.3711402018613;916.276141847946;959.947202903847;15671.373145074298;16227.107509086878;16400.83599163993;16514;16830.915845420695;864.900536438305;951.7620594851287;965.1362030982232;970.1753509516996;992.846108853129;6918.8962165567555;9762.121409073217;9792.21662267017;9792.363496372713;9879.506024698736;387905;399815;400799;403117;406552;70711;71922.64038679774;72564;72781;72945;897.8608315711075;973.7468258252906;976.0532283684814;994.264244459095;994.5524513968743;14040.227787471787;14744.778828317798;14832.25838708082;15042.548723538312;15264.160471174193;31777.523337149498;32138.839305804257;32858.17854553655;32967.17582060468;35132.47301290432;39006.80496597499;40854.59145408508;42146.57853421549;42443.57556424396;42582.361264581676;7724.0731112266885;7752.5348479091435;8024.277814996678;8226.547539885363;8293.626786794488;12299.75400492003;12718.872811271769;12886.548970786353;12906.612801615967;13029;10524.684259472227;10909.945450272699;11268.436578170895;11312.94343528277;11341.376224307742;10971.341719496855;11035.117190624891;11266.887331126583;11463.165893457006;11653;10931.672049838518;11024.393658348868;11050.226484146033;11686.357250351311;11914.940425297818;7697.653605587874;7722.806929826799;7818.3354414875375;8030.036395632562;8195.262426381654;9663.275254356093;11443.48504317291;11467.139964502529;11652.53389864396;11687.76624467523 11:21:02 INFO - PROCESS | 2120 | |3;mootools.html;1379.7861331493623;1520.8175018997722;1523.3830298729013;1722.3282919661326;1866.729324247984;7776.222377762221;7923.643436045378;7924.405669574783;7943.920560794398;7960.482568633035;7352.96323518383;7443.85112297755;7462.552246865192;7476.140243871956;7546.584937828417;1976;2207.426069222002;2227.986266248861;2234.3743751749453;2246.853954492961;2252.2454977582447;2295.8392912496133;2300.0454811253308;2303.9539209215804;2305.688732021181;2248.134468229727;2336.0655737704883;2337.9649305260436;2341.6838726771925;2343.4610039690883;2287.3709729824263;2309.5265470578574;2320.5474932388274;2320.7795259450495;2323.6630688550235;2299.7930186283315;2304.6543018547186;2309.6535519672016;2314.340412982309;2339.777721116491;7319.268073192691;7364.04267445234;7376.668049937712;7384.076990376203;7394.741184058532;4664.067186562667;4732.313814496913;4737.028909073666;4756;4776.450708168571;2942.735153836165;3020.4865172920654;3070.1710538154575;3135.6237251529733;3145.1979745165067;973.454865275448;985.4629227071264;988.3773222869546;996.2677432087482;1036.1244748187844;10962.232643714942;11061.281016733887;11081.168912331526;11093.278936869077;11108;4134.441850350225;4244.702870799015;4286.035641980592;4293.0769884474985;4299.849505267363;9190.90809091914;9228;9228.723138305728;9229.169374756304;9231.399959002643;4301.612854843079;4633.582977532038;4638.0955713636195;4644.95355046452;4659.9767001165455;4247.23549761046;4327.978360108243;4350.543192964757;4354.346847972829;4355.303151495746;3683.778973261613;3743.363628183161;3747.6065013173225;3784.8675296365045;3800.980995095062;1160.3386069940223;1161.0769438296575;1164.0803765025705;1172.6657902497748;1173.3663821536445;1269.911106222574;1276.1768659214754;1288.5747703257903;1359.9116057456233;1360.1906865415062;7409.073865766779;7466.290702383265;7471.4396420268695;7483.102027756704;7490.70037198506;471.65804791526557;472.4236431553499;473.5013681697389;474.69382248449557;500.3220636038189;5742.59801813869;5834.416558344216;5845.386234445407;5847;5859.736311865976;9296.209822165056;9908.65319713821;10024.749381265527;10040.69877903664;10047.748806279755;9734.561944712505;9821.066998635119;9833.311668183158;9869.013098690073;9907.900920990698;7409.777706668809;7627.313541781266;7662;7718.3053525183;7722.845543089107;7258.12902451688;7297.343239108506;7325.084364454443;7327.926720732725;7336.37640800538;8322.583870806557;8705.956470217609;8853.557322133996;8947.955260223658;8948.328875334246;8542.871856922027;8579;8606.569671516525;8620.267277281502;8753.168448997336;6901.309869013058;7064.611446370499;7197.028401165776;7563.924360756322;7676.385889128968;7283.417326613964;7319.59742214162;7328.303811137934;7369.115706115301;7382.335589796944;6403.6798160090875;6494.675266236574;6580.769673061612;6642.103316052271;6705.798826035227;6488.935110648833;6553.082568440327;6582.605043697394;6593.505487088391;6606.867862642816;7071.080759501232;7071.46963977714;7110.146782386147;7128.536645118051;7130.251323610946;6389.265234497906;6512.6743662815725;6553.082568440517;6561;6561.737530498917;6535.738570457319;6541.182352205974;6567.671616419065;6576.704048317742;6582.3746744059235 11:21:02 INFO - PROCESS | 2120 | |4;prototype.html;318.72589572967246;325.8631374822574;328.8980416071018;334.2896345266309;337.4044810908746;5952.910706339403;5993.700314984249;6010.429009244126;6025.367336429677;6040.063790112539;5921.230240068796;5926.051831706928;5929.080992446177;5933.080372542263;5936.436038576328;4406;4447.533009034053;4522.29904364824;4555.544445555451;4596.862094137173;4535.773211339436;4538.97730511347;4538.977305113486;4550.408446901898;4558.27067669173;4499.055198408339;4501.617362524189;4508.706934049293;4509.210888094587;4513.2101882170655;4321.049369138785;4454.688171827957;4566.292224705176;4572.862814115582;4592.288195329729;4021.3364794809113;4032.1129351542613;4032.6370626643447;4032.959670403288;4047.1096358801015;5622.353429355636;5631.831045068655;5632.859178520529;5633.943660563383;5635.49280564747;5325.121354976424;5329.706866122362;5335.813246536352;5336.039512887679;5337.786488540453;6269.811905642838;6274.749010039593;6276.654783986879;6277.309495955441;6288.119663247149;4386.320120381346;4419.602235798793;4441.222786012435;4461.709988850715;4490.618297444721;6516.185476815398;6539.64031978241;6551.017347397881;6562.376574225441;6585.440237579812;4516.277395616686;4533.659975501851;4544.386507821402;4545.181867263925;4545.295514182181;4580.908381832344;4584.289435137559;4589.196890544142;4589.2657174851865;4594.218982772936;5278.445763194886;5283.550898173698;5285.07511185541;5294.967481341178;5310.468953104736;6097.420745029215;6310.211223597051;6323.652199129;6343.682815859189;6357.332480089524;1623.415570394657;1634.6567220883749;1643.6383995520966;1644.9472337703878;1651.265186991801;1033.3696445168441;1036.486938965202;1076.9084627806567;1090.9454527273604;1111.3887361950895;5858.5898987070495;5933.970330148408;5936.821895343147;5939.762409503658;5946.524278057745;6406.359364063556;6412.787588282128;6429.099926010363;6429.099926010363;6431.099646049463;5891.351951285355;5921.73352199152;5925.259342582177;5927.170196172539;5933.1396947443245;3422.19578399076;3456.9135771605406;3458.2219000724635;3462.3767721809813;3466.2027733621408;6553.279139294674;6704.731810727614;6721.462283017347;6733.663316834139;6744.393004629509;6553.63954982471;6601.471882249409;6602.438792702674;6606.504512161607;6615.040819081206;6707.731690732414;6715.865682686319;6715.966420167868;6719.697613607399;6724.49566282521;6369.554131210956;6420.807375778734;6421.550491465552;6424.261209960728;6441.549091563733;6305.96847015762;6368.108464814837;6381.266154392304;6386.584871983307;6514.120593719787;6810.284920083518;6831.69257383409;6840.794776156723;6843.041974123527;6844.452443804584;4442.977785111054;4457.3091170868565;4495.100979804118;4495.752733599684;4516.1419330328445;6518.5111116667385;6519.934800651933;6526.967365163144;6527.836804079936;6529.934700652932;6335.208098987627;6338.239411270677;6342.048692696132;6356.968215158895;6360.268569114426;6190.226221722285;6379.840503987438;6393.744250229939;6396.264429590657;6402.807915762534;6223.222097237845;6240.875182496416;6264.154339164154;6266.310705822265;6268.059791031382;6384.489240860627;6385.8722825544155;6393.2328120625825;6403.0395440682405;6404.711787969646;6031.879362412815;6128.571000029955;6240.906386404116;6256.186695729708;6258.655773932477 11:21:02 INFO - PROCESS | 2120 | |5;yui.html;727.2218725963219;750.6059318857599;755.9357454616357;784.8234147316853;791.4341246009106;13527.729445411085;13689.11020783651;13699.972502062335;13722.862771372284;13734.793978090336;12988.54540091097;13049.869501304984;13065.281409522473;13078.607641770763;13101.279429631366;671.4460570029732;807.3057170833079;823.6622984576295;828.3828547731948;829.2660995019421;840.0801122770587;843.9198276163754;846.6401779243828;847.1359213602123;847.3390755210914;704.7110684619307;862.4566523090444;868.0885070675797;871.542440218887;872.3980453487073;699.6047233313187;700.1947760075902;862.180928118287;871.2942516561606;880.0143838900473;651.6578796132069;651.8631087471637;652.0642877470797;652.2205963873126;653.1411194279507;13456.394462249222;13485.730285394236;13496.797548036788;13508;13514.32428378577;12464.252144871247;12495.25028498293;12841.807372889414;12884.226946383247;13381.66545836352;9881.16010139139;9944.154746846527;10023.548940297704;10192;10201.821682612257;3467.7225821934185;3484.3205574912904;3558.430651095838;3613.674769270778;3632.2553876455263;48591.27113093306;48989.26516102262;49055;49143.75428122872;51714.48285517172;9630.422174669542;9689.757756056155;9719.416834989923;9760.560774765152;10048.14590759779;18556.907215463838;18570.071496425124;18617.90691046536;18627.627447451247;18632.068396580118;7897.723579674684;7970.4819186752675;7972.202779722097;8027;8126.553039582762;4431.0694754102;4444.777761111932;4465.508794032654;4487.842925497592;4517.141743068806;3021.259791351133;3046.055722725962;3054;3055.114016935064;3063.050454359156;543.9401665816757;548.7942021741846;549.9257600223918;552.1689856765622;560.4339616986873;599.5952731905946;629.6127881352935;636.328673249726;639.9808005759835;640.3788325324521;7857.125090167423;8153.1846815317995;8213.466124701876;8256.752297431087;8542.701005464904;625.8748250349948;649.447969226154;653.8234676637281;656.4715404099745;658.3482352471115;3716.3867961786004;3827.73205875586;3836.232753449321;3862.729608927404;3959.9010024749614;54215;54492;54502.72748636311;54687.72656136694;55071.449285507435;47750.76124619355;49420.505794942306;49527;49702.751486242334;49800.75099624479;43200.567994320285;43300.350494742604;43495.78252108719;44325.33511997258;44500;7496.662650180646;7667.616619168908;7756.612169391621;7900.604969751605;7907.48601340911;33348.33303333871;33826.49260261049;34290.65709342974;34383.65616343805;34612.82693586516;40509.189816202925;40548.1890362197;41942;42779.786101069294;43752.343714843664;10123.493825308853;10165.237607179639;10188.439635820101;10246.538905749409;10420.843687344544;10453.738656533647;10692.144628429862;10932.56269749201;10956.233063685466;11208.495617697386;10032;10109.292349535463;10410.895891040993;10417.133495665434;10530.473476326;10067.597296108366;10537.26239163282;10625.043746062891;10745.677629671123;10778.946105269737;9868.506574671093;10136.290459667753;10202.693919182437;10309.74225644365;10519.316244444086;9047.502387368759;9208.723738287863;9297.907020929704;9339.20616747557;9551.876225843995;8259.710910118118;8703.869441958503;8711.21599056088;8909.420887642282;8959.372843901125 11:21:02 INFO - PROCESS | 2120 | __end_tp_report 11:21:02 INFO - PROCESS | 2120 | __start_cc_report 11:21:02 INFO - PROCESS | 2120 | _x_x_mozilla_cycle_collect,874 11:21:02 INFO - PROCESS | 2120 | __end_cc_report 11:21:02 INFO - PROCESS | 2120 | __startTimestamp1456860062851__endTimestamp 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | ------- Summary: start ------- 11:21:02 INFO - PROCESS | 2120 | Number of tests: 6 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#0] dojo.html Cycles:165 Average:5133.31 Median:5367.28 stddev:547.22 (10.2%) stddev-sans-first:526.16 11:21:02 INFO - PROCESS | 2120 | Values: 3143.5 3175.9 3196.5 3209.6 3249.9 5099.2 5111.6 5135.4 5174.6 5215.5 5094.6 5116.1 5133.6 5141.6 5226.3 4683.4 4692.0 4750.8 4818.0 4877.4 4620.4 4664.8 4808.2 4810.5 4932.1 4722.3 4734.0 4742.7 4779.1 4782.4 4743.6 4745.5 4746.5 4767.5 4781.7 4599.4 4693.2 4747.0 4775.6 4792.7 5023.8 5044.1 5057.8 5060.6 5087.2 5510.7 5513.7 5514.8 5531.3 5579.2 5434.8 5501.1 5556.5 5605.1 5645.6 5104.5 5110.0 5112.4 5123.3 5140.6 5493.2 5563.2 5565.9 5569.1 5596.9 5386.5 5418.4 5452.9 5489.8 5521.8 5502.4 5526.1 5528.5 5529.3 5529.8 5326.3 5486.9 5504.6 5561.2 5564.6 5480.5 5482.8 5486.1 5487.0 5540.8 4270.8 4273.0 4274.1 4275.2 4310.4 3789.6 3793.8 3831.7 3847.1 3867.2 5072.8 5084.2 5092.5 5093.5 5143.5 5437.5 5476.1 5478.6 5492.7 5525.9 5043.1 5058.5 5107.3 5143.3 5150.4 4634.8 4647.0 4647.9 4653.8 4698.0 5675.9 5684.6 5690.0 5694.8 5695.3 5323.0 5502.1 5520.4 5569.4 5601.6 5719.6 5730.5 5762.8 5768.0 5771.2 5356.0 5456.3 5469.0 5469.3 5477.0 5439.3 5515.9 5516.3 5519.4 5556.2 5401.7 5401.8 5411.0 5411.3 5417.0 5364.2 5376.9 5410.0 5413.3 5459.1 5355.9 5361.3 5373.9 5376.6 5425.9 5473.7 5477.3 5478.8 5487.8 5490.3 5268.9 5367.3 5374.8 5377.7 5454.9 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#1] ext.html Cycles:180 Average:44451.89 Median:35295.82 stddev:76369.37 (216.4%) stddev-sans-first:76512.41 11:21:02 INFO - PROCESS | 2120 | Values: 532.4 542.3 553.0 553.4 582.3 36308.8 36773.4 36820.9 36962.0 36971.1 39404.6 39650.6 39766.2 39812.6 39889.8 8331.1 8508.9 8522.4 8538.2 8539.6 8672.9 8842.4 8859.6 8859.9 8861.4 8825.5 8898.6 8934.2 8935.2 8939.2 8793.9 8877.0 8880.8 8886.7 8887.7 8624.4 8747.0 8752.3 8767.0 8768.3 38814.6 39064.6 39272.6 39298.0 39402.4 3230.4 3291.7 3305.6 3443.7 3626.8 29919.6 30138.1 30525.5 30603.1 30621.1 3820.6 3833.8 3925.9 3964.8 3990.0 261011.0 261098.0 261287.0 261642.0 262524.0 55827.7 56357.0 56509.4 56512.7 56572.0 59172.4 59983.0 60149.1 60167.4 60179.4 15536.1 16060.9 16092.5 16193.7 16250.1 11902.2 11977.2 11981.6 12004.0 12016.5 19517.4 19845.5 19850.3 19871.7 19916.8 7721.8 7819.9 7931.4 7992.9 8032.2 857.2 858.2 974.4 1001.0 1094.7 27215.5 28059.0 28567.4 28655.0 28768.0 1014.4 1015.6 1071.4 1076.5 1078.5 13274.0 13662.2 13916.7 13929.6 13977.1 372021.6 376601.0 376712.0 379853.0 381224.0 51998.2 52558.7 52607.5 52624.0 52680.0 1002.0 1241.8 1343.3 1384.5 1387.6 25576.4 26760.6 26980.2 27329.5 27331.0 39802.4 40064.6 40584.6 40617.0 41360.8 203122.0 207006.0 207217.0 207378.0 207485.0 27018.3 30036.0 30259.0 30582.7 31252.5 35678.8 36490.3 36492.3 36987.4 37125.4 30759.5 31001.4 31858.7 32211.7 32331.8 33118.7 34172.7 34237.0 34788.1 34912.8 33478.3 34078.0 34110.3 34237.0 34332.3 30237.8 30243.5 30556.0 30617.7 30806.7 23066.9 23406.5 23628.6 23740.0 23787.9 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#2] jquery.html Cycles:180 Average:23866.96 Median:223703.30 stddev:65634.30 (29.3%) stddev-sans-first:65794.66 11:21:02 INFO - PROCESS | 2120 | Values: 344.4 358.0 359.1 367.3 372.4 14004.6 16223.6 16657.6 16901.7 18179.4 16231.0 16335.5 16691.6 17606.1 17621.8 5411.6 5499.2 5548.0 5572.8 5623.3 3795.4 5196.3 5307.2 5408.4 5509.5 5451.3 5459.3 5462.6 5465.1 5477.6 5371.8 5435.2 5443.5 5451.6 5455.5 5151.9 5198.4 5224.4 5232.7 5267.6 11074.8 11592.7 11656.9 12038.2 12088.7 2050.5 2104.4 2157.9 2393.9 2576.9 8686.8 8950.3 9141.1 9186.9 12279.6 1798.1 1836.2 1845.2 1868.0 1875.3 59534.4 64784.0 65849.0 66885.0 67361.7 9928.8 10173.2 10286.4 10322.5 10467.9 13651.8 13756.2 13774.9 13775.9 13777.0 7598.5 7746.3 7753.7 7864.6 7876.3 7539.5 7584.2 7701.2 7725.7 7733.7 4439.2 4504.2 4507.1 4553.6 4582.2 1715.2 1728.8 1728.9 1742.5 1753.6 888.9 896.4 898.4 916.3 959.9 15671.4 16227.1 16400.8 16514.0 16830.9 864.9 951.8 965.1 970.2 992.8 6918.9 9762.1 9792.2 9792.4 9879.5 387905.0 399815.0 400799.0 403117.0 406552.0 70711.0 71922.6 72564.0 72781.0 72945.0 897.9 973.7 976.1 994.3 994.6 14040.2 14744.8 14832.3 15042.5 15264.2 31777.5 32138.8 32858.2 32967.2 35132.5 39006.8 40854.6 42146.6 42443.6 42582.4 7724.1 7752.5 8024.3 8226.5 8293.6 12299.8 12718.9 12886.5 12906.6 13029.0 10524.7 10909.9 11268.4 11312.9 11341.4 10971.3 11035.1 11266.9 11463.2 11653.0 10931.7 11024.4 11050.2 11686.4 11914.9 7697.7 7722.8 7818.3 8030.0 8195.3 9663.3 11443.5 11467.1 11652.5 11687.8 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#3] mootools.html Cycles:180 Average:5497.59 Median:6446.31 stddev:2913.22 (45.2%) stddev-sans-first:2904.95 11:21:02 INFO - PROCESS | 2120 | Values: 1379.8 1520.8 1523.4 1722.3 1866.7 7776.2 7923.6 7924.4 7943.9 7960.5 7353.0 7443.9 7462.6 7476.1 7546.6 1976.0 2207.4 2228.0 2234.4 2246.9 2252.2 2295.8 2300.0 2304.0 2305.7 2248.1 2336.1 2338.0 2341.7 2343.5 2287.4 2309.5 2320.5 2320.8 2323.7 2299.8 2304.7 2309.7 2314.3 2339.8 7319.3 7364.0 7376.7 7384.1 7394.7 4664.1 4732.3 4737.0 4756.0 4776.5 2942.7 3020.5 3070.2 3135.6 3145.2 973.5 985.5 988.4 996.3 1036.1 10962.2 11061.3 11081.2 11093.3 11108.0 4134.4 4244.7 4286.0 4293.1 4299.8 9190.9 9228.0 9228.7 9229.2 9231.4 4301.6 4633.6 4638.1 4645.0 4660.0 4247.2 4328.0 4350.5 4354.3 4355.3 3683.8 3743.4 3747.6 3784.9 3801.0 1160.3 1161.1 1164.1 1172.7 1173.4 1269.9 1276.2 1288.6 1359.9 1360.2 7409.1 7466.3 7471.4 7483.1 7490.7 471.7 472.4 473.5 474.7 500.3 5742.6 5834.4 5845.4 5847.0 5859.7 9296.2 9908.7 10024.7 10040.7 10047.7 9734.6 9821.1 9833.3 9869.0 9907.9 7409.8 7627.3 7662.0 7718.3 7722.8 7258.1 7297.3 7325.1 7327.9 7336.4 8322.6 8706.0 8853.6 8948.0 8948.3 8542.9 8579.0 8606.6 8620.3 8753.2 6901.3 7064.6 7197.0 7563.9 7676.4 7283.4 7319.6 7328.3 7369.1 7382.3 6403.7 6494.7 6580.8 6642.1 6705.8 6488.9 6553.1 6582.6 6593.5 6606.9 7071.1 7071.5 7110.1 7128.5 7130.3 6389.3 6512.7 6553.1 6561.0 6561.7 6535.7 6541.2 6567.7 6576.7 6582.4 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#4] prototype.html Cycles:180 Average:5274.86 Median:5935.20 stddev:1581.56 (26.6%) stddev-sans-first:1541.63 11:21:02 INFO - PROCESS | 2120 | Values: 318.7 325.9 328.9 334.3 337.4 5952.9 5993.7 6010.4 6025.4 6040.1 5921.2 5926.1 5929.1 5933.1 5936.4 4406.0 4447.5 4522.3 4555.5 4596.9 4535.8 4539.0 4539.0 4550.4 4558.3 4499.1 4501.6 4508.7 4509.2 4513.2 4321.0 4454.7 4566.3 4572.9 4592.3 4021.3 4032.1 4032.6 4033.0 4047.1 5622.4 5631.8 5632.9 5633.9 5635.5 5325.1 5329.7 5335.8 5336.0 5337.8 6269.8 6274.7 6276.7 6277.3 6288.1 4386.3 4419.6 4441.2 4461.7 4490.6 6516.2 6539.6 6551.0 6562.4 6585.4 4516.3 4533.7 4544.4 4545.2 4545.3 4580.9 4584.3 4589.2 4589.3 4594.2 5278.4 5283.6 5285.1 5295.0 5310.5 6097.4 6310.2 6323.7 6343.7 6357.3 1623.4 1634.7 1643.6 1644.9 1651.3 1033.4 1036.5 1076.9 1090.9 1111.4 5858.6 5934.0 5936.8 5939.8 5946.5 6406.4 6412.8 6429.1 6429.1 6431.1 5891.4 5921.7 5925.3 5927.2 5933.1 3422.2 3456.9 3458.2 3462.4 3466.2 6553.3 6704.7 6721.5 6733.7 6744.4 6553.6 6601.5 6602.4 6606.5 6615.0 6707.7 6715.9 6716.0 6719.7 6724.5 6369.6 6420.8 6421.6 6424.3 6441.5 6306.0 6368.1 6381.3 6386.6 6514.1 6810.3 6831.7 6840.8 6843.0 6844.5 4443.0 4457.3 4495.1 4495.8 4516.1 6518.5 6519.9 6527.0 6527.8 6529.9 6335.2 6338.2 6342.0 6357.0 6360.3 6190.2 6379.8 6393.7 6396.3 6402.8 6223.2 6240.9 6264.2 6266.3 6268.1 6384.5 6385.9 6393.2 6403.0 6404.7 6031.9 6128.6 6240.9 6256.2 6258.7 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | [#5] yui.html Cycles:180 Average:13335.08 Median:49022.13 stddev:15405.85 (31.4%) stddev-sans-first:15419.97 11:21:02 INFO - PROCESS | 2120 | Values: 727.2 750.6 755.9 784.8 791.4 13527.7 13689.1 13700.0 13722.9 13734.8 12988.5 13049.9 13065.3 13078.6 13101.3 671.4 807.3 823.7 828.4 829.3 840.1 843.9 846.6 847.1 847.3 704.7 862.5 868.1 871.5 872.4 699.6 700.2 862.2 871.3 880.0 651.7 651.9 652.1 652.2 653.1 13456.4 13485.7 13496.8 13508.0 13514.3 12464.3 12495.3 12841.8 12884.2 13381.7 9881.2 9944.2 10023.5 10192.0 10201.8 3467.7 3484.3 3558.4 3613.7 3632.3 48591.3 48989.3 49055.0 49143.8 51714.5 9630.4 9689.8 9719.4 9760.6 10048.1 18556.9 18570.1 18617.9 18627.6 18632.1 7897.7 7970.5 7972.2 8027.0 8126.6 4431.1 4444.8 4465.5 4487.8 4517.1 3021.3 3046.1 3054.0 3055.1 3063.1 543.9 548.8 549.9 552.2 560.4 599.6 629.6 636.3 640.0 640.4 7857.1 8153.2 8213.5 8256.8 8542.7 625.9 649.4 653.8 656.5 658.3 3716.4 3827.7 3836.2 3862.7 3959.9 54215.0 54492.0 54502.7 54687.7 55071.4 47750.8 49420.5 49527.0 49702.8 49800.8 43200.6 43300.4 43495.8 44325.3 44500.0 7496.7 7667.6 7756.6 7900.6 7907.5 33348.3 33826.5 34290.7 34383.7 34612.8 40509.2 40548.2 41942.0 42779.8 43752.3 10123.5 10165.2 10188.4 10246.5 10420.8 10453.7 10692.1 10932.6 10956.2 11208.5 10032.0 10109.3 10410.9 10417.1 10530.5 10067.6 10537.3 10625.0 10745.7 10778.9 9868.5 10136.3 10202.7 10309.7 10519.3 9047.5 9208.7 9297.9 9339.2 9551.9 8259.7 8703.9 8711.2 8909.4 8959.4 11:21:02 INFO - PROCESS | 2120 | -------- Summary: end -------- 11:21:02 INFO - PROCESS | 2120 | 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:02 INFO - PROCESS | 2120 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:03 INFO - TEST-INFO | 2120: exit 0 11:21:03 INFO - TEST-OK | dromaeo_css | took 1112953ms 11:21:03 INFO - TEST-START | kraken 11:21:03 INFO - operating with platform_type : linux_ 11:21:03 INFO - Initialising browser for kraken test... 11:21:03 INFO - TEST-INFO | started process 2306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExGzd5/profile http://localhost:59270/getInfo.html) 11:21:07 INFO - PROCESS | 2306 | __metrics Screen width/height:1600/1200 11:21:07 INFO - PROCESS | 2306 | colorDepth:24 11:21:07 INFO - PROCESS | 2306 | Browser inner width/height: 1024/697 11:21:07 INFO - PROCESS | 2306 | __metrics 11:21:08 INFO - PROCESS | 2306 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:21:08 INFO - PROCESS | 2306 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 11:21:09 INFO - TEST-INFO | 2306: exit 0 11:21:09 INFO - Browser initialized. 11:21:09 INFO - Running cycle 1/1 for kraken test... 11:21:09 INFO - TEST-INFO | started process 2471 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpExGzd5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:21 INFO - PROCESS | 2471 | RSS: Main: 152821760 11:21:21 INFO - PROCESS | 2471 | 11:21:23 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59270/tests/kraken/driver.html?testName=audio-beat-detection) 11:21:24 INFO - PROCESS | 2471 | RSS: Main: 197730304 11:21:24 INFO - PROCESS | 2471 | 11:21:26 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59270/tests/kraken/driver.html?testName=audio-dft) 11:21:27 INFO - PROCESS | 2471 | RSS: Main: 186159104 11:21:27 INFO - PROCESS | 2471 | 11:21:30 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59270/tests/kraken/driver.html?testName=audio-fft) 11:21:30 INFO - PROCESS | 2471 | RSS: Main: 170369024 11:21:30 INFO - PROCESS | 2471 | 11:21:32 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59270/tests/kraken/driver.html?testName=audio-oscillator) 11:21:33 INFO - PROCESS | 2471 | RSS: Main: 172535808 11:21:33 INFO - PROCESS | 2471 | 11:21:35 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:21:36 INFO - PROCESS | 2471 | RSS: Main: 173637632 11:21:36 INFO - PROCESS | 2471 | 11:21:39 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59270/tests/kraken/driver.html?testName=imaging-darkroom) 11:21:39 INFO - PROCESS | 2471 | RSS: Main: 175775744 11:21:39 INFO - PROCESS | 2471 | 11:21:43 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59270/tests/kraken/driver.html?testName=imaging-desaturate) 11:21:43 INFO - PROCESS | 2471 | RSS: Main: 176521216 11:21:43 INFO - PROCESS | 2471 | 11:21:46 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59270/tests/kraken/driver.html?testName=json-parse-financial) 11:21:47 INFO - PROCESS | 2471 | RSS: Main: 176824320 11:21:47 INFO - PROCESS | 2471 | 11:21:48 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:21:49 INFO - PROCESS | 2471 | RSS: Main: 185012224 11:21:49 INFO - PROCESS | 2471 | 11:21:51 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:21:51 INFO - PROCESS | 2471 | RSS: Main: 182706176 11:21:51 INFO - PROCESS | 2471 | 11:21:53 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:21:54 INFO - PROCESS | 2471 | RSS: Main: 189685760 11:21:54 INFO - PROCESS | 2471 | 11:21:56 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:21:57 INFO - PROCESS | 2471 | RSS: Main: 200654848 11:21:57 INFO - PROCESS | 2471 | 11:21:59 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:22:00 INFO - PROCESS | 2471 | RSS: Main: 199139328 11:22:00 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | Cycle 1(1): loaded http://localhost:59270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59270/tests/kraken/driver.html?testName=ai-astar) 11:22:02 INFO - PROCESS | 2471 | RSS: Main: 259063808 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | __start_tp_report 11:22:02 INFO - PROCESS | 2471 | _x_x_mozilla_page_load 11:22:02 INFO - PROCESS | 2471 | _x_x_mozilla_page_load_details 11:22:02 INFO - PROCESS | 2471 | |i|pagename|runs| 11:22:02 INFO - PROCESS | 2471 | |0;ai-astar;108;112;106;109;111;112;99;110;109;111 11:22:02 INFO - PROCESS | 2471 | |1;audio-beat-detection;150;125;157;166;127;151;149;134;175;127 11:22:02 INFO - PROCESS | 2471 | |2;audio-dft;161;160;160;162;162;159;163;163;163;162 11:22:02 INFO - PROCESS | 2471 | |3;audio-fft;73;73;103;96;72;76;74;109;95;72 11:22:02 INFO - PROCESS | 2471 | |4;audio-oscillator;93;92;139;93;93;92;144;92;92;145 11:22:02 INFO - PROCESS | 2471 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;117 11:22:02 INFO - PROCESS | 2471 | |6;imaging-darkroom;145;144;145;145;147;145;145;145;145;145 11:22:02 INFO - PROCESS | 2471 | |7;imaging-desaturate;95;97;96;96;95;95;96;96;95;95 11:22:02 INFO - PROCESS | 2471 | |8;json-parse-financial;58;55;57;57;56;57;57;65;56;53 11:22:02 INFO - PROCESS | 2471 | |9;json-stringify-tinderbox;67;68;74;68;69;68;68;68;68;68 11:22:02 INFO - PROCESS | 2471 | |10;stanford-crypto-aes;82;82;82;83;88;81;89;81;83;82 11:22:02 INFO - PROCESS | 2471 | |11;stanford-crypto-ccm;115;113;116;118;116;117;116;118;123;117 11:22:02 INFO - PROCESS | 2471 | |12;stanford-crypto-pbkdf2;154;162;149;151;153;144;151;150;149;147 11:22:02 INFO - PROCESS | 2471 | |13;stanford-crypto-sha256-iterative;68;68;71;68;69;66;67;68;69;75 11:22:02 INFO - PROCESS | 2471 | __end_tp_report 11:22:02 INFO - PROCESS | 2471 | __start_cc_report 11:22:02 INFO - PROCESS | 2471 | _x_x_mozilla_cycle_collect,1110 11:22:02 INFO - PROCESS | 2471 | __end_cc_report 11:22:02 INFO - PROCESS | 2471 | __startTimestamp1456860122359__endTimestamp 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | ------- Summary: start ------- 11:22:02 INFO - PROCESS | 2471 | Number of tests: 14 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 11:22:02 INFO - PROCESS | 2471 | Values: 108.0 112.0 106.0 109.0 111.0 112.0 99.0 110.0 109.0 111.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:150.50 stddev:17.38 (11.5%) stddev-sans-first:18.38 11:22:02 INFO - PROCESS | 2471 | Values: 150.0 125.0 157.0 166.0 127.0 151.0 149.0 134.0 175.0 127.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 11:22:02 INFO - PROCESS | 2471 | Values: 161.0 160.0 160.0 162.0 162.0 159.0 163.0 163.0 163.0 162.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#3] audio-fft Cycles:10 Average:84.30 Median:73.50 stddev:14.70 (20.0%) stddev-sans-first:15.01 11:22:02 INFO - PROCESS | 2471 | Values: 73.0 73.0 103.0 96.0 72.0 76.0 74.0 109.0 95.0 72.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:92.00 stddev:24.32 (26.4%) stddev-sans-first:25.22 11:22:02 INFO - PROCESS | 2471 | Values: 93.0 92.0 139.0 93.0 93.0 92.0 144.0 92.0 92.0 145.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:22:02 INFO - PROCESS | 2471 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:22:02 INFO - PROCESS | 2471 | Values: 145.0 144.0 145.0 145.0 147.0 145.0 145.0 145.0 145.0 145.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:22:02 INFO - PROCESS | 2471 | Values: 95.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.11 (5.5%) stddev-sans-first:3.28 11:22:02 INFO - PROCESS | 2471 | Values: 58.0 55.0 57.0 57.0 56.0 57.0 57.0 65.0 56.0 53.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:1.99 11:22:02 INFO - PROCESS | 2471 | Values: 67.0 68.0 74.0 68.0 69.0 68.0 68.0 68.0 68.0 68.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:2.83 (3.4%) stddev-sans-first:2.96 11:22:02 INFO - PROCESS | 2471 | Values: 82.0 82.0 82.0 83.0 88.0 81.0 89.0 81.0 83.0 82.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#11] stanford-crypto-ccm Cycles:10 Average:116.90 Median:117.00 stddev:2.60 (2.2%) stddev-sans-first:2.67 11:22:02 INFO - PROCESS | 2471 | Values: 115.0 113.0 116.0 118.0 116.0 117.0 116.0 118.0 123.0 117.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.00 stddev:4.81 (3.2%) stddev-sans-first:4.97 11:22:02 INFO - PROCESS | 2471 | Values: 154.0 162.0 149.0 151.0 153.0 144.0 151.0 150.0 149.0 147.0 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.51 (3.7%) stddev-sans-first:2.65 11:22:02 INFO - PROCESS | 2471 | Values: 68.0 68.0 71.0 68.0 69.0 66.0 67.0 68.0 69.0 75.0 11:22:02 INFO - PROCESS | 2471 | -------- Summary: end -------- 11:22:02 INFO - PROCESS | 2471 | 11:22:02 INFO - PROCESS | 2471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:22:02 INFO - PROCESS | 2471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:22:02 INFO - PROCESS | 2471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:22:02 INFO - PROCESS | 2471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:22:02 INFO - PROCESS | 2471 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 11:22:03 INFO - TEST-INFO | 2471: exit 0 11:22:03 INFO - TEST-OK | kraken | took 59903ms 11:22:03 INFO - SUITE-END | took 1172s 11:22:03 INFO - Completed test suite (00:19:32) 11:22:03 INFO - Working with test: dromaeo_css 11:22:03 INFO - Generating results file: dromaeo_css 11:22:03 INFO - Working with test: kraken 11:22:03 INFO - Generating results file: kraken 11:22:03 INFO - javascript benchmark 11:22:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:22:03 INFO - process_Request line: dromaeo_css 6771.63 graph.html#tests=[[72,64,35]] 11:22:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:22:03 INFO - process_Request line: kraken 1511.40 graph.html#tests=[[232,64,35]] 11:22:03 INFO - RETURN: dromaeo_css: 6771.63 11:22:03 INFO - RETURN: kraken: 1511.40 11:22:03 INFO - javascript benchmark 11:22:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3143.5127555228933, 3175.936481270376, 3196.456602377597, 3209.6469388367277, 3249.918752031199, 5099.158638824599, 5111.642185047039, 5135.35808023997, 5174.560162386197, 5215.530602245802, 5094.566961808251, 5116.104681680709, 5133.61497887659, 5141.640085194029, 5226.2944502492155, 4683.437987441494, 4691.991221887302, 4750.833720819772, 4818.036392721452, 4877.439094504124, 4620.376249206364, 4664.790084446191, 4808.182608956486, 4810.4948980357085, 4932.112219800452, 4722.291656251556, 4733.952660473403, 4742.668013239075, 4779.115863565216, 4782.354382158399, 4743.596794272491, 4745.454272758642, 4746.5490778376, 4767.451743049559, 4781.665283430161, 4599.379083823708, 4693.249080147194, 4746.976265118687, 4775.617950563947, 4792.688475249132, 5023.773930173151, 5044.117279476113, 5057.848264552069, 5060.569851562622, 5087.186050231945, 5510.6969116698565, 5513.669179849182, 5514.779408823642, 5531.308586426697, 5579.218909352694, 5434.809781657663, 5501.14732216507, 5556.499915007628, 5605.103183490622, 5645.633033852787, 5104.489551044903, 5109.978004399098, 5112.36095488064, 5123.257127716498, 5140.614453915971, 5493.176023596492, 5563.248961390161, 5565.916511252334, 5569.136783798437, 5596.916046259309, 5386.542143917811, 5418.403975562764, 5452.890942181213, 5489.752961116759, 5521.806736764194, 5502.394736578973, 5526.088195447706, 5528.530074943595, 5529.30883639545, 5529.806456773994, 5326.280952071498, 5486.890262194734, 5504.6421982571, 5561.165825126182, 5564.582656300794, 5480.479354461319, 5482.780688772405, 5486.1222204447095, 5487.0, 5540.778368865281, 4270.786460677016, 4272.978635106804, 4274.123804620045, 4275.1663425631705, 4310.439642846472, 3789.5642001170218, 3793.7723736575895, 3831.693464522887, 3847.115163512408, 3867.1878905430176, 5072.822451214263, 5084.161113416245, 5092.516210959953, 5093.465186155475, 5143.485651434827, 5437.45625437461, 5476.12382018883, 5478.561715062785, 5492.725363731797, 5525.917111243334, 5043.092243396224, 5058.494150584986, 5107.259447380109, 5143.305653736773, 5150.356205474316, 4634.791434385461, 4647.0, 4647.930281045719, 4653.813847446064, 4697.976510117496, 5675.914861277084, 5684.63049901755, 5689.971550142305, 5694.800681976194, 5695.345035320991, 5323.0152421802095, 5502.0921547945745, 5520.365158006881, 5569.387367389503, 5601.551875849841, 5719.628224165416, 5730.541556675373, 5762.769489220552, 5768.0, 5771.1920331154515, 5355.973220133875, 5456.317960254968, 5469.042917489503, 5469.316335458067, 5476.959377718221, 5439.265699130567, 5515.944840551543, 5516.3380394352935, 5519.420460851553, 5556.222128901876, 5401.702906340189, 5401.783928642967, 5411.026015317123, 5411.323584551931, 5416.9729151353995, 5364.168553874156, 5376.919346209732, 5409.999150157233, 5413.323334583177, 5459.071957767269, 5355.919661205007, 5361.276227709365, 5373.919391209213, 5376.569874410116, 5425.945740542702, 5473.72631368422, 5477.287952566141, 5478.753456094565, 5487.780488780404, 5490.3411590609385, 5268.920966185434, 5367.275417818544, 5374.811881584282, 5377.677339359651, 5454.863628409322], "unit": "score", "name": "dojo.html", "value": 5099.613436931627}, {"lowerIsBetter": false, "replicates": [532.4249810204979, 542.3356388424181, 553.0432352030983, 553.3525774843433, 582.3099626942073, 36308.81845590772, 36773.44839827405, 36820.94969553347, 36962.0, 36971.0757231069, 39404.60595394045, 39650.60349396505, 39766.20467590646, 39812.60187398125, 39889.800550997206, 8331.083580806106, 8508.914910850905, 8522.446041007315, 8538.188872057144, 8539.615717292736, 8672.86990695137, 8842.425242359226, 8859.5570221489, 8859.911400885972, 8861.424007439497, 8825.470471771681, 8898.555072246361, 8934.195922366986, 8935.195832375084, 8939.150780675858, 8793.868091978593, 8877.0, 8880.777980550472, 8886.688965886227, 8887.68893088742, 8624.4394114383, 8746.956265218632, 8752.299816014704, 8767.0, 8768.254698350647, 38814.61185388138, 39064.60935390638, 39272.607273927184, 39298.0, 39402.408963865564, 3230.3862266169585, 3291.7202037826814, 3305.5702758641464, 3443.724502039856, 3626.7642603230706, 29919.5512067317, 30138.09585712432, 30525.542116868266, 30603.081907542808, 30621.081367558785, 3820.617938206185, 3833.769973801581, 3925.9214815703813, 3964.762114273124, 3990.0224445010867, 261011.0, 261098.0, 261287.0, 261642.0, 262524.0, 55827.720861395435, 56357.0, 56509.43490565124, 56512.71743641255, 56572.0, 59172.40827591755, 59983.0, 60149.09776353358, 60167.39832601706, 60179.39820601825, 15536.145511996723, 16060.919695401448, 16092.517224483285, 16193.676126477405, 16250.106244156685, 11902.166848320707, 11977.221480603734, 11981.580644677395, 12004.039676826007, 12016.459259333351, 19517.414477565697, 19845.503862403555, 19850.305239316556, 19871.701924471145, 19916.800831991495, 7721.8455630887065, 7819.882701759479, 7931.365490760725, 7992.880106798402, 8032.156623554442, 857.1985193843776, 858.2233079063458, 974.4056125763278, 1000.9849852252222, 1094.7263184203948, 27215.455690886072, 28059.0, 28567.42865142727, 28655.0, 28768.0, 1014.4268488304084, 1015.6445244164631, 1071.4107241017566, 1076.4671487613525, 1078.4823284823171, 13274.0, 13662.248576328397, 13916.721665566834, 13929.58211253664, 13977.091489053179, 372021.55956880713, 376601.0, 376712.0, 379853.0, 381224.0, 51998.22002669963, 52558.73720631372, 52607.47392526102, 52624.0, 52680.0, 1001.9949900250452, 1241.7578572178338, 1343.2813444807177, 1384.4669802126052, 1387.5906607550594, 25576.360590985376, 26760.59859102154, 26980.1905942822, 27329.453410932067, 27331.0, 39802.40296395614, 40064.59935400609, 40584.59415405926, 40617.0, 41360.79319603503, 203122.0, 207006.0, 207217.0, 207378.0, 207485.0, 27018.32454188661, 30036.0, 30259.0, 30582.694173057986, 31252.531212032292, 35678.821605891804, 36490.27019459649, 36492.270154596226, 36987.44518832166, 37125.443118352705, 30759.53860692136, 31001.37997240088, 31858.68141318557, 32211.677883221804, 32331.838340808146, 33118.66881331156, 34172.65827341695, 34237.0, 34788.130296742784, 34912.825435873674, 33478.33043339168, 34078.0, 34110.317793644484, 34237.0, 34332.31335373229, 30237.848810755804, 30243.546346804374, 30556.0, 30617.693823062375, 30806.691933081278, 23066.884665576566, 23406.531869362858, 23628.645570316803, 23740.0, 23787.881060594587], "unit": "score", "name": "ext.html", "value": 17833.670186258056}, {"lowerIsBetter": false, "replicates": [344.43856513882366, 357.9767315124517, 359.09687136850823, 367.2526408758176, 372.3706935279376, 14004.64988375291, 16223.594410139753, 16657.58356041098, 16901.661966760686, 18179.36372226972, 16231.0, 16335.509934701948, 16691.582710432245, 17606.119694015313, 17621.823781762178, 5411.594130440223, 5499.230107784913, 5547.972260138694, 5572.832815015536, 5623.26897503326, 3795.35478968576, 5196.272521846944, 5307.177387504943, 5408.405075441718, 5509.531689806371, 5451.3458384993855, 5459.344878614552, 5462.644928079682, 5465.07093794054, 5477.643953143053, 5371.81198658047, 5435.1847222916485, 5443.482869127427, 5451.591130665196, 5455.454454554552, 5151.948480515184, 5198.40218374888, 5224.425313215544, 5232.738363081869, 5267.631265811395, 11074.778504429867, 11592.710182245512, 11656.941715291454, 12038.217515861528, 12088.697782555419, 2050.4976280811147, 2104.379208133604, 2157.8705277683234, 2393.916212932539, 2576.9434531841853, 8686.782830429227, 8950.283977281802, 9141.131592498701, 9186.86219706705, 12279.570215042431, 1798.0739918941756, 1836.1645451319619, 1845.1881172284286, 1867.9533011674816, 1875.3436297295973, 59534.404655953316, 64784.0, 65849.0, 66884.99999999952, 67361.66319168422, 9928.751781205528, 10173.237007224488, 10286.382817031003, 10322.48387580618, 10467.895321046692, 13651.795223071662, 13756.17462952206, 13774.862251377559, 13775.862241377657, 13777.0, 7598.544087354777, 7746.30283274508, 7753.651085701157, 7864.606769661494, 7876.251756083163, 7539.472236943361, 7584.241575842371, 7701.191374905667, 7725.690972361155, 7733.729319473791, 4439.223135951195, 4504.189245935763, 4507.098580283956, 4553.590176884097, 4582.175208462442, 1715.1681434504255, 1728.7579738836573, 1728.9049102299493, 1742.4685470931233, 1753.6054387762906, 888.8711136885115, 896.4352457951579, 898.3711402018613, 916.276141847946, 959.947202903847, 15671.373145074298, 16227.107509086878, 16400.83599163993, 16514.0, 16830.915845420695, 864.900536438305, 951.7620594851287, 965.1362030982232, 970.1753509516996, 992.846108853129, 6918.8962165567555, 9762.121409073217, 9792.21662267017, 9792.363496372713, 9879.506024698736, 387905.0, 399815.0, 400799.0, 403117.0, 406552.0, 70711.0, 71922.64038679774, 72564.0, 72781.0, 72945.0, 897.8608315711075, 973.7468258252906, 976.0532283684814, 994.264244459095, 994.5524513968743, 14040.227787471787, 14744.778828317798, 14832.25838708082, 15042.548723538312, 15264.160471174193, 31777.523337149498, 32138.839305804257, 32858.17854553655, 32967.17582060468, 35132.47301290432, 39006.80496597499, 40854.59145408508, 42146.57853421549, 42443.57556424396, 42582.361264581676, 7724.0731112266885, 7752.5348479091435, 8024.277814996678, 8226.547539885363, 8293.626786794488, 12299.75400492003, 12718.872811271769, 12886.548970786353, 12906.612801615967, 13029.0, 10524.684259472227, 10909.945450272699, 11268.436578170895, 11312.94343528277, 11341.376224307742, 10971.341719496855, 11035.117190624891, 11266.887331126583, 11463.165893457006, 11653.0, 10931.672049838518, 11024.393658348868, 11050.226484146033, 11686.357250351311, 11914.940425297818, 7697.653605587874, 7722.806929826799, 7818.3354414875375, 8030.036395632562, 8195.262426381654, 9663.275254356093, 11443.48504317291, 11467.139964502529, 11652.53389864396, 11687.76624467523], "unit": "score", "name": "jquery.html", "value": 8206.054393528391}, {"lowerIsBetter": false, "replicates": [1379.7861331493623, 1520.8175018997722, 1523.3830298729013, 1722.3282919661326, 1866.729324247984, 7776.222377762221, 7923.643436045378, 7924.405669574783, 7943.920560794398, 7960.482568633035, 7352.96323518383, 7443.85112297755, 7462.552246865192, 7476.140243871956, 7546.584937828417, 1976.0, 2207.426069222002, 2227.986266248861, 2234.3743751749453, 2246.853954492961, 2252.2454977582447, 2295.8392912496133, 2300.0454811253308, 2303.9539209215804, 2305.688732021181, 2248.134468229727, 2336.0655737704883, 2337.9649305260436, 2341.6838726771925, 2343.4610039690883, 2287.3709729824263, 2309.5265470578574, 2320.5474932388274, 2320.7795259450495, 2323.6630688550235, 2299.7930186283315, 2304.6543018547186, 2309.6535519672016, 2314.340412982309, 2339.777721116491, 7319.268073192691, 7364.04267445234, 7376.668049937712, 7384.076990376203, 7394.741184058532, 4664.067186562667, 4732.313814496913, 4737.028909073666, 4756.0, 4776.450708168571, 2942.735153836165, 3020.4865172920654, 3070.1710538154575, 3135.6237251529733, 3145.1979745165067, 973.454865275448, 985.4629227071264, 988.3773222869546, 996.2677432087482, 1036.1244748187844, 10962.232643714942, 11061.281016733887, 11081.168912331526, 11093.278936869077, 11108.0, 4134.441850350225, 4244.702870799015, 4286.035641980592, 4293.0769884474985, 4299.849505267363, 9190.90809091914, 9228.0, 9228.723138305728, 9229.169374756304, 9231.399959002643, 4301.612854843079, 4633.582977532038, 4638.0955713636195, 4644.95355046452, 4659.9767001165455, 4247.23549761046, 4327.978360108243, 4350.543192964757, 4354.346847972829, 4355.303151495746, 3683.778973261613, 3743.363628183161, 3747.6065013173225, 3784.8675296365045, 3800.980995095062, 1160.3386069940223, 1161.0769438296575, 1164.0803765025705, 1172.6657902497748, 1173.3663821536445, 1269.911106222574, 1276.1768659214754, 1288.5747703257903, 1359.9116057456233, 1360.1906865415062, 7409.073865766779, 7466.290702383265, 7471.4396420268695, 7483.102027756704, 7490.70037198506, 471.65804791526557, 472.4236431553499, 473.5013681697389, 474.69382248449557, 500.3220636038189, 5742.59801813869, 5834.416558344216, 5845.386234445407, 5847.0, 5859.736311865976, 9296.209822165056, 9908.65319713821, 10024.749381265527, 10040.69877903664, 10047.748806279755, 9734.561944712505, 9821.066998635119, 9833.311668183158, 9869.013098690073, 9907.900920990698, 7409.777706668809, 7627.313541781266, 7662.0, 7718.3053525183, 7722.845543089107, 7258.12902451688, 7297.343239108506, 7325.084364454443, 7327.926720732725, 7336.37640800538, 8322.583870806557, 8705.956470217609, 8853.557322133996, 8947.955260223658, 8948.328875334246, 8542.871856922027, 8579.0, 8606.569671516525, 8620.267277281502, 8753.168448997336, 6901.309869013058, 7064.611446370499, 7197.028401165776, 7563.924360756322, 7676.385889128968, 7283.417326613964, 7319.59742214162, 7328.303811137934, 7369.115706115301, 7382.335589796944, 6403.6798160090875, 6494.675266236574, 6580.769673061612, 6642.103316052271, 6705.798826035227, 6488.935110648833, 6553.082568440327, 6582.605043697394, 6593.505487088391, 6606.867862642816, 7071.080759501232, 7071.46963977714, 7110.146782386147, 7128.536645118051, 7130.251323610946, 6389.265234497906, 6512.6743662815725, 6553.082568440517, 6561.0, 6561.737530498917, 6535.738570457319, 6541.182352205974, 6567.671616419065, 6576.704048317742, 6582.3746744059235], "unit": "score", "name": "mootools.html", "value": 4427.605242202381}, {"lowerIsBetter": false, "replicates": [318.72589572967246, 325.8631374822574, 328.8980416071018, 334.2896345266309, 337.4044810908746, 5952.910706339403, 5993.700314984249, 6010.429009244126, 6025.367336429677, 6040.063790112539, 5921.230240068796, 5926.051831706928, 5929.080992446177, 5933.080372542263, 5936.436038576328, 4406.0, 4447.533009034053, 4522.29904364824, 4555.544445555451, 4596.862094137173, 4535.773211339436, 4538.97730511347, 4538.977305113486, 4550.408446901898, 4558.27067669173, 4499.055198408339, 4501.617362524189, 4508.706934049293, 4509.210888094587, 4513.2101882170655, 4321.049369138785, 4454.688171827957, 4566.292224705176, 4572.862814115582, 4592.288195329729, 4021.3364794809113, 4032.1129351542613, 4032.6370626643447, 4032.959670403288, 4047.1096358801015, 5622.353429355636, 5631.831045068655, 5632.859178520529, 5633.943660563383, 5635.49280564747, 5325.121354976424, 5329.706866122362, 5335.813246536352, 5336.039512887679, 5337.786488540453, 6269.811905642838, 6274.749010039593, 6276.654783986879, 6277.309495955441, 6288.119663247149, 4386.320120381346, 4419.602235798793, 4441.222786012435, 4461.709988850715, 4490.618297444721, 6516.185476815398, 6539.64031978241, 6551.017347397881, 6562.376574225441, 6585.440237579812, 4516.277395616686, 4533.659975501851, 4544.386507821402, 4545.181867263925, 4545.295514182181, 4580.908381832344, 4584.289435137559, 4589.196890544142, 4589.2657174851865, 4594.218982772936, 5278.445763194886, 5283.550898173698, 5285.07511185541, 5294.967481341178, 5310.468953104736, 6097.420745029215, 6310.211223597051, 6323.652199129, 6343.682815859189, 6357.332480089524, 1623.415570394657, 1634.6567220883749, 1643.6383995520966, 1644.9472337703878, 1651.265186991801, 1033.3696445168441, 1036.486938965202, 1076.9084627806567, 1090.9454527273604, 1111.3887361950895, 5858.5898987070495, 5933.970330148408, 5936.821895343147, 5939.762409503658, 5946.524278057745, 6406.359364063556, 6412.787588282128, 6429.099926010363, 6429.099926010363, 6431.099646049463, 5891.351951285355, 5921.73352199152, 5925.259342582177, 5927.170196172539, 5933.1396947443245, 3422.19578399076, 3456.9135771605406, 3458.2219000724635, 3462.3767721809813, 3466.2027733621408, 6553.279139294674, 6704.731810727614, 6721.462283017347, 6733.663316834139, 6744.393004629509, 6553.63954982471, 6601.471882249409, 6602.438792702674, 6606.504512161607, 6615.040819081206, 6707.731690732414, 6715.865682686319, 6715.966420167868, 6719.697613607399, 6724.49566282521, 6369.554131210956, 6420.807375778734, 6421.550491465552, 6424.261209960728, 6441.549091563733, 6305.96847015762, 6368.108464814837, 6381.266154392304, 6386.584871983307, 6514.120593719787, 6810.284920083518, 6831.69257383409, 6840.794776156723, 6843.041974123527, 6844.452443804584, 4442.977785111054, 4457.3091170868565, 4495.100979804118, 4495.752733599684, 4516.1419330328445, 6518.5111116667385, 6519.934800651933, 6526.967365163144, 6527.836804079936, 6529.934700652932, 6335.208098987627, 6338.239411270677, 6342.048692696132, 6356.968215158895, 6360.268569114426, 6190.226221722285, 6379.840503987438, 6393.744250229939, 6396.264429590657, 6402.807915762534, 6223.222097237845, 6240.875182496416, 6264.154339164154, 6266.310705822265, 6268.059791031382, 6384.489240860627, 6385.8722825544155, 6393.2328120625825, 6403.0395440682405, 6404.711787969646, 6031.879362412815, 6128.571000029955, 6240.906386404116, 6256.186695729708, 6258.655773932477], "unit": "score", "name": "prototype.html", "value": 4759.471987011389}, {"lowerIsBetter": false, "replicates": [727.2218725963219, 750.6059318857599, 755.9357454616357, 784.8234147316853, 791.4341246009106, 13527.729445411085, 13689.11020783651, 13699.972502062335, 13722.862771372284, 13734.793978090336, 12988.54540091097, 13049.869501304984, 13065.281409522473, 13078.607641770763, 13101.279429631366, 671.4460570029732, 807.3057170833079, 823.6622984576295, 828.3828547731948, 829.2660995019421, 840.0801122770587, 843.9198276163754, 846.6401779243828, 847.1359213602123, 847.3390755210914, 704.7110684619307, 862.4566523090444, 868.0885070675797, 871.542440218887, 872.3980453487073, 699.6047233313187, 700.1947760075902, 862.180928118287, 871.2942516561606, 880.0143838900473, 651.6578796132069, 651.8631087471637, 652.0642877470797, 652.2205963873126, 653.1411194279507, 13456.394462249222, 13485.730285394236, 13496.797548036788, 13508.0, 13514.32428378577, 12464.252144871247, 12495.25028498293, 12841.807372889414, 12884.226946383247, 13381.66545836352, 9881.16010139139, 9944.154746846527, 10023.548940297704, 10192.0, 10201.821682612257, 3467.7225821934185, 3484.3205574912904, 3558.430651095838, 3613.674769270778, 3632.2553876455263, 48591.27113093306, 48989.26516102262, 49055.0, 49143.75428122872, 51714.48285517172, 9630.422174669542, 9689.757756056155, 9719.416834989923, 9760.560774765152, 10048.14590759779, 18556.907215463838, 18570.071496425124, 18617.90691046536, 18627.627447451247, 18632.068396580118, 7897.723579674684, 7970.4819186752675, 7972.202779722097, 8027.0, 8126.553039582762, 4431.0694754102, 4444.777761111932, 4465.508794032654, 4487.842925497592, 4517.141743068806, 3021.259791351133, 3046.055722725962, 3054.0, 3055.114016935064, 3063.050454359156, 543.9401665816757, 548.7942021741846, 549.9257600223918, 552.1689856765622, 560.4339616986873, 599.5952731905946, 629.6127881352935, 636.328673249726, 639.9808005759835, 640.3788325324521, 7857.125090167423, 8153.1846815317995, 8213.466124701876, 8256.752297431087, 8542.701005464904, 625.8748250349948, 649.447969226154, 653.8234676637281, 656.4715404099745, 658.3482352471115, 3716.3867961786004, 3827.73205875586, 3836.232753449321, 3862.729608927404, 3959.9010024749614, 54215.0, 54492.0, 54502.72748636311, 54687.72656136694, 55071.449285507435, 47750.76124619355, 49420.505794942306, 49527.0, 49702.751486242334, 49800.75099624479, 43200.567994320285, 43300.350494742604, 43495.78252108719, 44325.33511997258, 44500.0, 7496.662650180646, 7667.616619168908, 7756.612169391621, 7900.604969751605, 7907.48601340911, 33348.33303333871, 33826.49260261049, 34290.65709342974, 34383.65616343805, 34612.82693586516, 40509.189816202925, 40548.1890362197, 41942.0, 42779.786101069294, 43752.343714843664, 10123.493825308853, 10165.237607179639, 10188.439635820101, 10246.538905749409, 10420.843687344544, 10453.738656533647, 10692.144628429862, 10932.56269749201, 10956.233063685466, 11208.495617697386, 10032.0, 10109.292349535463, 10410.895891040993, 10417.133495665434, 10530.473476326, 10067.597296108366, 10537.26239163282, 10625.043746062891, 10745.677629671123, 10778.946105269737, 9868.506574671093, 10136.290459667753, 10202.693919182437, 10309.74225644365, 10519.316244444086, 9047.502387368759, 9208.723738287863, 9297.907020929704, 9339.20616747557, 9551.876225843995, 8259.710910118118, 8703.869441958503, 8711.21599056088, 8909.420887642282, 8959.372843901125], "unit": "score", "name": "yui.html", "value": 6130.296421492753}], "name": "dromaeo_css", "value": 6771.630003274862}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 112.0, 106.0, 109.0, 111.0, 112.0, 99.0, 110.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 157.0, 166.0, 127.0, 151.0, 149.0, 134.0, 175.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 162.0, 162.0, 159.0, 163.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 103.0, 96.0, 72.0, 76.0, 74.0, 109.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 139.0, 93.0, 93.0, 92.0, 144.0, 92.0, 92.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 57.0, 57.0, 56.0, 57.0, 57.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 74.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 88.0, 81.0, 89.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 116.0, 118.0, 116.0, 117.0, 116.0, 118.0, 123.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.9}, {"lowerIsBetter": true, "replicates": [154.0, 162.0, 149.0, 151.0, 153.0, 144.0, 151.0, 150.0, 149.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 71.0, 68.0, 69.0, 66.0, 67.0, 68.0, 69.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1511.4}]} 11:22:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6771.63"}}} 11:22:03 INFO - Return code: 0 11:22:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:22:03 INFO - # TBPL SUCCESS # 11:22:03 INFO - Running post-action listener: _resource_record_post_action 11:22:03 INFO - Running post-run listener: _resource_record_post_run 11:22:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544829440; Read time: 204; Write time: 510728 11:22:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249552896; Read time: 0; Write time: 320400 11:22:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295276544; Read time: 204; Write time: 190328 11:22:04 INFO - Running post-run listener: _upload_blobber_files 11:22:04 INFO - Blob upload gear active. 11:22:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:22:04 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:22:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:22:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:22:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:06 INFO - (blobuploader) - INFO - Done attempting. 11:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:22:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:22:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:22:07 INFO - (blobuploader) - INFO - Done attempting. 11:22:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:22:07 INFO - Return code: 0 11:22:07 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:22:07 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:22:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05a79118adaa089911d1910099424dfa45cf3fd062fef85c4e7421579ce404ab3e78815c0ee170f7f7164c92b058f98661e92a6c210f4ebc5dba6c98b8336238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47526fe182902f7559f9da940b8bc30cfde87137e1106014ba0c9267220e3b196068a7a62e547685db5347244cce9418ddcc9b091522138ed3c0443ccb24befa"} 11:22:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:22:07 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:22:07 INFO - Contents: 11:22:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05a79118adaa089911d1910099424dfa45cf3fd062fef85c4e7421579ce404ab3e78815c0ee170f7f7164c92b058f98661e92a6c210f4ebc5dba6c98b8336238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47526fe182902f7559f9da940b8bc30cfde87137e1106014ba0c9267220e3b196068a7a62e547685db5347244cce9418ddcc9b091522138ed3c0443ccb24befa"} 11:22:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:22:07 INFO - Copying logs to upload dir... 11:22:07 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:22:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.245978 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-03-01 11:22:06.958494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 11:22:06.965414) ========= 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-1456853728.616877-1309763706 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/05a79118adaa089911d1910099424dfa45cf3fd062fef85c4e7421579ce404ab3e78815c0ee170f7f7164c92b058f98661e92a6c210f4ebc5dba6c98b8336238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47526fe182902f7559f9da940b8bc30cfde87137e1106014ba0c9267220e3b196068a7a62e547685db5347244cce9418ddcc9b091522138ed3c0443ccb24befa"} build_url:https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/alqfhVFGR6igwqYqMcWsAQ/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/05a79118adaa089911d1910099424dfa45cf3fd062fef85c4e7421579ce404ab3e78815c0ee170f7f7164c92b058f98661e92a6c210f4ebc5dba6c98b8336238", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47526fe182902f7559f9da940b8bc30cfde87137e1106014ba0c9267220e3b196068a7a62e547685db5347244cce9418ddcc9b091522138ed3c0443ccb24befa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 11:22:06.990432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:22:06.990756) ========= 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-1456853728.616877-1309763706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 11:22:07.074095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 11:22:07.074447) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 11:22:07.074866) ========= ========= Total master_lag: 0.36 =========