builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1456330771.09 results: success (0) buildid: 20160224053021 builduid: 2ba08abe9bb945a592089ea8d0c7c837 revision: 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.085857) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.086349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.086693) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008776 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.154456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.154816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.168536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.168946) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.218694) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.219057) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.219454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.219781) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 08:19:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.8M=0s 2016-02-24 08:19:31 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.419441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.419850) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.469982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:31.470568) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 --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 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 --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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 08:19:31,640 truncating revision to first 12 chars 2016-02-24 08:19:31,640 Setting DEBUG logging. 2016-02-24 08:19:31,640 attempt 1/10 2016-02-24 08:19:31,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b9d91965921?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 08:19:32,190 unpacking tar archive at: fx-team-1b9d91965921/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:32.342970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:32.343371) ========= echo 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1b9d91965921cc7d3f7c9d6684315bc7ace03a17'] 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 program finished with exit code 0 elapsedTime=0.004020 script_repo_revision: '1b9d91965921cc7d3f7c9d6684315bc7ace03a17' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:32.396563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:32.397344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:19:32.407697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-24 08:19:32.408004) ========= /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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:19:32 INFO - MultiFileLogger online at 20160224 08:19:32 in /builds/slave/test-pgo 08:19:32 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 08:19:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:19:32 INFO - {'append_to_log': False, 08:19:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:19:32 INFO - 'blob_upload_branch': 'Fx-Team', 08:19:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:19:32 INFO - 'branch': 'Fx-Team', 08:19:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:19:32 INFO - 'config_files': ('talos/linux_config.py',), 08:19:32 INFO - 'default_actions': ('clobber', 08:19:32 INFO - 'read-buildbot-config', 08:19:32 INFO - 'download-and-extract', 08:19:32 INFO - 'populate-webroot', 08:19:32 INFO - 'create-virtualenv', 08:19:32 INFO - 'install', 08:19:32 INFO - 'run-tests'), 08:19:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:19:32 INFO - 'download_minidump_stackwalk': True, 08:19:32 INFO - 'download_symbols': 'ondemand', 08:19:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:19:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:19:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:19:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:19:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:19:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:19:32 INFO - 'installer_path': 'installer.exe', 08:19:32 INFO - 'log_level': 'info', 08:19:32 INFO - 'log_name': 'talos', 08:19:32 INFO - 'log_to_console': True, 08:19:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:19:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:19:32 INFO - 'opt_config_files': (), 08:19:32 INFO - 'pip_index': False, 08:19:32 INFO - 'sps_profile': False, 08:19:32 INFO - 'sps_profile_interval': 0, 08:19:32 INFO - 'suite': 'dromaeojs', 08:19:32 INFO - 'system_bits': '32', 08:19:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:19:32 INFO - 'title': 'talos-linux64-ix-015', 08:19:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:19:32 INFO - 'use_talos_json': True, 08:19:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:19:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:19:32 INFO - 'work_dir': 'build'} 08:19:32 INFO - ##### 08:19:32 INFO - ##### Running clobber step. 08:19:32 INFO - ##### 08:19:32 INFO - Running pre-action listener: _resource_record_pre_action 08:19:32 INFO - Running main action method: clobber 08:19:32 INFO - rmtree: /builds/slave/test-pgo/build 08:19:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:19:33 INFO - Running post-action listener: _resource_record_post_action 08:19:33 INFO - ##### 08:19:33 INFO - ##### Running read-buildbot-config step. 08:19:33 INFO - ##### 08:19:33 INFO - Running pre-action listener: _resource_record_pre_action 08:19:33 INFO - Running main action method: read_buildbot_config 08:19:33 INFO - Using buildbot properties: 08:19:33 INFO - { 08:19:33 INFO - "project": "", 08:19:33 INFO - "product": "firefox", 08:19:33 INFO - "script_repo_revision": "production", 08:19:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:19:33 INFO - "repository": "", 08:19:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:19:33 INFO - "buildid": "20160224053021", 08:19:33 INFO - "pgo_build": "True", 08:19:33 INFO - "basedir": "/builds/slave/test-pgo", 08:19:33 INFO - "buildnumber": 516, 08:19:33 INFO - "slavename": "talos-linux64-ix-015", 08:19:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:19:33 INFO - "platform": "ubuntu64_hw", 08:19:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:19:33 INFO - "branch": "fx-team", 08:19:33 INFO - "repo_path": "integration/fx-team", 08:19:33 INFO - "revision": "1b9d91965921cc7d3f7c9d6684315bc7ace03a17", 08:19:33 INFO - "stage_platform": "linux64-pgo", 08:19:33 INFO - "builduid": "2ba08abe9bb945a592089ea8d0c7c837", 08:19:33 INFO - "slavebuilddir": "test" 08:19:33 INFO - } 08:19:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:19:33 INFO - Running post-action listener: _resource_record_post_action 08:19:33 INFO - ##### 08:19:33 INFO - ##### Running download-and-extract step. 08:19:33 INFO - ##### 08:19:33 INFO - Running pre-action listener: _resource_record_pre_action 08:19:33 INFO - Running main action method: download_and_extract 08:19:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:19:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:33 INFO - https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:19:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/test_packages.json 08:19:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/test_packages.json 08:19:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:19:34 INFO - Downloaded 1448 bytes. 08:19:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:19:34 INFO - Using the following test package requirements: 08:19:34 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:19:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:19:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'jsshell-linux-x86_64.zip'], 08:19:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:19:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:19:34 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:19:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:19:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:19:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:19:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:19:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:19:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:34 INFO - https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:19:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:19:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:35 INFO - Downloaded 23368747 bytes. 08:19:35 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'] 08:19:35 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 08:19:36 INFO - Return code: 0 08:19:36 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 08:19: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')]} 08:19:36 INFO - https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:37 INFO - Downloaded 23368747 bytes. 08:19:37 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'] 08:19:37 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 08:19:39 INFO - Return code: 0 08:19:39 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')]} 08:19:39 INFO - https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:19:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:19:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:40 INFO - Downloaded 10707015 bytes. 08:19:40 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'] 08:19:40 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 08:19:40 INFO - Return code: 0 08:19: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')]} 08:19:40 INFO - https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:19:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:19:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:19:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/anXhOCffSraW5GFHnpDkJQ/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 08:19:43 INFO - Downloaded 56657489 bytes. 08:19:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:19:43 INFO - mkdir: /builds/slave/test-pgo/properties 08:19:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:19:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:19:43 INFO - Contents: 08:19:43 INFO - build_url:https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:19:43 INFO - Running post-action listener: _resource_record_post_action 08:19:43 INFO - Running post-action listener: set_extra_try_arguments 08:19:43 INFO - ##### 08:19:43 INFO - ##### Running populate-webroot step. 08:19:43 INFO - ##### 08:19:43 INFO - Running pre-action listener: _resource_record_pre_action 08:19:43 INFO - Running main action method: populate_webroot 08:19:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:43 INFO - '--tppagecycles', 08:19:43 INFO - '7'], 08:19:43 INFO - 'tests': ['tsvgm']}}, 08:19:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:19:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:19:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:19:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['damp', 'tps']}, 08:19:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['damp', 'tps']}, 08:19:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:19:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:43 INFO - 'other': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'other_l64': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'other_nol64': {'tests': ['a11yr', 08:19:43 INFO - 'ts_paint', 08:19:43 INFO - 'tpaint', 08:19:43 INFO - 'sessionrestore', 08:19:43 INFO - 'sessionrestore_no_auto_restore']}, 08:19:43 INFO - 'svgr': {'tests': ['tsvgx', 08:19:43 INFO - 'tsvgr_opacity', 08:19:43 INFO - 'tart', 08:19:43 INFO - 'tscrollx', 08:19:43 INFO - 'cart']}, 08:19:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['tsvgx', 08:19:43 INFO - 'tsvgr_opacity', 08:19:43 INFO - 'tart', 08:19:43 INFO - 'tscrollx', 08:19:43 INFO - 'cart']}, 08:19:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'tests': ['tp5o']}, 08:19:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--e10s'], 08:19:43 INFO - 'tests': ['tp5o']}, 08:19:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--xperf_path', 08:19:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:43 INFO - 'tests': ['tp5n']}, 08:19:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:43 INFO - 'talos_options': ['--e10s', 08:19:43 INFO - '--xperf_path', 08:19:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:43 INFO - 'tests': ['tp5n']}}, 08:19:43 INFO - 'talos.zip': {'path': '', 08:19:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:43 INFO - Running post-action listener: _resource_record_post_action 08:19:43 INFO - ##### 08:19:43 INFO - ##### Running create-virtualenv step. 08:19:43 INFO - ##### 08:19:43 INFO - Running pre-action listener: _resource_record_pre_action 08:19:43 INFO - Running main action method: create_virtualenv 08:19:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:19:43 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 08:19:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:19:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:43 INFO - Using real prefix '/usr' 08:19:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:19:44 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:46 INFO - Installing pip.................done. 08:19:46 INFO - Return code: 0 08:19:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19:46 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 08:19:46 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 08:19:46 INFO - Using env: {'DISPLAY': ':0', 08:19:46 INFO - 'HOME': '/home/cltbld', 08:19:46 INFO - 'LANG': 'en_US.UTF-8', 08:19:46 INFO - 'LANGUAGE': 'en_US:en', 08:19:46 INFO - 'LOGNAME': 'cltbld', 08:19:46 INFO - 'MAIL': '/var/mail/cltbld', 08:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:46 INFO - 'MOZ_NO_REMOTE': '1', 08:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:46 INFO - 'NO_EM_RESTART': '1', 08:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:46 INFO - 'SHELL': '/bin/bash', 08:19:46 INFO - 'SHLVL': '1', 08:19:46 INFO - 'TERM': 'linux', 08:19:46 INFO - 'TMOUT': '86400', 08:19:46 INFO - 'USER': 'cltbld', 08:19:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:46 INFO - '_': '/tools/buildbot/bin/python'} 08:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:46 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 08:19:46 INFO - Cleaning up... 08:19:46 INFO - Return code: 0 08:19:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:46 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19:46 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 08:19:46 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 08:19:46 INFO - Using env: {'DISPLAY': ':0', 08:19:46 INFO - 'HOME': '/home/cltbld', 08:19:46 INFO - 'LANG': 'en_US.UTF-8', 08:19:46 INFO - 'LANGUAGE': 'en_US:en', 08:19:46 INFO - 'LOGNAME': 'cltbld', 08:19:46 INFO - 'MAIL': '/var/mail/cltbld', 08:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:46 INFO - 'MOZ_NO_REMOTE': '1', 08:19:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:46 INFO - 'NO_EM_RESTART': '1', 08:19:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:46 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:46 INFO - 'SHELL': '/bin/bash', 08:19:46 INFO - 'SHLVL': '1', 08:19:46 INFO - 'TERM': 'linux', 08:19:46 INFO - 'TMOUT': '86400', 08:19:46 INFO - 'USER': 'cltbld', 08:19:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:46 INFO - '_': '/tools/buildbot/bin/python'} 08:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:46 INFO - Downloading/unpacking psutil>=0.7.1 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:48 INFO - Installing collected packages: psutil 08:19:48 INFO - Running setup.py install for psutil 08:19:48 INFO - building 'psutil._psutil_linux' extension 08:19:48 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 08:19:49 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 08:19:49 INFO - building 'psutil._psutil_posix' extension 08:19:49 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 08:19:49 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 08:19:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:49 INFO - Successfully installed psutil 08:19:49 INFO - Cleaning up... 08:19:49 INFO - Return code: 0 08:19:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:49 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19:49 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 08:19:49 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 08:19:49 INFO - Using env: {'DISPLAY': ':0', 08:19:49 INFO - 'HOME': '/home/cltbld', 08:19:49 INFO - 'LANG': 'en_US.UTF-8', 08:19:49 INFO - 'LANGUAGE': 'en_US:en', 08:19:49 INFO - 'LOGNAME': 'cltbld', 08:19:49 INFO - 'MAIL': '/var/mail/cltbld', 08:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:49 INFO - 'MOZ_NO_REMOTE': '1', 08:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:49 INFO - 'NO_EM_RESTART': '1', 08:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:49 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:49 INFO - 'SHELL': '/bin/bash', 08:19:49 INFO - 'SHLVL': '1', 08:19:49 INFO - 'TERM': 'linux', 08:19:49 INFO - 'TMOUT': '86400', 08:19:49 INFO - 'USER': 'cltbld', 08:19:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:49 INFO - '_': '/tools/buildbot/bin/python'} 08:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:19:49 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 08:19:49 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 08:19:49 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 08:19:49 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 08:19:49 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 08:19:49 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 08:19:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:19:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:51 INFO - Installing collected packages: mozsystemmonitor 08:19:51 INFO - Running setup.py install for mozsystemmonitor 08:19:51 INFO - Successfully installed mozsystemmonitor 08:19:51 INFO - Cleaning up... 08:19:51 INFO - Return code: 0 08:19:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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', '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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:19: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 blobuploader==1.2.4 08:19:51 INFO - Using env: {'DISPLAY': ':0', 08:19:51 INFO - 'HOME': '/home/cltbld', 08:19:51 INFO - 'LANG': 'en_US.UTF-8', 08:19:51 INFO - 'LANGUAGE': 'en_US:en', 08:19:51 INFO - 'LOGNAME': 'cltbld', 08:19:51 INFO - 'MAIL': '/var/mail/cltbld', 08:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:51 INFO - 'MOZ_NO_REMOTE': '1', 08:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:51 INFO - 'NO_EM_RESTART': '1', 08:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:51 INFO - 'SHELL': '/bin/bash', 08:19:51 INFO - 'SHLVL': '1', 08:19:51 INFO - 'TERM': 'linux', 08:19:51 INFO - 'TMOUT': '86400', 08:19:51 INFO - 'USER': 'cltbld', 08:19:51 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:51 INFO - '_': '/tools/buildbot/bin/python'} 08:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:19:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:54 INFO - Downloading docopt-0.6.1.tar.gz 08:19:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:54 INFO - Running setup.py install for blobuploader 08:19:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:19:54 INFO - Running setup.py install for requests 08:19:54 INFO - Running setup.py install for docopt 08:19:54 INFO - Successfully installed blobuploader requests docopt 08:19:54 INFO - Cleaning up... 08:19:54 INFO - Return code: 0 08:19:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19: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')]} 08:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:54 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19:54 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 08:19:54 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 08:19:54 INFO - Using env: {'DISPLAY': ':0', 08:19:54 INFO - 'HOME': '/home/cltbld', 08:19:54 INFO - 'LANG': 'en_US.UTF-8', 08:19:54 INFO - 'LANGUAGE': 'en_US:en', 08:19:54 INFO - 'LOGNAME': 'cltbld', 08:19:54 INFO - 'MAIL': '/var/mail/cltbld', 08:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:54 INFO - 'MOZ_NO_REMOTE': '1', 08:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:54 INFO - 'NO_EM_RESTART': '1', 08:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:54 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:54 INFO - 'SHELL': '/bin/bash', 08:19:54 INFO - 'SHLVL': '1', 08:19:54 INFO - 'TERM': 'linux', 08:19:54 INFO - 'TMOUT': '86400', 08:19:54 INFO - 'USER': 'cltbld', 08:19:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:54 INFO - '_': '/tools/buildbot/bin/python'} 08:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:55 INFO - Running setup.py (path:/tmp/pip-qCo8pV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:55 INFO - Running setup.py (path:/tmp/pip-o72hvD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:55 INFO - Running setup.py (path:/tmp/pip-lw4Zva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:55 INFO - Running setup.py (path:/tmp/pip-WLyEXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:55 INFO - Running setup.py (path:/tmp/pip-_Bws0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:55 INFO - Running setup.py (path:/tmp/pip-13CPTw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:55 INFO - Running setup.py (path:/tmp/pip-PDp3CY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:55 INFO - Running setup.py (path:/tmp/pip-3f6GAG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:55 INFO - Running setup.py (path:/tmp/pip-ZpTItb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:55 INFO - Running setup.py (path:/tmp/pip-rp4zac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:55 INFO - Running setup.py (path:/tmp/pip-HCVFam-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:55 INFO - Running setup.py (path:/tmp/pip-XaIvYY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:56 INFO - Running setup.py (path:/tmp/pip-pFkCCR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:56 INFO - Running setup.py (path:/tmp/pip-JcsOtL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:56 INFO - Running setup.py (path:/tmp/pip-FeI1Fh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:56 INFO - Running setup.py (path:/tmp/pip-4hWj5F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:56 INFO - Running setup.py (path:/tmp/pip-UZtoZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:56 INFO - Running setup.py install for manifestparser 08:19:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:19:56 INFO - Running setup.py install for mozcrash 08:19:56 INFO - Running setup.py install for mozdebug 08:19:56 INFO - Running setup.py install for mozdevice 08:19:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:19:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:19:56 INFO - Running setup.py install for mozfile 08:19:56 INFO - Running setup.py install for mozhttpd 08:19:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozinfo 08:19:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozInstall 08:19:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozleak 08:19:57 INFO - Running setup.py install for mozlog 08:19:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for moznetwork 08:19:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozprocess 08:19:57 INFO - Running setup.py install for mozprofile 08:19:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozrunner 08:19:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:19:57 INFO - Running setup.py install for mozscreenshot 08:19:57 INFO - Running setup.py install for moztest 08:19:58 INFO - Running setup.py install for mozversion 08:19:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:19:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:58 INFO - Cleaning up... 08:19:58 INFO - Return code: 0 08:19:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:19:58 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')]} 08:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:58 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')]} 08:19:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:58 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:19:58 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 08:19:58 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 08:19:58 INFO - Using env: {'DISPLAY': ':0', 08:19:58 INFO - 'HOME': '/home/cltbld', 08:19:58 INFO - 'LANG': 'en_US.UTF-8', 08:19:58 INFO - 'LANGUAGE': 'en_US:en', 08:19:58 INFO - 'LOGNAME': 'cltbld', 08:19:58 INFO - 'MAIL': '/var/mail/cltbld', 08:19:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:58 INFO - 'MOZ_NO_REMOTE': '1', 08:19:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:58 INFO - 'NO_EM_RESTART': '1', 08:19:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:19:58 INFO - 'PWD': '/builds/slave/test-pgo', 08:19:58 INFO - 'SHELL': '/bin/bash', 08:19:58 INFO - 'SHLVL': '1', 08:19:58 INFO - 'TERM': 'linux', 08:19:58 INFO - 'TMOUT': '86400', 08:19:58 INFO - 'USER': 'cltbld', 08:19:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:19:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:58 INFO - '_': '/tools/buildbot/bin/python'} 08:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:58 INFO - Running setup.py (path:/tmp/pip-d3IwAJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:58 INFO - Running setup.py (path:/tmp/pip-o9k1A0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:58 INFO - Running setup.py (path:/tmp/pip-YQeDnz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:58 INFO - Running setup.py (path:/tmp/pip-t2lZSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:58 INFO - Running setup.py (path:/tmp/pip-yGq0RS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:58 INFO - Running setup.py (path:/tmp/pip-OXmytF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:58 INFO - Running setup.py (path:/tmp/pip-SS9SYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:58 INFO - Running setup.py (path:/tmp/pip-cmqcQl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:19:58 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)) 08:19:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:58 INFO - Running setup.py (path:/tmp/pip-jfiehY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:59 INFO - Running setup.py (path:/tmp/pip-fM_TN0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:59 INFO - Running setup.py (path:/tmp/pip-ID8ffa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:59 INFO - Running setup.py (path:/tmp/pip-X3f0QZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:59 INFO - Running setup.py (path:/tmp/pip-9CvNc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:59 INFO - Running setup.py (path:/tmp/pip-1VmFkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:59 INFO - Running setup.py (path:/tmp/pip-IkNLL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:59 INFO - Running setup.py (path:/tmp/pip-ELnX2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:19:59 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)) 08:19:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:59 INFO - Running setup.py (path:/tmp/pip-4hgxqt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:19:59 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)) 08:19:59 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)) 08:19:59 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)) 08:19:59 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)) 08:19:59 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)) 08:19:59 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)) 08:19:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:20:01 INFO - Downloading blessings-1.6.tar.gz 08:20:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:01 INFO - Installing collected packages: blessings 08:20:01 INFO - Running setup.py install for blessings 08:20:01 INFO - Successfully installed blessings 08:20:01 INFO - Cleaning up... 08:20:01 INFO - Return code: 0 08:20:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:20:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:20:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:20:01 INFO - Reading from file tmpfile_stdout 08:20:01 INFO - Current package versions: 08:20:01 INFO - argparse == 1.2.1 08:20:01 INFO - blessings == 1.6 08:20:01 INFO - blobuploader == 1.2.4 08:20:01 INFO - docopt == 0.6.1 08:20:01 INFO - manifestparser == 1.1 08:20:01 INFO - mozInstall == 1.12 08:20:01 INFO - mozcrash == 0.16 08:20:01 INFO - mozdebug == 0.1 08:20:01 INFO - mozdevice == 0.48 08:20:01 INFO - mozfile == 1.2 08:20:01 INFO - mozhttpd == 0.7 08:20:01 INFO - mozinfo == 0.9 08:20:01 INFO - mozleak == 0.1 08:20:01 INFO - mozlog == 3.1 08:20:01 INFO - moznetwork == 0.27 08:20:01 INFO - mozprocess == 0.22 08:20:01 INFO - mozprofile == 0.28 08:20:01 INFO - mozrunner == 6.11 08:20:01 INFO - mozscreenshot == 0.1 08:20:01 INFO - mozsystemmonitor == 0.0 08:20:01 INFO - moztest == 0.7 08:20:01 INFO - mozversion == 1.4 08:20:01 INFO - psutil == 3.1.1 08:20:01 INFO - requests == 1.2.3 08:20:01 INFO - wsgiref == 0.1.2 08:20:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:20:01 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')]} 08:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:01 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')]} 08:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:01 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:20:01 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 08:20:01 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 08:20:01 INFO - Using env: {'DISPLAY': ':0', 08:20:01 INFO - 'HOME': '/home/cltbld', 08:20:01 INFO - 'LANG': 'en_US.UTF-8', 08:20:01 INFO - 'LANGUAGE': 'en_US:en', 08:20:01 INFO - 'LOGNAME': 'cltbld', 08:20:01 INFO - 'MAIL': '/var/mail/cltbld', 08:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:01 INFO - 'MOZ_NO_REMOTE': '1', 08:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:01 INFO - 'NO_EM_RESTART': '1', 08:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:20:01 INFO - 'PWD': '/builds/slave/test-pgo', 08:20:01 INFO - 'SHELL': '/bin/bash', 08:20:01 INFO - 'SHLVL': '1', 08:20:01 INFO - 'TERM': 'linux', 08:20:01 INFO - 'TMOUT': '86400', 08:20:01 INFO - 'USER': 'cltbld', 08:20:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:01 INFO - '_': '/tools/buildbot/bin/python'} 08:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 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)) 08:20:02 INFO - Cleaning up... 08:20:02 INFO - Return code: 0 08:20:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:20:02 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')]} 08:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:02 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')]} 08:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:02 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:20:02 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 08:20:02 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 08:20:02 INFO - Using env: {'DISPLAY': ':0', 08:20:02 INFO - 'HOME': '/home/cltbld', 08:20:02 INFO - 'LANG': 'en_US.UTF-8', 08:20:02 INFO - 'LANGUAGE': 'en_US:en', 08:20:02 INFO - 'LOGNAME': 'cltbld', 08:20:02 INFO - 'MAIL': '/var/mail/cltbld', 08:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:02 INFO - 'MOZ_NO_REMOTE': '1', 08:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:02 INFO - 'NO_EM_RESTART': '1', 08:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:20:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:20:02 INFO - 'SHELL': '/bin/bash', 08:20:02 INFO - 'SHLVL': '1', 08:20:02 INFO - 'TERM': 'linux', 08:20:02 INFO - 'TMOUT': '86400', 08:20:02 INFO - 'USER': 'cltbld', 08:20:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:02 INFO - '_': '/tools/buildbot/bin/python'} 08:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:02 INFO - Downloading/unpacking jsonschema 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:02 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 08:20:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:04 INFO - Downloading/unpacking functools32 (from jsonschema) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:04 INFO - warning: no files found matching '*.txt' 08:20:04 INFO - no previously-included directories found matching 'build' 08:20:04 INFO - no previously-included directories found matching 'dist' 08:20:04 INFO - no previously-included directories found matching '.git*' 08:20:04 INFO - Installing collected packages: jsonschema, functools32 08:20:04 INFO - Running setup.py install for functools32 08:20:04 INFO - warning: no files found matching '*.txt' 08:20:04 INFO - no previously-included directories found matching 'build' 08:20:04 INFO - no previously-included directories found matching 'dist' 08:20:04 INFO - no previously-included directories found matching '.git*' 08:20:04 INFO - Successfully installed jsonschema functools32 08:20:04 INFO - Cleaning up... 08:20:04 INFO - Return code: 0 08:20:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:04 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 0x7f64a3796f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf13670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, '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': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', '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 08:20:04 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 08:20:04 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 08:20:04 INFO - Using env: {'DISPLAY': ':0', 08:20:04 INFO - 'HOME': '/home/cltbld', 08:20:04 INFO - 'LANG': 'en_US.UTF-8', 08:20:04 INFO - 'LANGUAGE': 'en_US:en', 08:20:04 INFO - 'LOGNAME': 'cltbld', 08:20:04 INFO - 'MAIL': '/var/mail/cltbld', 08:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:04 INFO - 'MOZ_NO_REMOTE': '1', 08:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:04 INFO - 'NO_EM_RESTART': '1', 08:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:20:04 INFO - 'PWD': '/builds/slave/test-pgo', 08:20:04 INFO - 'SHELL': '/bin/bash', 08:20:04 INFO - 'SHLVL': '1', 08:20:04 INFO - 'TERM': 'linux', 08:20:04 INFO - 'TMOUT': '86400', 08:20:04 INFO - 'USER': 'cltbld', 08:20:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:04 INFO - '_': '/tools/buildbot/bin/python'} 08:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:04 INFO - Downloading/unpacking flake8 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:20:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:20:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:06 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 08:20:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:20:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:20:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:20:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:20:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:20:07 INFO - no previously-included directories found matching 'docs/_build' 08:20:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:20:07 INFO - Running setup.py install for pep8 08:20:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:20:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:20:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:20:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:20:07 INFO - no previously-included directories found matching 'docs/_build' 08:20:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:20:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:20:07 INFO - Cleaning up... 08:20:07 INFO - Return code: 0 08:20:07 INFO - Running post-action listener: _resource_record_post_action 08:20:07 INFO - Running post-action listener: _start_resource_monitoring 08:20:07 INFO - Starting resource monitoring. 08:20:07 INFO - ##### 08:20:07 INFO - ##### Running install step. 08:20:07 INFO - ##### 08:20:07 INFO - Running pre-action listener: _resource_record_pre_action 08:20:07 INFO - Running main action method: install 08:20:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:20:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:20:07 INFO - Reading from file tmpfile_stdout 08:20:07 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:20:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:20:08 INFO - Reading from file tmpfile_stdout 08:20:08 INFO - Output received: 08:20:08 INFO - Usage: mozinstall [options] installer 08:20:08 INFO - Options: 08:20:08 INFO - -h, --help show this help message and exit 08:20:08 INFO - -d DEST, --destination=DEST 08:20:08 INFO - Directory to install application into. [default: 08:20:08 INFO - "/builds/slave/test-pgo"] 08:20:08 INFO - --app=APP Application being installed. [default: firefox] 08:20:08 INFO - mkdir: /builds/slave/test-pgo/build/application 08:20:08 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'] 08:20:08 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 08:20:24 INFO - Reading from file tmpfile_stdout 08:20:24 INFO - Output received: 08:20:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:20:24 INFO - Running post-action listener: _resource_record_post_action 08:20:24 INFO - ##### 08:20:24 INFO - ##### Running run-tests step. 08:20:24 INFO - ##### 08:20:24 INFO - Running pre-action listener: _resource_record_pre_action 08:20:24 INFO - Running main action method: run_tests 08:20:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:20:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:20:24 INFO - Python 2.7.3 08:20:24 INFO - Return code: 0 08:20:24 INFO - grabbing minidump binary from tooltool 08:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:20:24 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 0xfa28c0>, '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 0xfa37c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa3c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:20:24 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 08:20:24 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 08:20:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:24 INFO - Return code: 0 08:20:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:20:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:20:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:20:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:20:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:20:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:20:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:20:25 INFO - Return code: 0 08:20:25 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/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 08:20:25 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/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 08:20:25 INFO - Using env: {'DISPLAY': ':0', 08:20:25 INFO - 'HOME': '/home/cltbld', 08:20:25 INFO - 'LANG': 'en_US.UTF-8', 08:20:25 INFO - 'LANGUAGE': 'en_US:en', 08:20:25 INFO - 'LOGNAME': 'cltbld', 08:20:25 INFO - 'MAIL': '/var/mail/cltbld', 08:20:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:20:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:25 INFO - 'MOZ_NO_REMOTE': '1', 08:20:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:25 INFO - 'NO_EM_RESTART': '1', 08:20:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:20:25 INFO - 'PWD': '/builds/slave/test-pgo', 08:20:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:20:25 INFO - 'SHELL': '/bin/bash', 08:20:25 INFO - 'SHLVL': '1', 08:20:25 INFO - 'TERM': 'linux', 08:20:25 INFO - 'TMOUT': '86400', 08:20:25 INFO - 'USER': 'cltbld', 08:20:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735', 08:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:25 INFO - '_': '/tools/buildbot/bin/python'} 08:20:25 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/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 08:20:25 INFO - mozversion application_buildid: 20160224053021 08:20:25 INFO - mozversion application_changeset: 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 08:20:25 INFO - mozversion application_display_name: Nightly 08:20:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:25 INFO - mozversion application_name: Firefox 08:20:25 INFO - mozversion application_remotingname: firefox 08:20:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:20:25 INFO - mozversion application_vendor: Mozilla 08:20:25 INFO - mozversion application_version: 47.0a1 08:20:25 INFO - mozversion platform_buildid: 20160224053021 08:20:25 INFO - mozversion platform_changeset: 1b9d91965921cc7d3f7c9d6684315bc7ace03a17 08:20:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:20:25 INFO - mozversion platform_version: 47.0a1 08:20:25 INFO - using testdate: 1456330825 08:20:25 INFO - actual date: 1456330825 08:20:25 INFO - starting webserver on 'localhost:44913' 08:20:25 INFO - SUITE-START | Running 2 tests 08:20:25 INFO - TEST-START | dromaeo_css 08:20:25 INFO - operating with platform_type : linux_ 08:20:25 INFO - Initialising browser for dromaeo_css test... 08:20:25 INFO - TEST-INFO | started process 449 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi9cqoo/profile http://localhost:44913/getInfo.html) 08:20:29 INFO - PROCESS | 449 | __metrics Screen width/height:1600/1200 08:20:29 INFO - PROCESS | 449 | colorDepth:24 08:20:29 INFO - PROCESS | 449 | Browser inner width/height: 1024/697 08:20:29 INFO - PROCESS | 449 | __metrics 08:20:30 INFO - PROCESS | 449 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:31 INFO - TEST-INFO | 449: exit 0 08:20:31 INFO - Browser initialized. 08:20:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:20:31 INFO - TEST-INFO | started process 547 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi9cqoo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:42 INFO - PROCESS | 547 | RSS: Main: 147193856 08:20:42 INFO - PROCESS | 547 | 08:21:34 INFO - PROCESS | 547 | 1456330894342 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] 08:23:42 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44913/tests/dromaeo/cssquery-ext.html) 08:23:43 INFO - PROCESS | 547 | RSS: Main: 265707520 08:23:43 INFO - PROCESS | 547 | 08:26:45 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-ext.html (next: http://localhost:44913/tests/dromaeo/cssquery-jquery.html) 08:26:46 INFO - PROCESS | 547 | RSS: Main: 236957696 08:26:46 INFO - PROCESS | 547 | 08:29:48 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44913/tests/dromaeo/cssquery-mootools.html) 08:29:49 INFO - PROCESS | 547 | RSS: Main: 231911424 08:29:49 INFO - PROCESS | 547 | 08:32:51 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44913/tests/dromaeo/cssquery-prototype.html) 08:32:51 INFO - PROCESS | 547 | RSS: Main: 207060992 08:32:51 INFO - PROCESS | 547 | 08:35:54 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44913/tests/dromaeo/cssquery-yui.html) 08:35:54 INFO - PROCESS | 547 | RSS: Main: 172466176 08:35:54 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | Cycle 1(1): loaded http://localhost:44913/tests/dromaeo/cssquery-yui.html (next: http://localhost:44913/tests/dromaeo/cssquery-dojo.html) 08:38:57 INFO - PROCESS | 547 | RSS: Main: 257634304 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | __start_tp_report 08:38:57 INFO - PROCESS | 547 | _x_x_mozilla_page_load 08:38:57 INFO - PROCESS | 547 | _x_x_mozilla_page_load_details 08:38:57 INFO - PROCESS | 547 | |i|pagename|runs| 08:38:57 INFO - PROCESS | 547 | |0;dojo.html;3003.264200270934;3054.9083527494167;3056.831874246917;3083.121310426528;3102.519109538022;5050.621203409745;5067.974660126703;5084.669496482726;5090.669106508079;5121.103806833803;5136.512031357024;5170.870728231796;5177.352830896138;5195.58435325174;5225.320708307924;4742.549457801503;4752.287156926454;4795.664303498756;4803.663743537953;4903.730294833783;4866.31871537985;4884.242942343943;4886.609071274307;4906.1168989581865;4935.161022626145;4680.461746899116;4701.976490117545;4737.857864264078;4776.140294746944;4800.207965685658;4667.509911459316;4682.344471773954;4693.6245100392225;4703.976480117578;4705.670603057787;4645.256758918556;4665.393498845162;4681.016986432854;4713.905721885578;4729.834455794031;4984.975075124637;4987.202047672355;4996.825111121093;4996.9500304996845;5022.949770502321;5482.862928426821;5492.423295553989;5498.367687715924;5541.889162216773;5542.889142217174;5507.807226747044;5559.583031272671;5578.079616863212;5648.604597678164;5658.066419040853;5252.6323157379;5268.341457317835;5269.762860671279;5275.551578115865;5279.709615971082;5612.045952188057;5708.857278567986;5716.857078573069;5721.914171287434;5728.398518155617;5411.242426060355;5486.588505862076;5504.724763761796;5505.9724701376235;5558.666480011212;5467.644603100785;5479.643823151482;5491.093969494988;5497.230387745719;5504.614676972574;5445.591580631469;5485.396606373296;5518.19986102013;5533.363663178786;5605.523530499871;5526.723663816793;5536.363318218376;5542.86142846424;5548;5554.750036248379;4338.522762496123;4339.609435150852;4342.066455712037;4373.693841431133;4377.934330985037;3767.2653832502947;3842.423636454498;3869.555001174901;3894.824732887027;3906.277338692351;5158.4067832199025;5166.5866730661455;5167.560757335594;5181.637285390062;5215.243789650555;5455.972720136453;5528.723563821793;5533.806316778893;5545;5554.611177217556;5119.513646203604;5122.206058061007;5131.332926719502;5147.433782283946;5188.22176673502;4702.600278976325;4731.4139017000225;4739.834105806281;4748.406449193851;4781.6891902026255;5640.125780504029;5764.337101233412;5811.389804070596;5821.679807610622;5841.123831425235;5485.6434331768305;5508.7521061553125;5523.6685798852195;5571.693556854412;5577.27495425592;5716.828495145152;5719.884622498739;5729.656220626775;5754.827355179351;5775.249217601685;5386.272853164773;5451.890962180813;5455.208994695826;5474.3704473986;5529.972350138223;5536.003519366553;5544.3346798384455;5546.611737178358;5551.583631227593;5577.247071645276;5393.568514518907;5418.512333889968;5429.972850135724;5437.075697131576;5482.23248745184;5267.57859371257;5372.811951581676;5397.298351214317;5425.484578964992;5463.180522921593;5273.604479664117;5286.286351342519;5300.6024548158275;5303.178007408857;5307.203919411964;5318;5384.9730751346;5441.673499590037;5447.0467668157125;5452.672839629635;5246.108161612458;5317.893642127213;5321.467853214803;5353.116735738715;5359.785608575613 08:38:57 INFO - PROCESS | 547 | |1;ext.html;539.5629540072543;580.3587036324861;593.6675461741423;598.9311229208639;600.0938582740063;36248.81875590625;36263.27473450529;36333.273334533325;36413.27173456536;36427;38982.610173898254;39481.407778883266;39498.605013949855;39509.40735888957;39530.20939581207;8430.53632050237;8650.783730406758;8659.95670021649;8667.913320866774;8671.176238257387;8438.11399803021;8539.359548033892;8558;8773.736787896374;8774.824503509926;8773.210411063003;8814.86777698335;8821.823563528726;8851.159139881702;8860.556972151368;8670.566471676422;8757.080506546848;8781.34139939507;8782.341324400631;8789.033206347296;8683.60923758426;8789.208971192624;8794.51630160341;8810.074942131048;8811.515366654832;38840.22319553593;39323;39374.606253937665;39391.60608393908;39402.408963865564;2137.9893100534555;3260.750520226601;3339.3989081965237;3386.136535183537;3391.8473668684724;26409.603855942176;26849;26867.73132268672;27075.72924270752;27626.447471050466;3685.1708365617524;3710.573284072312;3770.6794922431627;3922.490076290064;3959.742616729903;218983.90508047518;220194;220757;221030;221064;50409.495905041214;53910.191347129825;54128;54602.72698636481;57848;53862.46137538574;54021.45978540243;54522;54562.727186363816;54615.18077228845;16086.75869861953;16247.59381015484;16280.43018494347;16308.673826523403;16309.347626094823;11438.256513326607;11455.885441145649;11456.255343402652;11458.312501249951;11492.25300355491;19206.07209116086;19606.80393196078;19615.215391384183;19620.215191392468;19641.901790490956;7611.619419029137;7726.34326082278;7816.7264145754625;7875.330596899328;7884.053913530413;839.9962045355741;915.8122584870085;1002.1682003936716;1016.6289304403987;1064.4837253931837;28608.14175574736;29330.706692933225;29580;29720.702792972224;29732.256693582833;1013.5287091502487;1025.5231317437429;1046.9581216751396;1058.0794708603564;1060.989390106089;15266.313015914311;15365.462208822637;15640.296186671627;15767.86992128483;15837.208139593205;356544;358158;358490;358870;359888;53058.46941530613;54106;54137.458625413245;54147.18779218315;54178;1138.3966497756203;1226.589092653971;1311.5475161069608;1343.2544937559553;1464.1434760664918;26845.731542684323;29313;30153.547696784128;30546.389072217986;30720.231994200323;40375.78872633826;41228.38157427701;41466.58533414627;41729.37405938852;41953.790231048646;189658;190517;190630;191324;346684;31148.598313075512;31841.522377164823;31849.522257165696;31874.84062579672;31884.202894927814;42478;43014.13971720485;43344.349834753135;43559.78220108879;44065;36059.81970090133;36221.27557448889;36481.27037459289;41317.38023929583;42328.78835605802;40506.79746601248;41070.58929410668;41163.794181028905;41782.58217417787;42392.788036059625;36027.63972360243;36483.452748209325;36926.815365923;36950.6304936958;37074.6292537082;35789.64210357863;36573.45139822958;36585;36822.63177368192;36972.44541331936;24985.87507062453;26803.19590412291;26827.195184144508;26850.731492685605;27126.864365678044 08:38:57 INFO - PROCESS | 547 | |2;jquery.html;358.48915295703625;361.74858473361024;362.6518542199489;368.92068205335846;369.85021066468073;13714.24571648559;16808.74786878198;16862.662746745056;16867.57831054224;17695.380661676827;16165.272562734675;16309.83690163098;16560.420385286518;17540.649187016254;17547.12264386782;5321.175217841241;5451.863703407426;5474.151506516497;5481.205225242337;5501.119820828668;3729.384651532494;5262.105442074857;5333.839984800462;5480.068388373986;5480.479354461339;5427.782888684448;5450;5456.208849716789;5493.642913210629;5496.80761173359;5376.784928602851;5396.865078373053;5416.295881535395;5511.724413779335;5534.308211473566;5277.656952298088;5291.86770330741;5293.602979776494;5294.97352513235;5310.8141215057285;13383;17765.822341776548;20852.687209691867;20913.790862091337;20947.266845660328;2118.480972161815;2236.5303286309895;2239.6528538076623;2252.279270633398;2355.729091154522;9554.474503902282;9563.61745530185;9790.853137202948;9803.558839852223;10134.54394552247;1798.352593066495;1854.7403363529118;1857.811000959387;1867.8412334951545;1905.4378958207362;64231;64989;65248.3475165247;66696.6665166676;67730.66134669345;10365.118964887919;10427.113695335982;10435.37387756737;10442.321249118782;10453.477326133663;13780.035397522277;13801.585952421243;13828.516001939885;13847.515336963157;13850.307484625728;7599.544027358376;7732.806679833049;7734.071911370672;7780.766577002699;7797.532148071134;7486.32623063916;7488.288612581796;7497.850042999109;7556.2443755624;7565.394768418513;4509.594136527729;4568.56598623137;4589.495155532889;4592.425946756655;4629.236176030984;1729.6713624411323;1755.3505203074944;1827.2873579304082;1869.6260747850483;1875.6017139807132;879.6437442835662;887.8179973105498;896.5338024227365;905.4522014181325;1003.6487229469627;16308.510744677678;16556.089415082046;16781.916090419712;17420;17427.73858392125;946.6402766948515;953.0394297680556;957.3777044920857;1019.1948360794889;1068.759529105945;9705.175060119827;9783.315167938175;9847.45838978863;9853.655122070693;10000.2999790014;343333.28333358176;408828;409180;409678;429912;70615;73603;75075.24924750792;75347;76742.6162869182;1039.1271332080937;1043.6973277749519;1046.5761366646673;1064.21248276275;1066.2909165405074;12687;14825.332860021541;15208.46770363032;15495;15700.293486792893;31035.534466983467;31144.377112458078;31189.68810311868;31850.522242165924;31866.36267274688;38666.226675466896;38774.2245155101;39115.608843912334;39249.607503925734;39324.213515730095;8025.23760242776;8109.270165685117;8359.707410240613;8364.539950302791;8388.286995605198;11638.941805290919;12118.151729378858;12214.816777748163;12322.383880806103;12709.555165569162;10956.890431095588;11316.434178291218;11319.773604528027;11561.710957226136;11612.187146899636;6901.827454313682;8873.245774109273;11270.718232044264;11485;11609.419529023684;11327.716807079889;11575.247608905394;11739.589114381297;11774.646760597196;11798.351090690094;8013.519188848688;8283.751487455385;8342.582870856555;8408.285295749685;8479.788005299917;9397.765055873659;10803.081738052353;11009.559617615205;11154.832677509681;11294.491747871201 08:38:57 INFO - PROCESS | 547 | |3;mootools.html;1269.6254604891556;1481.4370539195104;1492.813398325209;1631.910244936528;1780.706183479726;7304.160021597511;7520.699172033119;7529.66116524757;7535;7540.585267810282;7391.741289054884;7549.849003019936;7559.092908850946;7573.962130189341;7585.127710313315;1958.8237058664718;2002.3392280547457;2216.3683350245183;2247.1685476373723;2280.384296240014;2306.723193216808;2310.7111611048617;2313.0169677886915;2322.8606283622953;2324.012294774714;2249.3701763506165;2259.197984715427;2306.7001289832297;2309.896054677535;2310.1452462588863;2247.6965609642652;2269.341890851659;2278.715160604924;2281.1445707859552;2292.5071109711494;2260.8191344692386;2269.5574362999223;2280.1791355112146;2281.908723651052;2285.1430713482446;7634.541927484369;7694.153643099311;7709.768706938801;7716.228377162295;7717.305442510201;4776.761161941889;4835.782389792468;4848.490908454597;4878.414590249193;4895.167821470359;3127.218195451137;3143.6070491188602;3191.329820737648;3212.61448626164;3237.4010808000594;1144.1876267849836;1814.2561549764532;1848.5009047557085;1849.9907500462411;1873.3162395725599;10121;10167.644132455329;10217.2847900647;10241.795164096751;10246.282760206788;4129.628333449944;4139.689523285766;4198.391233271159;4203.873883783492;4289.892752681208;8186;8203.753887383387;8237.382196335298;8255.669773209125;8278.627461764236;4800.903981920412;4802.423709154854;4839.491853355417;4844.878878028077;4845.297431872429;3765.4163604641326;4272.380504826782;4382.079763249753;4393.51671316155;4396.098799746044;3446.6553344665836;3465.2722928184858;3476.6349533299144;3488.7732297401094;3513.2446523997464;1002.8896821349646;1003.5935446144323;1050.7058023753361;1088.7604726960055;1093.3112139352156;1253.9937300313622;1262.040848954801;1279.3795009420423;1302.1145620977827;1303.589369348652;6901.930980690229;6940.305969403019;7147.106611673541;7237.638118094074;7245.347918687344;1098.5825386353135;1106.397013627575;1110.622388387952;1116.391566596207;1155.3703231738723;5662.6036177468;5692.459216374438;5742.167385729046;5745.597808153389;5747.971260143756;8782;8852.645894164161;9106.089391060841;9214.078592140866;9244.029376915461;9134.862977055349;9169.495677737656;9197.954010229905;9283;9285.978542360335;6994.055802466703;7169.032180655545;7169.856602868018;7347.191808901017;7446.813829654302;6882.621455819978;6973.442124629916;6992.195897471653;7000.579965202104;7017.894731578928;7813.296803287732;8029.598520073856;8226.42415030966;8253.174682531699;8253.83492330162;8230.09468958402;8489.74530764078;8665.783355415913;8668.52323122209;8672.479651220947;6021.096835474714;6170.629762214281;6171.814845554461;6656.7004484797335;6778.7288508459105;6512.185976752906;7183.820404489929;7385.778426647209;7406.222346653739;7444.032275804328;6706.6646667665445;6760.391564759196;6763.391294783493;6897.448204143556;6918.5502942308585;6703.66481675924;6761.425278851353;6761.594304341756;6787.253402125861;6847;6698.665066746546;6801.251862295045;6814.965925170342;6824.351686589766;6828.2830302819475;6307.211598550181;6318.304986451395;6368.490520758421;6372.490200783834;6375.7449702013255;6114.938850611437;6160.137580738789;6190.50475961931;6192.783252586138;6207.565470417027 08:38:57 INFO - PROCESS | 547 | |4;prototype.html;336.39952684458245;338.6697969479757;341.06888195227043;344.17569920041507;348.8517380113451;5674.971625141869;5789.710514474281;5800.622959507635;5901.232839730835;5905.911411328833;5785.566082543805;5812;5819.272590926134;5822.475977162055;5841.941580584193;4581.702189357689;4593.058423023289;4593.908121837561;4601.7345230061665;4605.700629459075;4358.5423530529315;4448.354988526662;4485.215087359716;4540.931886021713;4597.264437689971;4471.150481408538;4491.124230775;4491.842785502508;4495.011097558532;4501.977490112545;4486.663500237462;4486.753228572427;4488.304312831517;4502.5047244803045;4504.076664283814;3966.841326346943;3968.0873399118077;3968.6825053995613;3970.7021973352116;3976.6619837313865;5521.033819081645;5542.279503664538;5542.584306177053;5545.279113715232;5549.500544950974;5257;5258.13240815265;5260.473952604709;5263.657862238981;5264.657797243205;5946.821595352147;6150.323464418955;6184.350643182491;6225.408586184305;6263.185785847856;4302.913941721179;4306.20335237982;4306.6124048835445;4307.923019245189;4311.698181127323;6231.844203894893;6370.076338930876;6376.234851817811;6452.774152904626;6453.677316134174;4377.190219809346;4398.956010439919;4399.73601583906;4402.097569998143;4412.5659160772875;4455.376247325377;4460.041091165415;4464.285714285698;4464.285714285698;4464.3973063635995;5131.281620573122;5142.997115562504;5146.459621739738;5147.845564632992;5150.0472412603785;5854.268216472941;6046.667433291123;6184.319724830265;6198.039303907902;6211.937880621226;1546.427821705976;1562.4453319071793;1568.6235303527071;1569.6389830339085;1574.1342261755988;1034.4155552113032;1048.9475526223812;1049.9212559057949;1061.7186445591924;1067.9412632305143;5860.359099452075;5861.736221870026;5871.060630299132;5874.9118763218585;5877;6410.807675769641;6447.484201263887;6449.677516124175;6452.290248072708;6455.064015717789;5864.70676466175;5867.354590994987;5870.677112758839;5871.148683440877;5872.031114866085;3396.558447401822;3420.846061927219;3424.5719285089363;3432.7253819694365;3434.8797792077157;6505.967470162619;6640.468762498988;6644.634545099969;6746.4265537429865;6752.594844309259;6564.245111812203;6588.308227636125;6596.8350791230605;6603.570767900071;6612.0412540181405;6735.360140786617;6735.494837887178;6735.932640673628;6736.360045795642;6737.393634572912;6407.327230640902;6440.420362167428;6449.226092868886;6451.935480645134;6456.483481321577;5740.512056475246;6029.095635654687;6361.141245931925;6369.777057802955;6381.904271436025;6485.54601177913;6559.934400655932;6677.332266773478;6730.0241464988285;6799.354061364163;4394.362817391397;4421.314696222091;4430.224710675683;4431.224535706303;4435.9556404436835;6172.382761723792;6322.178116844781;6413.005984072476;6427.228732552124;6430.64631445275;6088;6191.876162476635;6199.1011303361665;6204.689765511616;6278.748850045947;6235.314115447388;6237.594556353823;6245.18812554365;6246.406591373812;6252.155958945484;6075.513958883367;6080.087986802015;6137.079438084144;6146.293176284785;6154.169187159676;6281.120643109877;6281.371862813865;6281.434670879643;6282.685865706605;6285.717142728679;5873.794417195549;6014;6026.397360263939;6027.18632984559;6131.478824299985 08:38:57 INFO - PROCESS | 547 | |5;yui.html;710.3784188834769;799.1050023973149;817.7464985854385;832.1512057701145;855.6278019061707;13666.31668416579;13825.101368411046;13828.377723002464;13858.792118118212;13875.375608097635;13159.144655597403;13212.669683257924;13249.536266230683;13264.204147751117;13277.800832987488;680.7685386968429;812.5937031484258;813.4712436916022;819.4018366592392;821.0680877204356;827.0199813221321;829.5271695133777;829.531314807132;830.248624994378;835.0188528479043;872.7556284240422;877.9648814047431;879.8020445399798;881.1012766977678;881.8721285413643;701.3757755597471;870.0646804684989;870.8476016697084;871.8430682477151;872.4808738800435;630.2153818495956;640.4332166033048;641.3586413586413;641.4804008752925;642.1267076775628;13567.321633918265;13613.523526676618;13617;13629.931850340785;13635.727285454335;12863.742725145445;12888.871111288954;13668.52160174399;13844.515441959484;13875.098118622258;10802.189835762349;10847.132229421628;10888.40113793741;10944.343339399582;11072.335659860435;3611.855525778966;3675.5773086095173;3707.647773461517;3713.925721485555;3790.431435284702;48108.27837582439;48563.75718121422;48572.271415928786;48602.27096593554;48805.755971219914;10459.68620941373;10509.264351495474;10536;10855.45722713877;11033.337999720043;17745;17918.820811791975;17928.9103554484;17974.843018837822;17982.550436238937;7736.7678969631;7920.247576480225;8009.399295052895;8101;8123.4313598047565;4410.757408342572;4426.203283408953;4429.579189976947;4447.977760111179;4523.411956445641;3234.75739319552;3278.9836050819595;3279.8360081995806;3286.4413049781597;3286.8520916558814;617.8970537590379;624.9000159974473;625.2059883947361;635.1774452084561;640.6220330005319;630.6941133550224;708.143146792387;719.4496210399049;722.7723267170825;733.7028503456108;8984.32617553686;9373.1564159226;9506.287028472892;9551.522423878918;9752.21982241419;675.6689222281046;704.2604269391967;708.3518580498888;719.9712011519586;736.9498464687798;4022.6178513041214;4171.937420938689;4185.958140418617;4212.5361735135;4354.477462704495;54919.725401372736;55772.16341754877;55851.441485584626;56063.71968140133;56340;48875.511244887806;49406.75296623494;50508;50682.74658626683;50768;45303.32045019327;45601.54398455973;45777.31334029992;45810.31284530668;46460;8016.7194148204535;8198.754037378889;8332.416730828783;8366.790830229293;8374.665013399639;33089.834550827094;33350;37176.81411593033;38347.2330553393;39204.607953920095;49225.26162107643;49434;49619.50380496149;50263.246051309994;50356.24465632945;11464.197506174487;11567.942160289145;12050.035997120034;12331.815022774845;12348.970503065266;12068.879311206776;12365.629031129081;12707.301098439675;12728.6817829555;12918.22490650564;8417.747467575982;10749.570017199538;11195.944020279847;11377.715557111138;11443.771124577628;11698.532058717896;11802.23285486475;11810.645680629596;11814;11835.70410739704;11324;11403.885961140615;11512.94243528777;11594.536218551164;11613.76772464563;9419.905800941902;9694;9967.850482242628;9995.70012899614;10021.148202402877;10169.796604068026;10214.285000049926;10424.947875260576;10429.26995110335;10460.26778125524 08:38:57 INFO - PROCESS | 547 | __end_tp_report 08:38:57 INFO - PROCESS | 547 | __start_cc_report 08:38:57 INFO - PROCESS | 547 | _x_x_mozilla_cycle_collect,938 08:38:57 INFO - PROCESS | 547 | __end_cc_report 08:38:57 INFO - PROCESS | 547 | __startTimestamp1456331937584__endTimestamp 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | ------- Summary: start ------- 08:38:57 INFO - PROCESS | 547 | Number of tests: 6 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#0] dojo.html Cycles:165 Average:5149.64 Median:5317.89 stddev:562.88 (10.6%) stddev-sans-first:538.84 08:38:57 INFO - PROCESS | 547 | Values: 3003.3 3054.9 3056.8 3083.1 3102.5 5050.6 5068.0 5084.7 5090.7 5121.1 5136.5 5170.9 5177.4 5195.6 5225.3 4742.5 4752.3 4795.7 4803.7 4903.7 4866.3 4884.2 4886.6 4906.1 4935.2 4680.5 4702.0 4737.9 4776.1 4800.2 4667.5 4682.3 4693.6 4704.0 4705.7 4645.3 4665.4 4681.0 4713.9 4729.8 4985.0 4987.2 4996.8 4997.0 5022.9 5482.9 5492.4 5498.4 5541.9 5542.9 5507.8 5559.6 5578.1 5648.6 5658.1 5252.6 5268.3 5269.8 5275.6 5279.7 5612.0 5708.9 5716.9 5721.9 5728.4 5411.2 5486.6 5504.7 5506.0 5558.7 5467.6 5479.6 5491.1 5497.2 5504.6 5445.6 5485.4 5518.2 5533.4 5605.5 5526.7 5536.4 5542.9 5548.0 5554.8 4338.5 4339.6 4342.1 4373.7 4377.9 3767.3 3842.4 3869.6 3894.8 3906.3 5158.4 5166.6 5167.6 5181.6 5215.2 5456.0 5528.7 5533.8 5545.0 5554.6 5119.5 5122.2 5131.3 5147.4 5188.2 4702.6 4731.4 4739.8 4748.4 4781.7 5640.1 5764.3 5811.4 5821.7 5841.1 5485.6 5508.8 5523.7 5571.7 5577.3 5716.8 5719.9 5729.7 5754.8 5775.2 5386.3 5451.9 5455.2 5474.4 5530.0 5536.0 5544.3 5546.6 5551.6 5577.2 5393.6 5418.5 5430.0 5437.1 5482.2 5267.6 5372.8 5397.3 5425.5 5463.2 5273.6 5286.3 5300.6 5303.2 5307.2 5318.0 5385.0 5441.7 5447.0 5452.7 5246.1 5317.9 5321.5 5353.1 5359.8 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#1] ext.html Cycles:180 Average:44023.42 Median:36703.82 stddev:72597.54 (197.8%) stddev-sans-first:72727.78 08:38:57 INFO - PROCESS | 547 | Values: 539.6 580.4 593.7 598.9 600.1 36248.8 36263.3 36333.3 36413.3 36427.0 38982.6 39481.4 39498.6 39509.4 39530.2 8430.5 8650.8 8660.0 8667.9 8671.2 8438.1 8539.4 8558.0 8773.7 8774.8 8773.2 8814.9 8821.8 8851.2 8860.6 8670.6 8757.1 8781.3 8782.3 8789.0 8683.6 8789.2 8794.5 8810.1 8811.5 38840.2 39323.0 39374.6 39391.6 39402.4 2138.0 3260.8 3339.4 3386.1 3391.8 26409.6 26849.0 26867.7 27075.7 27626.4 3685.2 3710.6 3770.7 3922.5 3959.7 218983.9 220194.0 220757.0 221030.0 221064.0 50409.5 53910.2 54128.0 54602.7 57848.0 53862.5 54021.5 54522.0 54562.7 54615.2 16086.8 16247.6 16280.4 16308.7 16309.3 11438.3 11455.9 11456.3 11458.3 11492.3 19206.1 19606.8 19615.2 19620.2 19641.9 7611.6 7726.3 7816.7 7875.3 7884.1 840.0 915.8 1002.2 1016.6 1064.5 28608.1 29330.7 29580.0 29720.7 29732.3 1013.5 1025.5 1047.0 1058.1 1061.0 15266.3 15365.5 15640.3 15767.9 15837.2 356544.0 358158.0 358490.0 358870.0 359888.0 53058.5 54106.0 54137.5 54147.2 54178.0 1138.4 1226.6 1311.5 1343.3 1464.1 26845.7 29313.0 30153.5 30546.4 30720.2 40375.8 41228.4 41466.6 41729.4 41953.8 189658.0 190517.0 190630.0 191324.0 346684.0 31148.6 31841.5 31849.5 31874.8 31884.2 42478.0 43014.1 43344.3 43559.8 44065.0 36059.8 36221.3 36481.3 41317.4 42328.8 40506.8 41070.6 41163.8 41782.6 42392.8 36027.6 36483.5 36926.8 36950.6 37074.6 35789.6 36573.5 36585.0 36822.6 36972.4 24985.9 26803.2 26827.2 26850.7 27126.9 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#2] jquery.html Cycles:180 Average:24068.99 Median:365.79 stddev:65906.71 (18017.8%) stddev-sans-first:66067.55 08:38:57 INFO - PROCESS | 547 | Values: 358.5 361.7 362.7 368.9 369.9 13714.2 16808.7 16862.7 16867.6 17695.4 16165.3 16309.8 16560.4 17540.6 17547.1 5321.2 5451.9 5474.2 5481.2 5501.1 3729.4 5262.1 5333.8 5480.1 5480.5 5427.8 5450.0 5456.2 5493.6 5496.8 5376.8 5396.9 5416.3 5511.7 5534.3 5277.7 5291.9 5293.6 5295.0 5310.8 13383.0 17765.8 20852.7 20913.8 20947.3 2118.5 2236.5 2239.7 2252.3 2355.7 9554.5 9563.6 9790.9 9803.6 10134.5 1798.4 1854.7 1857.8 1867.8 1905.4 64231.0 64989.0 65248.3 66696.7 67730.7 10365.1 10427.1 10435.4 10442.3 10453.5 13780.0 13801.6 13828.5 13847.5 13850.3 7599.5 7732.8 7734.1 7780.8 7797.5 7486.3 7488.3 7497.9 7556.2 7565.4 4509.6 4568.6 4589.5 4592.4 4629.2 1729.7 1755.4 1827.3 1869.6 1875.6 879.6 887.8 896.5 905.5 1003.6 16308.5 16556.1 16781.9 17420.0 17427.7 946.6 953.0 957.4 1019.2 1068.8 9705.2 9783.3 9847.5 9853.7 10000.3 343333.3 408828.0 409180.0 409678.0 429912.0 70615.0 73603.0 75075.2 75347.0 76742.6 1039.1 1043.7 1046.6 1064.2 1066.3 12687.0 14825.3 15208.5 15495.0 15700.3 31035.5 31144.4 31189.7 31850.5 31866.4 38666.2 38774.2 39115.6 39249.6 39324.2 8025.2 8109.3 8359.7 8364.5 8388.3 11638.9 12118.2 12214.8 12322.4 12709.6 10956.9 11316.4 11319.8 11561.7 11612.2 6901.8 8873.2 11270.7 11485.0 11609.4 11327.7 11575.2 11739.6 11774.6 11798.4 8013.5 8283.8 8342.6 8408.3 8479.8 9397.8 10803.1 11009.6 11154.8 11294.5 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#3] mootools.html Cycles:180 Average:5340.45 Median:6068.02 stddev:2669.95 (44.0%) stddev-sans-first:2659.90 08:38:57 INFO - PROCESS | 547 | Values: 1269.6 1481.4 1492.8 1631.9 1780.7 7304.2 7520.7 7529.7 7535.0 7540.6 7391.7 7549.8 7559.1 7574.0 7585.1 1958.8 2002.3 2216.4 2247.2 2280.4 2306.7 2310.7 2313.0 2322.9 2324.0 2249.4 2259.2 2306.7 2309.9 2310.1 2247.7 2269.3 2278.7 2281.1 2292.5 2260.8 2269.6 2280.2 2281.9 2285.1 7634.5 7694.2 7709.8 7716.2 7717.3 4776.8 4835.8 4848.5 4878.4 4895.2 3127.2 3143.6 3191.3 3212.6 3237.4 1144.2 1814.3 1848.5 1850.0 1873.3 10121.0 10167.6 10217.3 10241.8 10246.3 4129.6 4139.7 4198.4 4203.9 4289.9 8186.0 8203.8 8237.4 8255.7 8278.6 4800.9 4802.4 4839.5 4844.9 4845.3 3765.4 4272.4 4382.1 4393.5 4396.1 3446.7 3465.3 3476.6 3488.8 3513.2 1002.9 1003.6 1050.7 1088.8 1093.3 1254.0 1262.0 1279.4 1302.1 1303.6 6901.9 6940.3 7147.1 7237.6 7245.3 1098.6 1106.4 1110.6 1116.4 1155.4 5662.6 5692.5 5742.2 5745.6 5748.0 8782.0 8852.6 9106.1 9214.1 9244.0 9134.9 9169.5 9198.0 9283.0 9286.0 6994.1 7169.0 7169.9 7347.2 7446.8 6882.6 6973.4 6992.2 7000.6 7017.9 7813.3 8029.6 8226.4 8253.2 8253.8 8230.1 8489.7 8665.8 8668.5 8672.5 6021.1 6170.6 6171.8 6656.7 6778.7 6512.2 7183.8 7385.8 7406.2 7444.0 6706.7 6760.4 6763.4 6897.4 6918.6 6703.7 6761.4 6761.6 6787.3 6847.0 6698.7 6801.3 6815.0 6824.4 6828.3 6307.2 6318.3 6368.5 6372.5 6375.7 6114.9 6160.1 6190.5 6192.8 6207.6 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#4] prototype.html Cycles:180 Average:5190.33 Median:5861.05 stddev:1557.56 (26.6%) stddev-sans-first:1518.73 08:38:57 INFO - PROCESS | 547 | Values: 336.4 338.7 341.1 344.2 348.9 5675.0 5789.7 5800.6 5901.2 5905.9 5785.6 5812.0 5819.3 5822.5 5841.9 4581.7 4593.1 4593.9 4601.7 4605.7 4358.5 4448.4 4485.2 4540.9 4597.3 4471.2 4491.1 4491.8 4495.0 4502.0 4486.7 4486.8 4488.3 4502.5 4504.1 3966.8 3968.1 3968.7 3970.7 3976.7 5521.0 5542.3 5542.6 5545.3 5549.5 5257.0 5258.1 5260.5 5263.7 5264.7 5946.8 6150.3 6184.4 6225.4 6263.2 4302.9 4306.2 4306.6 4307.9 4311.7 6231.8 6370.1 6376.2 6452.8 6453.7 4377.2 4399.0 4399.7 4402.1 4412.6 4455.4 4460.0 4464.3 4464.3 4464.4 5131.3 5143.0 5146.5 5147.8 5150.0 5854.3 6046.7 6184.3 6198.0 6211.9 1546.4 1562.4 1568.6 1569.6 1574.1 1034.4 1048.9 1049.9 1061.7 1067.9 5860.4 5861.7 5871.1 5874.9 5877.0 6410.8 6447.5 6449.7 6452.3 6455.1 5864.7 5867.4 5870.7 5871.1 5872.0 3396.6 3420.8 3424.6 3432.7 3434.9 6506.0 6640.5 6644.6 6746.4 6752.6 6564.2 6588.3 6596.8 6603.6 6612.0 6735.4 6735.5 6735.9 6736.4 6737.4 6407.3 6440.4 6449.2 6451.9 6456.5 5740.5 6029.1 6361.1 6369.8 6381.9 6485.5 6559.9 6677.3 6730.0 6799.4 4394.4 4421.3 4430.2 4431.2 4436.0 6172.4 6322.2 6413.0 6427.2 6430.6 6088.0 6191.9 6199.1 6204.7 6278.7 6235.3 6237.6 6245.2 6246.4 6252.2 6075.5 6080.1 6137.1 6146.3 6154.2 6281.1 6281.4 6281.4 6282.7 6285.7 5873.8 6014.0 6026.4 6027.2 6131.5 08:38:57 INFO - PROCESS | 547 | 08:38:57 INFO - PROCESS | 547 | [#5] yui.html Cycles:180 Average:14067.87 Median:45452.43 stddev:16036.37 (35.3%) stddev-sans-first:16049.99 08:38:57 INFO - PROCESS | 547 | Values: 710.4 799.1 817.7 832.2 855.6 13666.3 13825.1 13828.4 13858.8 13875.4 13159.1 13212.7 13249.5 13264.2 13277.8 680.8 812.6 813.5 819.4 821.1 827.0 829.5 829.5 830.2 835.0 872.8 878.0 879.8 881.1 881.9 701.4 870.1 870.8 871.8 872.5 630.2 640.4 641.4 641.5 642.1 13567.3 13613.5 13617.0 13629.9 13635.7 12863.7 12888.9 13668.5 13844.5 13875.1 10802.2 10847.1 10888.4 10944.3 11072.3 3611.9 3675.6 3707.6 3713.9 3790.4 48108.3 48563.8 48572.3 48602.3 48805.8 10459.7 10509.3 10536.0 10855.5 11033.3 17745.0 17918.8 17928.9 17974.8 17982.6 7736.8 7920.2 8009.4 8101.0 8123.4 4410.8 4426.2 4429.6 4448.0 4523.4 3234.8 3279.0 3279.8 3286.4 3286.9 617.9 624.9 625.2 635.2 640.6 630.7 708.1 719.4 722.8 733.7 8984.3 9373.2 9506.3 9551.5 9752.2 675.7 704.3 708.4 720.0 736.9 4022.6 4171.9 4186.0 4212.5 4354.5 54919.7 55772.2 55851.4 56063.7 56340.0 48875.5 49406.8 50508.0 50682.7 50768.0 45303.3 45601.5 45777.3 45810.3 46460.0 8016.7 8198.8 8332.4 8366.8 8374.7 33089.8 33350.0 37176.8 38347.2 39204.6 49225.3 49434.0 49619.5 50263.2 50356.2 11464.2 11567.9 12050.0 12331.8 12349.0 12068.9 12365.6 12707.3 12728.7 12918.2 8417.7 10749.6 11195.9 11377.7 11443.8 11698.5 11802.2 11810.6 11814.0 11835.7 11324.0 11403.9 11512.9 11594.5 11613.8 9419.9 9694.0 9967.9 9995.7 10021.1 10169.8 10214.3 10424.9 10429.3 10460.3 08:38:57 INFO - PROCESS | 547 | -------- Summary: end -------- 08:38:57 INFO - PROCESS | 547 | 08:38:58 INFO - TEST-INFO | 547: exit 0 08:38:58 INFO - TEST-OK | dromaeo_css | took 1112593ms 08:38:58 INFO - TEST-START | kraken 08:38:58 INFO - operating with platform_type : linux_ 08:38:58 INFO - Initialising browser for kraken test... 08:38:58 INFO - TEST-INFO | started process 731 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdPNbxi/profile http://localhost:44913/getInfo.html) 08:39:01 INFO - PROCESS | 731 | __metrics Screen width/height:1600/1200 08:39:01 INFO - PROCESS | 731 | colorDepth:24 08:39:01 INFO - PROCESS | 731 | Browser inner width/height: 1024/697 08:39:01 INFO - PROCESS | 731 | __metrics 08:39:02 INFO - PROCESS | 731 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:03 INFO - TEST-INFO | 731: exit 0 08:39:03 INFO - Browser initialized. 08:39:03 INFO - Running cycle 1/1 for kraken test... 08:39:03 INFO - TEST-INFO | started process 820 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdPNbxi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:15 INFO - PROCESS | 820 | RSS: Main: 147566592 08:39:15 INFO - PROCESS | 820 | 08:39:18 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44913/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:18 INFO - PROCESS | 820 | RSS: Main: 191504384 08:39:18 INFO - PROCESS | 820 | 08:39:21 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44913/tests/kraken/driver.html?testName=audio-dft) 08:39:21 INFO - PROCESS | 820 | RSS: Main: 180875264 08:39:21 INFO - PROCESS | 820 | 08:39:24 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44913/tests/kraken/driver.html?testName=audio-fft) 08:39:25 INFO - PROCESS | 820 | RSS: Main: 165318656 08:39:25 INFO - PROCESS | 820 | 08:39:27 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44913/tests/kraken/driver.html?testName=audio-oscillator) 08:39:28 INFO - PROCESS | 820 | RSS: Main: 167944192 08:39:28 INFO - PROCESS | 820 | 08:39:30 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:30 INFO - PROCESS | 820 | RSS: Main: 168316928 08:39:30 INFO - PROCESS | 820 | 08:39:33 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44913/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:34 INFO - PROCESS | 820 | RSS: Main: 168718336 08:39:34 INFO - PROCESS | 820 | 08:39:37 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44913/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:38 INFO - PROCESS | 820 | RSS: Main: 172036096 08:39:38 INFO - PROCESS | 820 | 08:39:41 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44913/tests/kraken/driver.html?testName=json-parse-financial) 08:39:41 INFO - PROCESS | 820 | RSS: Main: 170577920 08:39:41 INFO - PROCESS | 820 | 08:39:43 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:43 INFO - PROCESS | 820 | RSS: Main: 181186560 08:39:43 INFO - PROCESS | 820 | 08:39:45 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:46 INFO - PROCESS | 820 | RSS: Main: 178438144 08:39:46 INFO - PROCESS | 820 | 08:39:48 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:48 INFO - PROCESS | 820 | RSS: Main: 189980672 08:39:48 INFO - PROCESS | 820 | 08:39:51 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:51 INFO - PROCESS | 820 | RSS: Main: 193982464 08:39:51 INFO - PROCESS | 820 | 08:39:54 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:55 INFO - PROCESS | 820 | RSS: Main: 195878912 08:39:55 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | Cycle 1(1): loaded http://localhost:44913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44913/tests/kraken/driver.html?testName=ai-astar) 08:39:56 INFO - PROCESS | 820 | RSS: Main: 254287872 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | __start_tp_report 08:39:56 INFO - PROCESS | 820 | _x_x_mozilla_page_load 08:39:56 INFO - PROCESS | 820 | _x_x_mozilla_page_load_details 08:39:56 INFO - PROCESS | 820 | |i|pagename|runs| 08:39:56 INFO - PROCESS | 820 | |0;ai-astar;111;113;107;113;111;111;104;112;111;112 08:39:56 INFO - PROCESS | 820 | |1;audio-beat-detection;157;127;158;169;131;157;153;128;168;125 08:39:56 INFO - PROCESS | 820 | |2;audio-dft;161;162;170;162;160;160;161;162;162;162 08:39:56 INFO - PROCESS | 820 | |3;audio-fft;73;74;98;95;73;75;75;117;96;74 08:39:56 INFO - PROCESS | 820 | |4;audio-oscillator;97;97;154;96;96;96;136;97;96;147 08:39:56 INFO - PROCESS | 820 | |5;imaging-gaussian-blur;119;115;116;116;115;115;114;114;114;115 08:39:56 INFO - PROCESS | 820 | |6;imaging-darkroom;145;145;146;147;147;146;146;146;146;145 08:39:56 INFO - PROCESS | 820 | |7;imaging-desaturate;95;96;95;96;96;95;96;96;96;96 08:39:56 INFO - PROCESS | 820 | |8;json-parse-financial;61;56;57;55;58;60;60;67;56;55 08:39:56 INFO - PROCESS | 820 | |9;json-stringify-tinderbox;69;68;67;68;68;69;68;68;68;68 08:39:56 INFO - PROCESS | 820 | |10;stanford-crypto-aes;82;91;83;89;82;82;84;83;83;83 08:39:56 INFO - PROCESS | 820 | |11;stanford-crypto-ccm;120;126;120;122;118;115;115;115;119;117 08:39:56 INFO - PROCESS | 820 | |12;stanford-crypto-pbkdf2;151;142;152;152;153;141;153;151;151;151 08:39:56 INFO - PROCESS | 820 | |13;stanford-crypto-sha256-iterative;69;69;72;69;69;68;72;70;70;67 08:39:56 INFO - PROCESS | 820 | __end_tp_report 08:39:56 INFO - PROCESS | 820 | __start_cc_report 08:39:56 INFO - PROCESS | 820 | _x_x_mozilla_cycle_collect,961 08:39:56 INFO - PROCESS | 820 | __end_cc_report 08:39:56 INFO - PROCESS | 820 | __startTimestamp1456331996965__endTimestamp 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | ------- Summary: start ------- 08:39:56 INFO - PROCESS | 820 | Number of tests: 14 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:2.84 (2.5%) stddev-sans-first:3.00 08:39:56 INFO - PROCESS | 820 | Values: 111.0 113.0 107.0 113.0 111.0 111.0 104.0 112.0 111.0 112.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:157.00 stddev:17.58 (11.2%) stddev-sans-first:18.29 08:39:56 INFO - PROCESS | 820 | Values: 157.0 127.0 158.0 169.0 131.0 157.0 153.0 128.0 168.0 125.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:2.86 (1.8%) stddev-sans-first:3.00 08:39:56 INFO - PROCESS | 820 | Values: 161.0 162.0 170.0 162.0 160.0 160.0 161.0 162.0 162.0 162.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.00 stddev:15.43 (20.6%) stddev-sans-first:15.75 08:39:56 INFO - PROCESS | 820 | Values: 73.0 74.0 98.0 95.0 73.0 75.0 75.0 117.0 96.0 74.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:96.00 stddev:24.17 (25.2%) stddev-sans-first:25.08 08:39:56 INFO - PROCESS | 820 | Values: 97.0 97.0 154.0 96.0 96.0 96.0 136.0 97.0 96.0 147.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.78 08:39:56 INFO - PROCESS | 820 | Values: 119.0 115.0 116.0 116.0 115.0 115.0 114.0 114.0 114.0 115.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:39:56 INFO - PROCESS | 820 | Values: 145.0 145.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 145.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:39:56 INFO - PROCESS | 820 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:3.69 (6.3%) stddev-sans-first:3.80 08:39:56 INFO - PROCESS | 820 | Values: 61.0 56.0 57.0 55.0 58.0 60.0 60.0 67.0 56.0 55.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 08:39:56 INFO - PROCESS | 820 | Values: 69.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.16 (3.8%) stddev-sans-first:3.24 08:39:56 INFO - PROCESS | 820 | Values: 82.0 91.0 83.0 89.0 82.0 82.0 84.0 83.0 83.0 83.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:3.53 (3.0%) stddev-sans-first:3.71 08:39:56 INFO - PROCESS | 820 | Values: 120.0 126.0 120.0 122.0 118.0 115.0 115.0 115.0 119.0 117.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.70 Median:151.50 stddev:4.40 (2.9%) stddev-sans-first:4.64 08:39:56 INFO - PROCESS | 820 | Values: 151.0 142.0 152.0 152.0 153.0 141.0 153.0 151.0 151.0 151.0 08:39:56 INFO - PROCESS | 820 | 08:39:56 INFO - PROCESS | 820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.67 08:39:56 INFO - PROCESS | 820 | Values: 69.0 69.0 72.0 69.0 69.0 68.0 72.0 70.0 70.0 67.0 08:39:56 INFO - PROCESS | 820 | -------- Summary: end -------- 08:39:56 INFO - PROCESS | 820 | 08:39:57 INFO - TEST-INFO | 820: exit 0 08:39:57 INFO - TEST-OK | kraken | took 59650ms 08:39:57 INFO - SUITE-END | took 1172s 08:39:58 INFO - Completed test suite (00:19:32) 08:39:58 INFO - Working with test: dromaeo_css 08:39:58 INFO - Generating results file: dromaeo_css 08:39:58 INFO - Working with test: kraken 08:39:58 INFO - Generating results file: kraken 08:39:58 INFO - javascript benchmark 08:39:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:39:58 INFO - process_Request line: dromaeo_css 6879.67 graph.html#tests=[[72,64,35]] 08:39:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:39:58 INFO - process_Request line: kraken 1521.80 graph.html#tests=[[232,64,35]] 08:39:58 INFO - RETURN: dromaeo_css: 6879.67 08:39:58 INFO - RETURN: kraken: 1521.80 08:39:58 INFO - javascript benchmark 08:39:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3003.264200270934, 3054.9083527494167, 3056.831874246917, 3083.121310426528, 3102.519109538022, 5050.621203409745, 5067.974660126703, 5084.669496482726, 5090.669106508079, 5121.103806833803, 5136.512031357024, 5170.870728231796, 5177.352830896138, 5195.58435325174, 5225.320708307924, 4742.549457801503, 4752.287156926454, 4795.664303498756, 4803.663743537953, 4903.730294833783, 4866.31871537985, 4884.242942343943, 4886.609071274307, 4906.1168989581865, 4935.161022626145, 4680.461746899116, 4701.976490117545, 4737.857864264078, 4776.140294746944, 4800.207965685658, 4667.509911459316, 4682.344471773954, 4693.6245100392225, 4703.976480117578, 4705.670603057787, 4645.256758918556, 4665.393498845162, 4681.016986432854, 4713.905721885578, 4729.834455794031, 4984.975075124637, 4987.202047672355, 4996.825111121093, 4996.9500304996845, 5022.949770502321, 5482.862928426821, 5492.423295553989, 5498.367687715924, 5541.889162216773, 5542.889142217174, 5507.807226747044, 5559.583031272671, 5578.079616863212, 5648.604597678164, 5658.066419040853, 5252.6323157379, 5268.341457317835, 5269.762860671279, 5275.551578115865, 5279.709615971082, 5612.045952188057, 5708.857278567986, 5716.857078573069, 5721.914171287434, 5728.398518155617, 5411.242426060355, 5486.588505862076, 5504.724763761796, 5505.9724701376235, 5558.666480011212, 5467.644603100785, 5479.643823151482, 5491.093969494988, 5497.230387745719, 5504.614676972574, 5445.591580631469, 5485.396606373296, 5518.19986102013, 5533.363663178786, 5605.523530499871, 5526.723663816793, 5536.363318218376, 5542.86142846424, 5548.0, 5554.750036248379, 4338.522762496123, 4339.609435150852, 4342.066455712037, 4373.693841431133, 4377.934330985037, 3767.2653832502947, 3842.423636454498, 3869.555001174901, 3894.824732887027, 3906.277338692351, 5158.4067832199025, 5166.5866730661455, 5167.560757335594, 5181.637285390062, 5215.243789650555, 5455.972720136453, 5528.723563821793, 5533.806316778893, 5545.0, 5554.611177217556, 5119.513646203604, 5122.206058061007, 5131.332926719502, 5147.433782283946, 5188.22176673502, 4702.600278976325, 4731.4139017000225, 4739.834105806281, 4748.406449193851, 4781.6891902026255, 5640.125780504029, 5764.337101233412, 5811.389804070596, 5821.679807610622, 5841.123831425235, 5485.6434331768305, 5508.7521061553125, 5523.6685798852195, 5571.693556854412, 5577.27495425592, 5716.828495145152, 5719.884622498739, 5729.656220626775, 5754.827355179351, 5775.249217601685, 5386.272853164773, 5451.890962180813, 5455.208994695826, 5474.3704473986, 5529.972350138223, 5536.003519366553, 5544.3346798384455, 5546.611737178358, 5551.583631227593, 5577.247071645276, 5393.568514518907, 5418.512333889968, 5429.972850135724, 5437.075697131576, 5482.23248745184, 5267.57859371257, 5372.811951581676, 5397.298351214317, 5425.484578964992, 5463.180522921593, 5273.604479664117, 5286.286351342519, 5300.6024548158275, 5303.178007408857, 5307.203919411964, 5318.0, 5384.9730751346, 5441.673499590037, 5447.0467668157125, 5452.672839629635, 5246.108161612458, 5317.893642127213, 5321.467853214803, 5353.116735738715, 5359.785608575613], "unit": "score", "name": "dojo.html", "value": 5113.30784938212}, {"lowerIsBetter": false, "replicates": [539.5629540072543, 580.3587036324861, 593.6675461741423, 598.9311229208639, 600.0938582740063, 36248.81875590625, 36263.27473450529, 36333.273334533325, 36413.27173456536, 36427.0, 38982.610173898254, 39481.407778883266, 39498.605013949855, 39509.40735888957, 39530.20939581207, 8430.53632050237, 8650.783730406758, 8659.95670021649, 8667.913320866774, 8671.176238257387, 8438.11399803021, 8539.359548033892, 8558.0, 8773.736787896374, 8774.824503509926, 8773.210411063003, 8814.86777698335, 8821.823563528726, 8851.159139881702, 8860.556972151368, 8670.566471676422, 8757.080506546848, 8781.34139939507, 8782.341324400631, 8789.033206347296, 8683.60923758426, 8789.208971192624, 8794.51630160341, 8810.074942131048, 8811.515366654832, 38840.22319553593, 39323.0, 39374.606253937665, 39391.60608393908, 39402.408963865564, 2137.9893100534555, 3260.750520226601, 3339.3989081965237, 3386.136535183537, 3391.8473668684724, 26409.603855942176, 26849.0, 26867.73132268672, 27075.72924270752, 27626.447471050466, 3685.1708365617524, 3710.573284072312, 3770.6794922431627, 3922.490076290064, 3959.742616729903, 218983.90508047518, 220194.0, 220757.0, 221030.0, 221064.0, 50409.495905041214, 53910.191347129825, 54128.0, 54602.72698636481, 57848.0, 53862.46137538574, 54021.45978540243, 54522.0, 54562.727186363816, 54615.18077228845, 16086.75869861953, 16247.59381015484, 16280.43018494347, 16308.673826523403, 16309.347626094823, 11438.256513326607, 11455.885441145649, 11456.255343402652, 11458.312501249951, 11492.25300355491, 19206.07209116086, 19606.80393196078, 19615.215391384183, 19620.215191392468, 19641.901790490956, 7611.619419029137, 7726.34326082278, 7816.7264145754625, 7875.330596899328, 7884.053913530413, 839.9962045355741, 915.8122584870085, 1002.1682003936716, 1016.6289304403987, 1064.4837253931837, 28608.14175574736, 29330.706692933225, 29580.0, 29720.702792972224, 29732.256693582833, 1013.5287091502487, 1025.5231317437429, 1046.9581216751396, 1058.0794708603564, 1060.989390106089, 15266.313015914311, 15365.462208822637, 15640.296186671627, 15767.86992128483, 15837.208139593205, 356544.0, 358158.0, 358490.0, 358870.0, 359888.0, 53058.46941530613, 54106.0, 54137.458625413245, 54147.18779218315, 54178.0, 1138.3966497756203, 1226.589092653971, 1311.5475161069608, 1343.2544937559553, 1464.1434760664918, 26845.731542684323, 29313.0, 30153.547696784128, 30546.389072217986, 30720.231994200323, 40375.78872633826, 41228.38157427701, 41466.58533414627, 41729.37405938852, 41953.790231048646, 189658.0, 190517.0, 190630.0, 191324.0, 346684.0, 31148.598313075512, 31841.522377164823, 31849.522257165696, 31874.84062579672, 31884.202894927814, 42478.0, 43014.13971720485, 43344.349834753135, 43559.78220108879, 44065.0, 36059.81970090133, 36221.27557448889, 36481.27037459289, 41317.38023929583, 42328.78835605802, 40506.79746601248, 41070.58929410668, 41163.794181028905, 41782.58217417787, 42392.788036059625, 36027.63972360243, 36483.452748209325, 36926.815365923, 36950.6304936958, 37074.6292537082, 35789.64210357863, 36573.45139822958, 36585.0, 36822.63177368192, 36972.44541331936, 24985.87507062453, 26803.19590412291, 26827.195184144508, 26850.731492685605, 27126.864365678044], "unit": "score", "name": "ext.html", "value": 18212.01472490121}, {"lowerIsBetter": false, "replicates": [358.48915295703625, 361.74858473361024, 362.6518542199489, 368.92068205335846, 369.85021066468073, 13714.24571648559, 16808.74786878198, 16862.662746745056, 16867.57831054224, 17695.380661676827, 16165.272562734675, 16309.83690163098, 16560.420385286518, 17540.649187016254, 17547.12264386782, 5321.175217841241, 5451.863703407426, 5474.151506516497, 5481.205225242337, 5501.119820828668, 3729.384651532494, 5262.105442074857, 5333.839984800462, 5480.068388373986, 5480.479354461339, 5427.782888684448, 5450.0, 5456.208849716789, 5493.642913210629, 5496.80761173359, 5376.784928602851, 5396.865078373053, 5416.295881535395, 5511.724413779335, 5534.308211473566, 5277.656952298088, 5291.86770330741, 5293.602979776494, 5294.97352513235, 5310.8141215057285, 13383.0, 17765.822341776548, 20852.687209691867, 20913.790862091337, 20947.266845660328, 2118.480972161815, 2236.5303286309895, 2239.6528538076623, 2252.279270633398, 2355.729091154522, 9554.474503902282, 9563.61745530185, 9790.853137202948, 9803.558839852223, 10134.54394552247, 1798.352593066495, 1854.7403363529118, 1857.811000959387, 1867.8412334951545, 1905.4378958207362, 64231.0, 64989.0, 65248.3475165247, 66696.6665166676, 67730.66134669345, 10365.118964887919, 10427.113695335982, 10435.37387756737, 10442.321249118782, 10453.477326133663, 13780.035397522277, 13801.585952421243, 13828.516001939885, 13847.515336963157, 13850.307484625728, 7599.544027358376, 7732.806679833049, 7734.071911370672, 7780.766577002699, 7797.532148071134, 7486.32623063916, 7488.288612581796, 7497.850042999109, 7556.2443755624, 7565.394768418513, 4509.594136527729, 4568.56598623137, 4589.495155532889, 4592.425946756655, 4629.236176030984, 1729.6713624411323, 1755.3505203074944, 1827.2873579304082, 1869.6260747850483, 1875.6017139807132, 879.6437442835662, 887.8179973105498, 896.5338024227365, 905.4522014181325, 1003.6487229469627, 16308.510744677678, 16556.089415082046, 16781.916090419712, 17420.0, 17427.73858392125, 946.6402766948515, 953.0394297680556, 957.3777044920857, 1019.1948360794889, 1068.759529105945, 9705.175060119827, 9783.315167938175, 9847.45838978863, 9853.655122070693, 10000.2999790014, 343333.28333358176, 408828.0, 409180.0, 409678.0, 429912.0, 70615.0, 73603.0, 75075.24924750792, 75347.0, 76742.6162869182, 1039.1271332080937, 1043.6973277749519, 1046.5761366646673, 1064.21248276275, 1066.2909165405074, 12687.0, 14825.332860021541, 15208.46770363032, 15495.0, 15700.293486792893, 31035.534466983467, 31144.377112458078, 31189.68810311868, 31850.522242165924, 31866.36267274688, 38666.226675466896, 38774.2245155101, 39115.608843912334, 39249.607503925734, 39324.213515730095, 8025.23760242776, 8109.270165685117, 8359.707410240613, 8364.539950302791, 8388.286995605198, 11638.941805290919, 12118.151729378858, 12214.816777748163, 12322.383880806103, 12709.555165569162, 10956.890431095588, 11316.434178291218, 11319.773604528027, 11561.710957226136, 11612.187146899636, 6901.827454313682, 8873.245774109273, 11270.718232044264, 11485.0, 11609.419529023684, 11327.716807079889, 11575.247608905394, 11739.589114381297, 11774.646760597196, 11798.351090690094, 8013.519188848688, 8283.751487455385, 8342.582870856555, 8408.285295749685, 8479.788005299917, 9397.765055873659, 10803.081738052353, 11009.559617615205, 11154.832677509681, 11294.491747871201], "unit": "score", "name": "jquery.html", "value": 8355.043927121515}, {"lowerIsBetter": false, "replicates": [1269.6254604891556, 1481.4370539195104, 1492.813398325209, 1631.910244936528, 1780.706183479726, 7304.160021597511, 7520.699172033119, 7529.66116524757, 7535.0, 7540.585267810282, 7391.741289054884, 7549.849003019936, 7559.092908850946, 7573.962130189341, 7585.127710313315, 1958.8237058664718, 2002.3392280547457, 2216.3683350245183, 2247.1685476373723, 2280.384296240014, 2306.723193216808, 2310.7111611048617, 2313.0169677886915, 2322.8606283622953, 2324.012294774714, 2249.3701763506165, 2259.197984715427, 2306.7001289832297, 2309.896054677535, 2310.1452462588863, 2247.6965609642652, 2269.341890851659, 2278.715160604924, 2281.1445707859552, 2292.5071109711494, 2260.8191344692386, 2269.5574362999223, 2280.1791355112146, 2281.908723651052, 2285.1430713482446, 7634.541927484369, 7694.153643099311, 7709.768706938801, 7716.228377162295, 7717.305442510201, 4776.761161941889, 4835.782389792468, 4848.490908454597, 4878.414590249193, 4895.167821470359, 3127.218195451137, 3143.6070491188602, 3191.329820737648, 3212.61448626164, 3237.4010808000594, 1144.1876267849836, 1814.2561549764532, 1848.5009047557085, 1849.9907500462411, 1873.3162395725599, 10121.0, 10167.644132455329, 10217.2847900647, 10241.795164096751, 10246.282760206788, 4129.628333449944, 4139.689523285766, 4198.391233271159, 4203.873883783492, 4289.892752681208, 8186.0, 8203.753887383387, 8237.382196335298, 8255.669773209125, 8278.627461764236, 4800.903981920412, 4802.423709154854, 4839.491853355417, 4844.878878028077, 4845.297431872429, 3765.4163604641326, 4272.380504826782, 4382.079763249753, 4393.51671316155, 4396.098799746044, 3446.6553344665836, 3465.2722928184858, 3476.6349533299144, 3488.7732297401094, 3513.2446523997464, 1002.8896821349646, 1003.5935446144323, 1050.7058023753361, 1088.7604726960055, 1093.3112139352156, 1253.9937300313622, 1262.040848954801, 1279.3795009420423, 1302.1145620977827, 1303.589369348652, 6901.930980690229, 6940.305969403019, 7147.106611673541, 7237.638118094074, 7245.347918687344, 1098.5825386353135, 1106.397013627575, 1110.622388387952, 1116.391566596207, 1155.3703231738723, 5662.6036177468, 5692.459216374438, 5742.167385729046, 5745.597808153389, 5747.971260143756, 8782.0, 8852.645894164161, 9106.089391060841, 9214.078592140866, 9244.029376915461, 9134.862977055349, 9169.495677737656, 9197.954010229905, 9283.0, 9285.978542360335, 6994.055802466703, 7169.032180655545, 7169.856602868018, 7347.191808901017, 7446.813829654302, 6882.621455819978, 6973.442124629916, 6992.195897471653, 7000.579965202104, 7017.894731578928, 7813.296803287732, 8029.598520073856, 8226.42415030966, 8253.174682531699, 8253.83492330162, 8230.09468958402, 8489.74530764078, 8665.783355415913, 8668.52323122209, 8672.479651220947, 6021.096835474714, 6170.629762214281, 6171.814845554461, 6656.7004484797335, 6778.7288508459105, 6512.185976752906, 7183.820404489929, 7385.778426647209, 7406.222346653739, 7444.032275804328, 6706.6646667665445, 6760.391564759196, 6763.391294783493, 6897.448204143556, 6918.5502942308585, 6703.66481675924, 6761.425278851353, 6761.594304341756, 6787.253402125861, 6847.0, 6698.665066746546, 6801.251862295045, 6814.965925170342, 6824.351686589766, 6828.2830302819475, 6307.211598550181, 6318.304986451395, 6368.490520758421, 6372.490200783834, 6375.7449702013255, 6114.938850611437, 6160.137580738789, 6190.50475961931, 6192.783252586138, 6207.565470417027], "unit": "score", "name": "mootools.html", "value": 4469.135235132279}, {"lowerIsBetter": false, "replicates": [336.39952684458245, 338.6697969479757, 341.06888195227043, 344.17569920041507, 348.8517380113451, 5674.971625141869, 5789.710514474281, 5800.622959507635, 5901.232839730835, 5905.911411328833, 5785.566082543805, 5812.0, 5819.272590926134, 5822.475977162055, 5841.941580584193, 4581.702189357689, 4593.058423023289, 4593.908121837561, 4601.7345230061665, 4605.700629459075, 4358.5423530529315, 4448.354988526662, 4485.215087359716, 4540.931886021713, 4597.264437689971, 4471.150481408538, 4491.124230775, 4491.842785502508, 4495.011097558532, 4501.977490112545, 4486.663500237462, 4486.753228572427, 4488.304312831517, 4502.5047244803045, 4504.076664283814, 3966.841326346943, 3968.0873399118077, 3968.6825053995613, 3970.7021973352116, 3976.6619837313865, 5521.033819081645, 5542.279503664538, 5542.584306177053, 5545.279113715232, 5549.500544950974, 5257.0, 5258.13240815265, 5260.473952604709, 5263.657862238981, 5264.657797243205, 5946.821595352147, 6150.323464418955, 6184.350643182491, 6225.408586184305, 6263.185785847856, 4302.913941721179, 4306.20335237982, 4306.6124048835445, 4307.923019245189, 4311.698181127323, 6231.844203894893, 6370.076338930876, 6376.234851817811, 6452.774152904626, 6453.677316134174, 4377.190219809346, 4398.956010439919, 4399.73601583906, 4402.097569998143, 4412.5659160772875, 4455.376247325377, 4460.041091165415, 4464.285714285698, 4464.285714285698, 4464.3973063635995, 5131.281620573122, 5142.997115562504, 5146.459621739738, 5147.845564632992, 5150.0472412603785, 5854.268216472941, 6046.667433291123, 6184.319724830265, 6198.039303907902, 6211.937880621226, 1546.427821705976, 1562.4453319071793, 1568.6235303527071, 1569.6389830339085, 1574.1342261755988, 1034.4155552113032, 1048.9475526223812, 1049.9212559057949, 1061.7186445591924, 1067.9412632305143, 5860.359099452075, 5861.736221870026, 5871.060630299132, 5874.9118763218585, 5877.0, 6410.807675769641, 6447.484201263887, 6449.677516124175, 6452.290248072708, 6455.064015717789, 5864.70676466175, 5867.354590994987, 5870.677112758839, 5871.148683440877, 5872.031114866085, 3396.558447401822, 3420.846061927219, 3424.5719285089363, 3432.7253819694365, 3434.8797792077157, 6505.967470162619, 6640.468762498988, 6644.634545099969, 6746.4265537429865, 6752.594844309259, 6564.245111812203, 6588.308227636125, 6596.8350791230605, 6603.570767900071, 6612.0412540181405, 6735.360140786617, 6735.494837887178, 6735.932640673628, 6736.360045795642, 6737.393634572912, 6407.327230640902, 6440.420362167428, 6449.226092868886, 6451.935480645134, 6456.483481321577, 5740.512056475246, 6029.095635654687, 6361.141245931925, 6369.777057802955, 6381.904271436025, 6485.54601177913, 6559.934400655932, 6677.332266773478, 6730.0241464988285, 6799.354061364163, 4394.362817391397, 4421.314696222091, 4430.224710675683, 4431.224535706303, 4435.9556404436835, 6172.382761723792, 6322.178116844781, 6413.005984072476, 6427.228732552124, 6430.64631445275, 6088.0, 6191.876162476635, 6199.1011303361665, 6204.689765511616, 6278.748850045947, 6235.314115447388, 6237.594556353823, 6245.18812554365, 6246.406591373812, 6252.155958945484, 6075.513958883367, 6080.087986802015, 6137.079438084144, 6146.293176284785, 6154.169187159676, 6281.120643109877, 6281.371862813865, 6281.434670879643, 6282.685865706605, 6285.717142728679, 5873.794417195549, 6014.0, 6026.397360263939, 6027.18632984559, 6131.478824299985], "unit": "score", "name": "prototype.html", "value": 4687.629504871702}, {"lowerIsBetter": false, "replicates": [710.3784188834769, 799.1050023973149, 817.7464985854385, 832.1512057701145, 855.6278019061707, 13666.31668416579, 13825.101368411046, 13828.377723002464, 13858.792118118212, 13875.375608097635, 13159.144655597403, 13212.669683257924, 13249.536266230683, 13264.204147751117, 13277.800832987488, 680.7685386968429, 812.5937031484258, 813.4712436916022, 819.4018366592392, 821.0680877204356, 827.0199813221321, 829.5271695133777, 829.531314807132, 830.248624994378, 835.0188528479043, 872.7556284240422, 877.9648814047431, 879.8020445399798, 881.1012766977678, 881.8721285413643, 701.3757755597471, 870.0646804684989, 870.8476016697084, 871.8430682477151, 872.4808738800435, 630.2153818495956, 640.4332166033048, 641.3586413586413, 641.4804008752925, 642.1267076775628, 13567.321633918265, 13613.523526676618, 13617.0, 13629.931850340785, 13635.727285454335, 12863.742725145445, 12888.871111288954, 13668.52160174399, 13844.515441959484, 13875.098118622258, 10802.189835762349, 10847.132229421628, 10888.40113793741, 10944.343339399582, 11072.335659860435, 3611.855525778966, 3675.5773086095173, 3707.647773461517, 3713.925721485555, 3790.431435284702, 48108.27837582439, 48563.75718121422, 48572.271415928786, 48602.27096593554, 48805.755971219914, 10459.68620941373, 10509.264351495474, 10536.0, 10855.45722713877, 11033.337999720043, 17745.0, 17918.820811791975, 17928.9103554484, 17974.843018837822, 17982.550436238937, 7736.7678969631, 7920.247576480225, 8009.399295052895, 8101.0, 8123.4313598047565, 4410.757408342572, 4426.203283408953, 4429.579189976947, 4447.977760111179, 4523.411956445641, 3234.75739319552, 3278.9836050819595, 3279.8360081995806, 3286.4413049781597, 3286.8520916558814, 617.8970537590379, 624.9000159974473, 625.2059883947361, 635.1774452084561, 640.6220330005319, 630.6941133550224, 708.143146792387, 719.4496210399049, 722.7723267170825, 733.7028503456108, 8984.32617553686, 9373.1564159226, 9506.287028472892, 9551.522423878918, 9752.21982241419, 675.6689222281046, 704.2604269391967, 708.3518580498888, 719.9712011519586, 736.9498464687798, 4022.6178513041214, 4171.937420938689, 4185.958140418617, 4212.5361735135, 4354.477462704495, 54919.725401372736, 55772.16341754877, 55851.441485584626, 56063.71968140133, 56340.0, 48875.511244887806, 49406.75296623494, 50508.0, 50682.74658626683, 50768.0, 45303.32045019327, 45601.54398455973, 45777.31334029992, 45810.31284530668, 46460.0, 8016.7194148204535, 8198.754037378889, 8332.416730828783, 8366.790830229293, 8374.665013399639, 33089.834550827094, 33350.0, 37176.81411593033, 38347.2330553393, 39204.607953920095, 49225.26162107643, 49434.0, 49619.50380496149, 50263.246051309994, 50356.24465632945, 11464.197506174487, 11567.942160289145, 12050.035997120034, 12331.815022774845, 12348.970503065266, 12068.879311206776, 12365.629031129081, 12707.301098439675, 12728.6817829555, 12918.22490650564, 8417.747467575982, 10749.570017199538, 11195.944020279847, 11377.715557111138, 11443.771124577628, 11698.532058717896, 11802.23285486475, 11810.645680629596, 11814.0, 11835.70410739704, 11324.0, 11403.885961140615, 11512.94243528777, 11594.536218551164, 11613.76772464563, 9419.905800941902, 9694.0, 9967.850482242628, 9995.70012899614, 10021.148202402877, 10169.796604068026, 10214.285000049926, 10424.947875260576, 10429.26995110335, 10460.26778125524], "unit": "score", "name": "yui.html", "value": 6503.988761762829}], "name": "dromaeo_css", "value": 6879.665172723948}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 113.0, 111.0, 111.0, 104.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 158.0, 169.0, 131.0, 157.0, 153.0, 128.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 170.0, 162.0, 160.0, 160.0, 161.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 98.0, 95.0, 73.0, 75.0, 75.0, 117.0, 96.0, 74.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 154.0, 96.0, 96.0, 96.0, 136.0, 97.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 116.0, 116.0, 115.0, 115.0, 114.0, 114.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [61.0, 56.0, 57.0, 55.0, 58.0, 60.0, 60.0, 67.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 83.0, 89.0, 82.0, 82.0, 84.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [120.0, 126.0, 120.0, 122.0, 118.0, 115.0, 115.0, 115.0, 119.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.7}, {"lowerIsBetter": true, "replicates": [151.0, 142.0, 152.0, 152.0, 153.0, 141.0, 153.0, 151.0, 151.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 72.0, 69.0, 69.0, 68.0, 72.0, 70.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1521.8}]} 08:39:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6879.67"}}} 08:39:58 INFO - Return code: 0 08:39:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:39:58 INFO - # TBPL SUCCESS # 08:39:58 INFO - Running post-action listener: _resource_record_post_action 08:39:58 INFO - Running post-run listener: _resource_record_post_run 08:39:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 540803072; Read time: 0; Write time: 473268 08:39:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247078912; Read time: 0; Write time: 250544 08:39:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293724160; Read time: 0; Write time: 222724 08:39:59 INFO - Running post-run listener: _upload_blobber_files 08:39:59 INFO - Blob upload gear active. 08:39:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:39:59 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 08:39:59 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'] 08:39:59 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 08:39:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:00 INFO - (blobuploader) - INFO - Done attempting. 08:40:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:01 INFO - (blobuploader) - INFO - Done attempting. 08:40:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:01 INFO - Return code: 0 08:40:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:40:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/382c46c1d782c9537c6f8f688a7d6caba73af891e9eba5fa164c5c1425b95cecf103cf8da7e194962afe86ed37311f9879f75d43fedc4acd2684be2aa602602f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a8d4d2a49881568d0308ca12f770e47453f24bc7528d7d8c2dd4b71f7cc0fe1df74a119bce878ef8b9021a3b8a6ce051be89b72f7ac2a4a84bc6deb82078c04"} 08:40:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:40:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:40:01 INFO - Contents: 08:40:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/382c46c1d782c9537c6f8f688a7d6caba73af891e9eba5fa164c5c1425b95cecf103cf8da7e194962afe86ed37311f9879f75d43fedc4acd2684be2aa602602f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a8d4d2a49881568d0308ca12f770e47453f24bc7528d7d8c2dd4b71f7cc0fe1df74a119bce878ef8b9021a3b8a6ce051be89b72f7ac2a4a84bc6deb82078c04"} 08:40:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:01 INFO - Copying logs to upload dir... 08:40:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:40:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.054127 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-02-24 08:40:01.485096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:40:01.489084) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 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/382c46c1d782c9537c6f8f688a7d6caba73af891e9eba5fa164c5c1425b95cecf103cf8da7e194962afe86ed37311f9879f75d43fedc4acd2684be2aa602602f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a8d4d2a49881568d0308ca12f770e47453f24bc7528d7d8c2dd4b71f7cc0fe1df74a119bce878ef8b9021a3b8a6ce051be89b72f7ac2a4a84bc6deb82078c04"} build_url:https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/anXhOCffSraW5GFHnpDkJQ/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/382c46c1d782c9537c6f8f688a7d6caba73af891e9eba5fa164c5c1425b95cecf103cf8da7e194962afe86ed37311f9879f75d43fedc4acd2684be2aa602602f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a8d4d2a49881568d0308ca12f770e47453f24bc7528d7d8c2dd4b71f7cc0fe1df74a119bce878ef8b9021a3b8a6ce051be89b72f7ac2a4a84bc6deb82078c04"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:40:01.513704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:40:01.514021) ========= 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=20e666a3d4cfbb71505a330e000001b4-1456330748.872894-883235735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:40:01.600854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:40:01.601392) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:40:01.601744) ========= ========= Total master_lag: 0.34 =========