builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1455249452.69 results: success (0) buildid: 20160211173012 builduid: 187f3b30c16f400f876919bca7bb903c revision: 1e0af75b4c44da3271e51941561b582b42709a77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.688967) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.689601) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.689985) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.713171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.713460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.726505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.726844) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.785317) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.785631) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.785997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.786279) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 19:57:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.3M=0s 2016-02-11 19:57:33 (58.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.967690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:32.968007) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017477 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:33.017163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 19:57:33.017513) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e0af75b4c44da3271e51941561b582b42709a77 --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 1e0af75b4c44da3271e51941561b582b42709a77 --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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 19:57:33,346 truncating revision to first 12 chars 2016-02-11 19:57:33,346 Setting DEBUG logging. 2016-02-11 19:57:33,346 attempt 1/10 2016-02-11 19:57:33,346 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e0af75b4c44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 19:57:34,665 unpacking tar archive at: fx-team-1e0af75b4c44/testing/mozharness/ program finished with exit code 0 elapsedTime=1.612909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 19:57:34.643618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:34.643998) ========= echo 1e0af75b4c44da3271e51941561b582b42709a77 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1e0af75b4c44da3271e51941561b582b42709a77'] 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1e0af75b4c44da3271e51941561b582b42709a77 program finished with exit code 0 elapsedTime=0.003556 script_repo_revision: '1e0af75b4c44da3271e51941561b582b42709a77' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:34.692238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:34.692563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 19:57:34.702268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-11 19:57:34.702605) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:57:35 INFO - MultiFileLogger online at 20160211 19:57:35 in /builds/slave/test-pgo 19:57:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:57:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:57:35 INFO - {'append_to_log': False, 19:57:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:57:35 INFO - 'blob_upload_branch': 'Fx-Team', 19:57:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:57:35 INFO - 'branch': 'Fx-Team', 19:57:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:35 INFO - 'config_files': ('talos/linux_config.py',), 19:57:35 INFO - 'default_actions': ('clobber', 19:57:35 INFO - 'read-buildbot-config', 19:57:35 INFO - 'download-and-extract', 19:57:35 INFO - 'populate-webroot', 19:57:35 INFO - 'create-virtualenv', 19:57:35 INFO - 'install', 19:57:35 INFO - 'run-tests'), 19:57:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:35 INFO - 'download_minidump_stackwalk': True, 19:57:35 INFO - 'download_symbols': 'ondemand', 19:57:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:35 INFO - 'installer_path': 'installer.exe', 19:57:35 INFO - 'log_level': 'info', 19:57:35 INFO - 'log_name': 'talos', 19:57:35 INFO - 'log_to_console': True, 19:57:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:57:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:57:35 INFO - 'opt_config_files': (), 19:57:35 INFO - 'pip_index': False, 19:57:35 INFO - 'sps_profile': False, 19:57:35 INFO - 'sps_profile_interval': 0, 19:57:35 INFO - 'suite': 'dromaeojs', 19:57:35 INFO - 'system_bits': '32', 19:57:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:35 INFO - 'title': 'talos-linux64-ix-012', 19:57:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:35 INFO - 'use_talos_json': True, 19:57:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:57:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:35 INFO - 'work_dir': 'build'} 19:57:35 INFO - ##### 19:57:35 INFO - ##### Running clobber step. 19:57:35 INFO - ##### 19:57:35 INFO - Running pre-action listener: _resource_record_pre_action 19:57:35 INFO - Running main action method: clobber 19:57:35 INFO - rmtree: /builds/slave/test-pgo/build 19:57:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:57:35 INFO - Running post-action listener: _resource_record_post_action 19:57:35 INFO - ##### 19:57:35 INFO - ##### Running read-buildbot-config step. 19:57:35 INFO - ##### 19:57:35 INFO - Running pre-action listener: _resource_record_pre_action 19:57:35 INFO - Running main action method: read_buildbot_config 19:57:35 INFO - Using buildbot properties: 19:57:35 INFO - { 19:57:35 INFO - "project": "", 19:57:35 INFO - "product": "firefox", 19:57:35 INFO - "script_repo_revision": "production", 19:57:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:57:35 INFO - "repository": "", 19:57:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:57:35 INFO - "buildid": "20160211173012", 19:57:35 INFO - "pgo_build": "True", 19:57:35 INFO - "basedir": "/builds/slave/test-pgo", 19:57:35 INFO - "buildnumber": 936, 19:57:35 INFO - "slavename": "talos-linux64-ix-012", 19:57:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:57:35 INFO - "platform": "ubuntu64_hw", 19:57:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:57:35 INFO - "branch": "fx-team", 19:57:35 INFO - "repo_path": "integration/fx-team", 19:57:35 INFO - "revision": "1e0af75b4c44da3271e51941561b582b42709a77", 19:57:35 INFO - "stage_platform": "linux64-pgo", 19:57:35 INFO - "builduid": "187f3b30c16f400f876919bca7bb903c", 19:57:35 INFO - "slavebuilddir": "test" 19:57:35 INFO - } 19:57:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 19:57:35 INFO - Running post-action listener: _resource_record_post_action 19:57:35 INFO - ##### 19:57:35 INFO - ##### Running download-and-extract step. 19:57:35 INFO - ##### 19:57:35 INFO - Running pre-action listener: _resource_record_pre_action 19:57:35 INFO - Running main action method: download_and_extract 19:57:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:35 INFO - https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/test_packages.json 19:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/test_packages.json 19:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:57:36 INFO - Downloaded 1448 bytes. 19:57:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:57:36 INFO - Using the following test package requirements: 19:57:36 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:36 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:57:36 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:57:36 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'jsshell-linux-x86_64.zip'], 19:57:36 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:57:36 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:36 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:57:36 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:57:36 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:57:36 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 19:57:36 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 19:57:36 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:57:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:57: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')]} 19:57:36 INFO - https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:37 INFO - Downloaded 23297753 bytes. 19:57: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'] 19:57: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 19:57:39 INFO - Return code: 0 19:57:39 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 19:57: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')]} 19:57:39 INFO - https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 19:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:40 INFO - Downloaded 23297753 bytes. 19:57:40 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'] 19:57:40 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 19:57:41 INFO - Return code: 0 19:57:41 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')]} 19:57:41 INFO - https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 19:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:42 INFO - Downloaded 10706547 bytes. 19:57:42 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'] 19:57:42 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 19:57:43 INFO - Return code: 0 19:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:43 INFO - https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UScat5RYTiiLzo9Oo1V0lw/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 19:57:44 INFO - Downloaded 56481044 bytes. 19:57:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:57:44 INFO - mkdir: /builds/slave/test-pgo/properties 19:57:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:57:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:57:44 INFO - Contents: 19:57:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 19:57:45 INFO - Running post-action listener: _resource_record_post_action 19:57:45 INFO - Running post-action listener: set_extra_try_arguments 19:57:45 INFO - ##### 19:57:45 INFO - ##### Running populate-webroot step. 19:57:45 INFO - ##### 19:57:45 INFO - Running pre-action listener: _resource_record_pre_action 19:57:45 INFO - Running main action method: populate_webroot 19:57:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:45 INFO - '--tppagecycles', 19:57:45 INFO - '7'], 19:57:45 INFO - 'tests': ['tsvgm']}}, 19:57:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:57:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:57:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:57:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'tests': ['damp', 'tps']}, 19:57:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['damp', 'tps']}, 19:57:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:57:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:45 INFO - 'other': {'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'other_l64': {'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:57:45 INFO - 'ts_paint', 19:57:45 INFO - 'tpaint', 19:57:45 INFO - 'sessionrestore', 19:57:45 INFO - 'sessionrestore_no_auto_restore']}, 19:57:45 INFO - 'svgr': {'tests': ['tsvgx', 19:57:45 INFO - 'tsvgr_opacity', 19:57:45 INFO - 'tart', 19:57:45 INFO - 'tscrollx', 19:57:45 INFO - 'cart']}, 19:57:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['tsvgx', 19:57:45 INFO - 'tsvgr_opacity', 19:57:45 INFO - 'tart', 19:57:45 INFO - 'tscrollx', 19:57:45 INFO - 'cart']}, 19:57:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'tests': ['tp5o']}, 19:57:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'talos_options': ['--e10s'], 19:57:45 INFO - 'tests': ['tp5o']}, 19:57:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'talos_options': ['--xperf_path', 19:57:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:45 INFO - 'tests': ['tp5n']}, 19:57:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:57:45 INFO - 'talos_options': ['--e10s', 19:57:45 INFO - '--xperf_path', 19:57:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:45 INFO - 'tests': ['tp5n']}}, 19:57:45 INFO - 'talos.zip': {'path': '', 19:57:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:45 INFO - Running post-action listener: _resource_record_post_action 19:57:45 INFO - ##### 19:57:45 INFO - ##### Running create-virtualenv step. 19:57:45 INFO - ##### 19:57:45 INFO - Running pre-action listener: _resource_record_pre_action 19:57:45 INFO - Running main action method: create_virtualenv 19:57:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:57:45 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 19:57:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:57:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:45 INFO - Using real prefix '/usr' 19:57:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:57:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:57:47 INFO - Installing pip.................done. 19:57:47 INFO - Return code: 0 19:57:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:57:47 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')]} 19:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:47 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')]} 19:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:47 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:47 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 19:57:47 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 19:57:47 INFO - Using env: {'DISPLAY': ':0', 19:57:47 INFO - 'HOME': '/home/cltbld', 19:57:47 INFO - 'LANG': 'en_US.UTF-8', 19:57:47 INFO - 'LANGUAGE': 'en_US:en', 19:57:47 INFO - 'LOGNAME': 'cltbld', 19:57:47 INFO - 'MAIL': '/var/mail/cltbld', 19:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:47 INFO - 'MOZ_NO_REMOTE': '1', 19:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:47 INFO - 'NO_EM_RESTART': '1', 19:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:47 INFO - 'SHELL': '/bin/bash', 19:57:47 INFO - 'SHLVL': '1', 19:57:47 INFO - 'TERM': 'linux', 19:57:47 INFO - 'TMOUT': '86400', 19:57:47 INFO - 'USER': 'cltbld', 19:57:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:47 INFO - '_': '/tools/buildbot/bin/python'} 19:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:48 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 19:57:48 INFO - Cleaning up... 19:57:48 INFO - Return code: 0 19:57:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:57:48 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')]} 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:48 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')]} 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:48 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:48 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 19:57:48 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 19:57:48 INFO - Using env: {'DISPLAY': ':0', 19:57:48 INFO - 'HOME': '/home/cltbld', 19:57:48 INFO - 'LANG': 'en_US.UTF-8', 19:57:48 INFO - 'LANGUAGE': 'en_US:en', 19:57:48 INFO - 'LOGNAME': 'cltbld', 19:57:48 INFO - 'MAIL': '/var/mail/cltbld', 19:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:48 INFO - 'MOZ_NO_REMOTE': '1', 19:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:48 INFO - 'NO_EM_RESTART': '1', 19:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:48 INFO - 'SHELL': '/bin/bash', 19:57:48 INFO - 'SHLVL': '1', 19:57:48 INFO - 'TERM': 'linux', 19:57:48 INFO - 'TMOUT': '86400', 19:57:48 INFO - 'USER': 'cltbld', 19:57:48 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:48 INFO - '_': '/tools/buildbot/bin/python'} 19:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:48 INFO - Downloading/unpacking psutil>=0.7.1 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:57:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:50 INFO - Installing collected packages: psutil 19:57:50 INFO - Running setup.py install for psutil 19:57:50 INFO - building 'psutil._psutil_linux' extension 19:57:50 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 19:57:50 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 19:57:50 INFO - building 'psutil._psutil_posix' extension 19:57:50 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 19:57:50 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 19:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:50 INFO - Successfully installed psutil 19:57:50 INFO - Cleaning up... 19:57:50 INFO - Return code: 0 19:57:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:57:50 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')]} 19:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:50 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')]} 19:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:50 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:50 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 19:57:50 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 19:57:50 INFO - Using env: {'DISPLAY': ':0', 19:57:50 INFO - 'HOME': '/home/cltbld', 19:57:50 INFO - 'LANG': 'en_US.UTF-8', 19:57:50 INFO - 'LANGUAGE': 'en_US:en', 19:57:50 INFO - 'LOGNAME': 'cltbld', 19:57:50 INFO - 'MAIL': '/var/mail/cltbld', 19:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:50 INFO - 'MOZ_NO_REMOTE': '1', 19:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:50 INFO - 'NO_EM_RESTART': '1', 19:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:50 INFO - 'SHELL': '/bin/bash', 19:57:50 INFO - 'SHLVL': '1', 19:57:50 INFO - 'TERM': 'linux', 19:57:50 INFO - 'TMOUT': '86400', 19:57:50 INFO - 'USER': 'cltbld', 19:57:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:50 INFO - '_': '/tools/buildbot/bin/python'} 19:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:57:50 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 19:57:50 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 19:57:50 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 19:57:50 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 19:57:50 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 19:57:50 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 19:57:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:57:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:57:52 INFO - Installing collected packages: mozsystemmonitor 19:57:52 INFO - Running setup.py install for mozsystemmonitor 19:57:52 INFO - Successfully installed mozsystemmonitor 19:57:52 INFO - Cleaning up... 19:57:52 INFO - Return code: 0 19:57:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:52 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:52 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 19:57:52 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 19:57:52 INFO - Using env: {'DISPLAY': ':0', 19:57:52 INFO - 'HOME': '/home/cltbld', 19:57:52 INFO - 'LANG': 'en_US.UTF-8', 19:57:52 INFO - 'LANGUAGE': 'en_US:en', 19:57:52 INFO - 'LOGNAME': 'cltbld', 19:57:52 INFO - 'MAIL': '/var/mail/cltbld', 19:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:52 INFO - 'MOZ_NO_REMOTE': '1', 19:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:52 INFO - 'NO_EM_RESTART': '1', 19:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:52 INFO - 'SHELL': '/bin/bash', 19:57:52 INFO - 'SHLVL': '1', 19:57:52 INFO - 'TERM': 'linux', 19:57:52 INFO - 'TMOUT': '86400', 19:57:52 INFO - 'USER': 'cltbld', 19:57:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:52 INFO - '_': '/tools/buildbot/bin/python'} 19:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:57:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:57:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:57:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:57:55 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 19:57:55 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 19:57:55 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 19:57:55 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 19:57:55 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 19:57:55 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 19:57:55 INFO - Downloading docopt-0.6.1.tar.gz 19:57:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:57:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:57:55 INFO - Running setup.py install for blobuploader 19:57:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:57:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:57:55 INFO - Running setup.py install for requests 19:57:56 INFO - Running setup.py install for docopt 19:57:56 INFO - Successfully installed blobuploader requests docopt 19:57:56 INFO - Cleaning up... 19:57:56 INFO - Return code: 0 19:57:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:56 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:56 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 19:57:56 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 19:57:56 INFO - Using env: {'DISPLAY': ':0', 19:57:56 INFO - 'HOME': '/home/cltbld', 19:57:56 INFO - 'LANG': 'en_US.UTF-8', 19:57:56 INFO - 'LANGUAGE': 'en_US:en', 19:57:56 INFO - 'LOGNAME': 'cltbld', 19:57:56 INFO - 'MAIL': '/var/mail/cltbld', 19:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:56 INFO - 'MOZ_NO_REMOTE': '1', 19:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:56 INFO - 'NO_EM_RESTART': '1', 19:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:56 INFO - 'SHELL': '/bin/bash', 19:57:56 INFO - 'SHLVL': '1', 19:57:56 INFO - 'TERM': 'linux', 19:57:56 INFO - 'TMOUT': '86400', 19:57:56 INFO - 'USER': 'cltbld', 19:57:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:56 INFO - '_': '/tools/buildbot/bin/python'} 19:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:56 INFO - Running setup.py (path:/tmp/pip-c1Mcg5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:56 INFO - Running setup.py (path:/tmp/pip-8qXNOT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:56 INFO - Running setup.py (path:/tmp/pip-Ho_Cpz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:56 INFO - Running setup.py (path:/tmp/pip-HqseXv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:56 INFO - Running setup.py (path:/tmp/pip-VuAs26-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:56 INFO - Running setup.py (path:/tmp/pip-rnH1xe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57:56 INFO - Running setup.py (path:/tmp/pip-BshBm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57:56 INFO - Running setup.py (path:/tmp/pip-LhWxWF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:57 INFO - Running setup.py (path:/tmp/pip-f510wl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:57 INFO - Running setup.py (path:/tmp/pip-fZ8j37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57:57 INFO - Running setup.py (path:/tmp/pip-fh4y2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57:57 INFO - Running setup.py (path:/tmp/pip-V7tbCH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57:57 INFO - Running setup.py (path:/tmp/pip-25wfFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57:57 INFO - Running setup.py (path:/tmp/pip-ZspC49-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57:57 INFO - Running setup.py (path:/tmp/pip-5WgbQY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:57:57 INFO - Running setup.py (path:/tmp/pip-Mv32kU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:57:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57:57 INFO - Running setup.py (path:/tmp/pip-tg5N0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:57:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:57:57 INFO - Running setup.py install for manifestparser 19:57:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:57:57 INFO - Running setup.py install for mozcrash 19:57:57 INFO - Running setup.py install for mozdebug 19:57:57 INFO - Running setup.py install for mozdevice 19:57:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozfile 19:57:58 INFO - Running setup.py install for mozhttpd 19:57:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozinfo 19:57:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozInstall 19:57:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozleak 19:57:58 INFO - Running setup.py install for mozlog 19:57:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for moznetwork 19:57:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozprocess 19:57:58 INFO - Running setup.py install for mozprofile 19:57:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:57:58 INFO - Running setup.py install for mozrunner 19:57:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:57:59 INFO - Running setup.py install for mozscreenshot 19:57:59 INFO - Running setup.py install for moztest 19:57:59 INFO - Running setup.py install for mozversion 19:57:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:57:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:57:59 INFO - Cleaning up... 19:57:59 INFO - Return code: 0 19:57:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:59 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:57:59 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 19:57:59 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 19:57:59 INFO - Using env: {'DISPLAY': ':0', 19:57:59 INFO - 'HOME': '/home/cltbld', 19:57:59 INFO - 'LANG': 'en_US.UTF-8', 19:57:59 INFO - 'LANGUAGE': 'en_US:en', 19:57:59 INFO - 'LOGNAME': 'cltbld', 19:57:59 INFO - 'MAIL': '/var/mail/cltbld', 19:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:59 INFO - 'MOZ_NO_REMOTE': '1', 19:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:57:59 INFO - 'NO_EM_RESTART': '1', 19:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:57:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:57:59 INFO - 'SHELL': '/bin/bash', 19:57:59 INFO - 'SHLVL': '1', 19:57:59 INFO - 'TERM': 'linux', 19:57:59 INFO - 'TMOUT': '86400', 19:57:59 INFO - 'USER': 'cltbld', 19:57:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:59 INFO - '_': '/tools/buildbot/bin/python'} 19:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:59 INFO - Running setup.py (path:/tmp/pip-77CfMv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:57:59 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)) 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:59 INFO - Running setup.py (path:/tmp/pip-soqfKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:57:59 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)) 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:59 INFO - Running setup.py (path:/tmp/pip-lU4fiM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:57:59 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)) 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:59 INFO - Running setup.py (path:/tmp/pip-3FmX3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:57:59 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)) 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:59 INFO - Running setup.py (path:/tmp/pip-tsQxpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:57:59 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)) 19:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:57:59 INFO - Running setup.py (path:/tmp/pip-2azH0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:00 INFO - Running setup.py (path:/tmp/pip-uVUXc1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:00 INFO - Running setup.py (path:/tmp/pip-arXmn4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:00 INFO - Running setup.py (path:/tmp/pip-SaSErM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:00 INFO - Running setup.py (path:/tmp/pip-gJKNAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:00 INFO - Running setup.py (path:/tmp/pip-gI_CAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:00 INFO - Running setup.py (path:/tmp/pip-Xlu6GI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:00 INFO - Running setup.py (path:/tmp/pip-mIvbLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:00 INFO - Running setup.py (path:/tmp/pip-_3kBHD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:00 INFO - Running setup.py (path:/tmp/pip-4kdQOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:00 INFO - Running setup.py (path:/tmp/pip-4Qb_5e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:58:00 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)) 19:58:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:00 INFO - Running setup.py (path:/tmp/pip-QZvl1m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:58:00 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)) 19:58:00 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)) 19:58:00 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)) 19:58:00 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)) 19:58:00 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)) 19:58:00 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)) 19:58:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:00 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 19:58:00 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 19:58:00 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 19:58:00 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 19:58:00 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 19:58:00 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 19:58:02 INFO - Downloading blessings-1.6.tar.gz 19:58:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:02 INFO - Installing collected packages: blessings 19:58:02 INFO - Running setup.py install for blessings 19:58:02 INFO - Successfully installed blessings 19:58:02 INFO - Cleaning up... 19:58:02 INFO - Return code: 0 19:58:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:58:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:03 INFO - Reading from file tmpfile_stdout 19:58:03 INFO - Current package versions: 19:58:03 INFO - argparse == 1.2.1 19:58:03 INFO - blessings == 1.6 19:58:03 INFO - blobuploader == 1.2.4 19:58:03 INFO - docopt == 0.6.1 19:58:03 INFO - manifestparser == 1.1 19:58:03 INFO - mozInstall == 1.12 19:58:03 INFO - mozcrash == 0.16 19:58:03 INFO - mozdebug == 0.1 19:58:03 INFO - mozdevice == 0.48 19:58:03 INFO - mozfile == 1.2 19:58:03 INFO - mozhttpd == 0.7 19:58:03 INFO - mozinfo == 0.9 19:58:03 INFO - mozleak == 0.1 19:58:03 INFO - mozlog == 3.1 19:58:03 INFO - moznetwork == 0.27 19:58:03 INFO - mozprocess == 0.22 19:58:03 INFO - mozprofile == 0.28 19:58:03 INFO - mozrunner == 6.11 19:58:03 INFO - mozscreenshot == 0.1 19:58:03 INFO - mozsystemmonitor == 0.0 19:58:03 INFO - moztest == 0.7 19:58:03 INFO - mozversion == 1.4 19:58:03 INFO - psutil == 3.1.1 19:58:03 INFO - requests == 1.2.3 19:58:03 INFO - wsgiref == 0.1.2 19:58:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:58:03 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 19:58:03 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 19:58:03 INFO - Using env: {'DISPLAY': ':0', 19:58:03 INFO - 'HOME': '/home/cltbld', 19:58:03 INFO - 'LANG': 'en_US.UTF-8', 19:58:03 INFO - 'LANGUAGE': 'en_US:en', 19:58:03 INFO - 'LOGNAME': 'cltbld', 19:58:03 INFO - 'MAIL': '/var/mail/cltbld', 19:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:03 INFO - 'MOZ_NO_REMOTE': '1', 19:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:03 INFO - 'NO_EM_RESTART': '1', 19:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:03 INFO - 'SHELL': '/bin/bash', 19:58:03 INFO - 'SHLVL': '1', 19:58:03 INFO - 'TERM': 'linux', 19:58:03 INFO - 'TMOUT': '86400', 19:58:03 INFO - 'USER': 'cltbld', 19:58:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:03 INFO - '_': '/tools/buildbot/bin/python'} 19:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 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)) 19:58:03 INFO - Cleaning up... 19:58:03 INFO - Return code: 0 19:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:03 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 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:58:03 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 19:58:03 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 19:58:03 INFO - Using env: {'DISPLAY': ':0', 19:58:03 INFO - 'HOME': '/home/cltbld', 19:58:03 INFO - 'LANG': 'en_US.UTF-8', 19:58:03 INFO - 'LANGUAGE': 'en_US:en', 19:58:03 INFO - 'LOGNAME': 'cltbld', 19:58:03 INFO - 'MAIL': '/var/mail/cltbld', 19:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:03 INFO - 'MOZ_NO_REMOTE': '1', 19:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:03 INFO - 'NO_EM_RESTART': '1', 19:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:03 INFO - 'SHELL': '/bin/bash', 19:58:03 INFO - 'SHLVL': '1', 19:58:03 INFO - 'TERM': 'linux', 19:58:03 INFO - 'TMOUT': '86400', 19:58:03 INFO - 'USER': 'cltbld', 19:58:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:03 INFO - '_': '/tools/buildbot/bin/python'} 19:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:03 INFO - Downloading/unpacking jsonschema 19:58:03 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 19:58:03 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 19:58:03 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 19:58:03 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 19:58:03 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 19:58:03 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 19:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:05 INFO - Downloading/unpacking functools32 (from jsonschema) 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:05 INFO - warning: no files found matching '*.txt' 19:58:05 INFO - no previously-included directories found matching 'build' 19:58:05 INFO - no previously-included directories found matching 'dist' 19:58:05 INFO - no previously-included directories found matching '.git*' 19:58:05 INFO - Installing collected packages: jsonschema, functools32 19:58:05 INFO - Running setup.py install for functools32 19:58:05 INFO - warning: no files found matching '*.txt' 19:58:05 INFO - no previously-included directories found matching 'build' 19:58:05 INFO - no previously-included directories found matching 'dist' 19:58:05 INFO - no previously-included directories found matching '.git*' 19:58:05 INFO - Successfully installed jsonschema functools32 19:58:05 INFO - Cleaning up... 19:58:05 INFO - Return code: 0 19:58:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef8dd0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efb670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', '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 19:58:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:58:05 INFO - Using env: {'DISPLAY': ':0', 19:58:05 INFO - 'HOME': '/home/cltbld', 19:58:05 INFO - 'LANG': 'en_US.UTF-8', 19:58:05 INFO - 'LANGUAGE': 'en_US:en', 19:58:05 INFO - 'LOGNAME': 'cltbld', 19:58:05 INFO - 'MAIL': '/var/mail/cltbld', 19:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:05 INFO - 'MOZ_NO_REMOTE': '1', 19:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:05 INFO - 'NO_EM_RESTART': '1', 19:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:05 INFO - 'SHELL': '/bin/bash', 19:58:05 INFO - 'SHLVL': '1', 19:58:05 INFO - 'TERM': 'linux', 19:58:05 INFO - 'TMOUT': '86400', 19:58:05 INFO - 'USER': 'cltbld', 19:58:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:05 INFO - '_': '/tools/buildbot/bin/python'} 19:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:05 INFO - Downloading/unpacking flake8 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:58:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:58:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58: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 19:58:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:08 INFO - no previously-included directories found matching 'docs/_build' 19:58:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:58:08 INFO - Running setup.py install for pep8 19:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:58:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:58:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:58:08 INFO - no previously-included directories found matching 'docs/_build' 19:58:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:58:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:58:08 INFO - Cleaning up... 19:58:08 INFO - Return code: 0 19:58:08 INFO - Running post-action listener: _resource_record_post_action 19:58:08 INFO - Running post-action listener: _start_resource_monitoring 19:58:08 INFO - Starting resource monitoring. 19:58:08 INFO - ##### 19:58:08 INFO - ##### Running install step. 19:58:08 INFO - ##### 19:58:08 INFO - Running pre-action listener: _resource_record_pre_action 19:58:08 INFO - Running main action method: install 19:58:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:58:08 INFO - Reading from file tmpfile_stdout 19:58:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:58:09 INFO - Reading from file tmpfile_stdout 19:58:09 INFO - Output received: 19:58:09 INFO - Usage: mozinstall [options] installer 19:58:09 INFO - Options: 19:58:09 INFO - -h, --help show this help message and exit 19:58:09 INFO - -d DEST, --destination=DEST 19:58:09 INFO - Directory to install application into. [default: 19:58:09 INFO - "/builds/slave/test-pgo"] 19:58:09 INFO - --app=APP Application being installed. [default: firefox] 19:58:09 INFO - mkdir: /builds/slave/test-pgo/build/application 19:58:09 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'] 19:58:09 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 19:58:25 INFO - Reading from file tmpfile_stdout 19:58:25 INFO - Output received: 19:58:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:58:25 INFO - Running post-action listener: _resource_record_post_action 19:58:25 INFO - ##### 19:58:25 INFO - ##### Running run-tests step. 19:58:25 INFO - ##### 19:58:25 INFO - Running pre-action listener: _resource_record_pre_action 19:58:25 INFO - Running main action method: run_tests 19:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:58:25 INFO - Python 2.7.3 19:58:25 INFO - Return code: 0 19:58:25 INFO - grabbing minidump binary from tooltool 19:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:58:25 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 0x1f8a8c0>, '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 0x1f8b7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8bc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:58:25 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 19:58:25 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 19:58:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:58:25 INFO - Return code: 0 19:58:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:58:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:58:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:58:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:58:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:58:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:58:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:58:26 INFO - Return code: 0 19:58:26 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/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 19:58:26 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/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 19:58:26 INFO - Using env: {'DISPLAY': ':0', 19:58:26 INFO - 'HOME': '/home/cltbld', 19:58:26 INFO - 'LANG': 'en_US.UTF-8', 19:58:26 INFO - 'LANGUAGE': 'en_US:en', 19:58:26 INFO - 'LOGNAME': 'cltbld', 19:58:26 INFO - 'MAIL': '/var/mail/cltbld', 19:58:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:58:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:26 INFO - 'MOZ_NO_REMOTE': '1', 19:58:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:58:26 INFO - 'NO_EM_RESTART': '1', 19:58:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:58:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:58:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:58:26 INFO - 'SHELL': '/bin/bash', 19:58:26 INFO - 'SHLVL': '1', 19:58:26 INFO - 'TERM': 'linux', 19:58:26 INFO - 'TMOUT': '86400', 19:58:26 INFO - 'USER': 'cltbld', 19:58:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711', 19:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:26 INFO - '_': '/tools/buildbot/bin/python'} 19:58:26 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/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 19:58:26 INFO - mozversion application_buildid: 20160211173012 19:58:26 INFO - mozversion application_changeset: 1e0af75b4c44da3271e51941561b582b42709a77 19:58:26 INFO - mozversion application_display_name: Nightly 19:58:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:58:26 INFO - mozversion application_name: Firefox 19:58:26 INFO - mozversion application_remotingname: firefox 19:58:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:58:26 INFO - mozversion application_vendor: Mozilla 19:58:26 INFO - mozversion application_version: 47.0a1 19:58:26 INFO - mozversion platform_buildid: 20160211173012 19:58:26 INFO - mozversion platform_changeset: 1e0af75b4c44da3271e51941561b582b42709a77 19:58:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:58:26 INFO - mozversion platform_version: 47.0a1 19:58:26 INFO - using testdate: 1455249506 19:58:26 INFO - actual date: 1455249506 19:58:26 INFO - starting webserver on 'localhost:39380' 19:58:26 INFO - SUITE-START | Running 2 tests 19:58:26 INFO - TEST-START | dromaeo_css 19:58:26 INFO - operating with platform_type : linux_ 19:58:26 INFO - Initialising browser for dromaeo_css test... 19:58:26 INFO - TEST-INFO | started process 19883 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLEkmup/profile http://localhost:39380/getInfo.html) 19:58:30 INFO - PROCESS | 19883 | __metrics Screen width/height:1600/1200 19:58:30 INFO - PROCESS | 19883 | colorDepth:24 19:58:30 INFO - PROCESS | 19883 | Browser inner width/height: 1024/697 19:58:30 INFO - PROCESS | 19883 | __metrics 19:58:30 INFO - PROCESS | 19883 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:58:31 INFO - TEST-INFO | 19883: exit 0 19:58:31 INFO - Browser initialized. 19:58:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:58:31 INFO - TEST-INFO | started process 19975 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLEkmup/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:58:43 INFO - PROCESS | 19975 | RSS: Main: 153915392 19:58:43 INFO - PROCESS | 19975 | 19:59:34 INFO - PROCESS | 19975 | 1455249574595 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:01:43 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39380/tests/dromaeo/cssquery-ext.html) 20:01:44 INFO - PROCESS | 19975 | RSS: Main: 257523712 20:01:44 INFO - PROCESS | 19975 | 20:04:46 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-ext.html (next: http://localhost:39380/tests/dromaeo/cssquery-jquery.html) 20:04:47 INFO - PROCESS | 19975 | RSS: Main: 247836672 20:04:47 INFO - PROCESS | 19975 | 20:07:49 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39380/tests/dromaeo/cssquery-mootools.html) 20:07:49 INFO - PROCESS | 19975 | RSS: Main: 252993536 20:07:49 INFO - PROCESS | 19975 | 20:10:51 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39380/tests/dromaeo/cssquery-prototype.html) 20:10:52 INFO - PROCESS | 19975 | RSS: Main: 221945856 20:10:52 INFO - PROCESS | 19975 | 20:13:54 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39380/tests/dromaeo/cssquery-yui.html) 20:13:55 INFO - PROCESS | 19975 | RSS: Main: 224280576 20:13:55 INFO - PROCESS | 19975 | 20:16:57 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:39380/tests/dromaeo/cssquery-yui.html (next: http://localhost:39380/tests/dromaeo/cssquery-dojo.html) 20:16:58 INFO - PROCESS | 19975 | RSS: Main: 265801728 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | __start_tp_report 20:16:58 INFO - PROCESS | 19975 | _x_x_mozilla_page_load 20:16:58 INFO - PROCESS | 19975 | _x_x_mozilla_page_load_details 20:16:58 INFO - PROCESS | 19975 | |i|pagename|runs| 20:16:58 INFO - PROCESS | 19975 | |0;dojo.html;3116.922076948076;3117.7194052535283;3126.765492588055;3136.654967953526;3189.7288730457904;5013.172826483635;5047.141985862403;5103.081445339842;5105;5131.230315452684;5066.544011039005;5084.262781896623;5098.821541246057;5114.923276150861;5146.125158723016;4611.584957353837;4627.999999999992;4639.976800116012;4682.274247491628;4854.053459575384;4593.586577208051;4762.761861906908;4778.116048531016;4791.2813078038225;4862.465128835825;4642.257238841786;4691.62467002639;4712.3167140764735;4716.363290955712;4764.6426518011285;4689.1793936061395;4691.202495575761;4700.576948074689;4722.409698787652;4722.527747225285;4604.010137820384;4651.488336283006;4682;4701.435827700698;4722.197226471508;4947.554720075211;4983.700977941335;4997.225430058311;5003.74981250936;5018.723970181639;5521.199426083235;5532;5536.695481748502;5583.6928968906695;5583.972080139573;5292.126799078147;5514.200440936082;5537.556995440355;5584.804531841407;5616.66300022;5193.402758682724;5222.138347172674;5222.999999999962;5223.895522089575;5228.4510126436935;5532.944670553324;5605.607607467519;5605.747741351649;5656.8868622627315;5657.773689052474;5348.277982472394;5352.464753524617;5377.623566350318;5379;5398.541124004425;5495.835124946258;5511;5511.807086751945;5517.69652669099;5522.585806064561;5379;5474.616776825664;5512.228288039678;5518.475744804237;5578.330600327987;5462.3445186577865;5502.147167189092;5508.55931525477;5511.366192887789;5516.889662206733;4197.601227883346;4256.978715106405;4257.978710106429;4258.787060646955;4295.076558539929;3755.399136138205;3794.354959656865;3831.750936189139;3876.3797792353653;3878.825452854628;5152.201408781645;5162.664426812245;5179.067767801832;5193.143131383279;5242.056429842589;5405.729713514309;5415.783368665288;5433.049216387117;5437.972810136003;5491.670499770026;5007;5073.239014147834;5081.872953176126;5084;5104.846854594368;4727.267273572602;4738.289256611467;4751;4756.7145971241835;4788.688735232199;5709.8287051388525;5717.428257174332;5718.628289161191;5728.598998070095;5733.88532229353;5316.388615309289;5399.622026458111;5459.863503412446;5467.863303417446;5590.385057643737;5710.65736055838;5746;5748.195252664546;5750.539956803362;5762.394948530512;5450.1007333789485;5467.07059799843;5468.207109968953;5469.781208751605;5470.343558772973;5397.9190312144565;5453.972730136324;5506;5530.364008138955;5577.051901176728;5338.4394638563945;5356.544693701079;5357.8392648220615;5361.597880158925;5362.383325917569;5189.584833213258;5331.226972088948;5346.919796203138;5347.171188465794;5391.892162156813;5099.77051032697;5148.742562871917;5164.431912489698;5188.22176673502;5211.895762084661;5295.179247216687;5301.602379821606;5301.655392399482;5306.575473961997;5326;5206.479352064915;5224.164133738584;5226.216067589892;5266.762995665281;5310.256564080954 20:16:58 INFO - PROCESS | 19975 | |1;ext.html;528.912729399649;532.5872448852136;534.1853673148448;549.5795716277049;556.251841273487;28552;35650.46524302135;36465.99999999996;36570;36599.45100823483;39341.409878851766;39756.80121599395;39757.40363894544;39845.203095938065;39901.60098399015;8559.315254779634;8744.34417418693;8748.431351962134;8751.868721969175;8757.124287571256;8481.363897707666;8579;8585.055643879168;8604;8606.354523410739;8603.655853765842;8838.381313308071;8907.376483646147;8908.643654253821;8927.821443571125;8780.25367843734;8853.291736661116;8854.29165666745;8854.911450885473;8857.778555536132;8769.210771030637;8896.37725359225;8911.19799218067;8912.376133670645;8914.28685705142;39860.6188164597;40199.59800402017;40291.798541007105;40307.193856122714;40318.79840600808;3329.6503867094093;3689.981550092259;4077.3680079587416;4083.3670781028986;4198.6011328924005;30143;30635.846820765975;31251.062468125994;31528.32009279214;31549.684503154906;3856.5179352580926;3868.9226215475815;3879.4180872869297;3881.8059097045034;3904.082540602956;261700;262654;262796.6860165706;263468;264353;55000.44999549953;55007.07475238347;55207.72396138074;55341.44658553363;55404.44595554074;52494.73752631212;53620.463795362324;59406.70296648489;59455.10817337743;60672.39327606756;13411.195328280335;13472.191668499921;13489.190648561118;13511.662208444868;13621.978351623668;9134.497602631785;11009.83485247722;11056.391898445663;11082.168837337233;11087.445627718582;18605.81394186068;18929.43211703651;18971.146298416603;18979.24083036663;19170;7407.148177959603;7741.767746967487;7753.8449231015065;7754.224577542313;7912.9208707912185;962.4658314635304;988.906053924876;1008.2337423558149;1086.8098082835472;1154.9720748533812;29666.258343541584;29878.588403750786;29925.651478302287;30042.69957300399;30104.548431773543;1021.9846702299471;1036.9377837329785;1062.2033474893828;1141.5490881102085;1200.33981310279;15251;15670.921645391929;15741.921290393475;15800.68398632021;15920.840791592167;301355;301443;302334;304624;305124;52073.73963130236;52395;52592.474075259524;52934.73532632312;52946.470535294924;672.3310306245318;980.7548112971757;1140.4810811080938;1247.8502579690496;1275.6428200104172;25126.246212613652;26136.477270454103;26221.868890656187;26242.343941401617;26289.21132366032;40831.38752918768;40885.795571021954;41532.37701434542;41635.583644164384;41736.37395439132;267348;386784;397601;398211;398718;29604;30029.5495567571;30107.247318817204;30126;30130.24674383158;40840;41648;41702.37446438367;42347.57652423436;42418.363724544775;35106.29787404289;35449;35606;35902;35973.1006724834;35295.82352088223;36063;36083.278334433686;36156;36162.819185904955;35448;36649.63350366462;36766;36833.26333473262;36934.8153259232;30372.240693981945;33635.66364336325;33810.83094584511;33883;34064.31871362509;24115;25129.87435062813;25210.74789252084;25284.058246311735;25481.490370192863 20:16:58 INFO - PROCESS | 19975 | |2;jquery.html;335.49697355845797;346.18818869750424;366.152357292867;366.8899330200941;367.4304827517348;13942.930285348559;14238.430462781476;16523.256453459595;17300.394486192985;18843;15460.768088478682;15922.681546369095;16304.918475407607;17085.316587336492;17116.657666846655;4897.363342765436;5059.620528460362;5062.240663900426;5067.771950262247;5068.695878247317;3808.1431677872397;4979.875503112415;5237.319148510688;5426.21319908613;5440.129579267318;5312;5384;5414.133738601825;5431.2396264522995;5437.945620543784;5431.348238211401;5441.2654291670515;5462.8361149165585;5485.725713714318;5486.91769623456;5195.428502864682;5216.7913283468615;5220.9738951305;5269.235960785664;5449.727513624303;12944.352782360938;13106.60680179596;15921.363145474166;20798.27206047781;20844.5831083379;2158.98920505398;2233.6314508106143;2235.0724449353497;2238.597052530544;2259.5254996450767;9459.38513996588;9483.715488535356;9555.283353748497;9644.807103857884;9782.902170978341;1791.7849858016991;1831.0661562603036;1831.5146486181172;1870.560418301698;1882.4352694191825;57121;59515.404845951416;61407.69296153535;62164;62223.06665400023;9880.40717556949;10021.549030293654;10057.075575245888;10069.748256293506;10343.793124137626;12588;12701.110922235355;12739.36303184837;12740.80888786669;12761.234325940473;6558.508111891627;6610.107635469246;6642.202935647753;6667.933320666828;6702.59784412927;6474.9676251619385;6480.837979050561;6689.03009063683;6690.4647628190605;6986.720531178696;4101.938470922939;4125.64931980785;4167.041580436517;4169.10364271683;4335.913281734411;1698.4395149600603;1721.8364255395968;1734.7137722275936;1752.5881417866792;1827.7258411238154;824.1511243419287;858.1898459136575;887.627196577439;900.0729248873671;1013.4881884648353;16565.751513727304;16912.492625221017;17330.3067877286;17448.389306374214;17784;815.3273549321715;844.8648216285364;875.6103533927342;990.5592011554933;1055.2771351624162;9001.54992250385;9241.861372079424;9300.302477314228;9330.92694340146;9388.295877809192;514976;516613;516753;523252;534591;70985.64507177535;74927;75269.24730752732;76754;77426;1049.459528342904;1051.169576034924;1111.2388014210292;1122.8484154639182;1125.4654039331251;14711;14752.409903603735;14925.626859328604;15234.619134521725;15719.764203536728;30712.464376781518;30898.227544310674;31216;31624.683753162175;33956.15109622279;40503;43477.34783978306;43851.34222986594;43871.34192987044;43908.560914391725;7329.267073292628;7588.354989825927;7618.428617853794;7707.421943354383;7750;9908.752281193028;12011.519539218334;12091.879081209076;12104.334261615695;12152.513899444277;8789.824203515765;10310.226732995205;10471.790564188826;10698.89301106979;10915.454227288763;10117.19062475015;10516.579336826748;10519.73700657459;10569.471526423802;10761.354318740587;10816.783664326513;11044.834327484934;11149.554017839195;11240.100791936462;11271.830922536332;6639.070530125689;6805.523613347018;7367.852642947219;7626.3898888089925;7767.339776119094;10229.84655230187;10672.146228301563;10763.838542421714;11034.944825276143;11167.274127182032 20:16:58 INFO - PROCESS | 19975 | |3;mootools.html;1324.609240274119;1463.1586837568398;1467.1417220925757;1653.9421120260793;1857.684193687074;7033.683484243208;7482.326590606851;7652.540847549137;7657.655405506752;7674.884876726854;7495.400367970563;7685.193054729257;7700.614969251543;7731.149573546905;7734.5745983970855;2027.0472877747509;2261.072960086365;2269.3986093685185;2283.9885800570974;2314.9652755208685;2369.7985671217966;2373.3473294843884;2379.2624286471164;2381.2499062795164;2382.130522359335;2269.126386341254;2323.140438037928;2327.3367090379247;2329.77867102625;2330.9184178553755;2290.3586995641163;2305.9077636894503;2306.9307920762403;2309.0763694522157;2315.710536182977;2299.1837897546297;2307.492351682644;2319.373769082355;2328.6739856420113;2348.377679914824;7959.9602001989615;8010.919890801076;8035.477693949933;8039.598020098972;8046.074701409354;4728.881777955578;4832.73419961902;4864.78108485119;4867.878303042452;4876.609871210295;3137.403893260296;3178.8728450861936;3201.4237437261286;3299;3300.7029367356813;984.0946329376991;1009.7627057641448;1014.4724743133603;1016.755978565139;1056.4084112896726;10793.83809242862;10850.348979061202;10854.67435976922;10865.402402867918;10865.674029779118;4348.43470348859;4361.323994780751;4461.505395692479;4466.285394336891;4492.595666390041;9498.382605130782;9510.191633711212;9522.333436659368;9527.952360238154;9536.856947145798;4896.290037944478;4921.9507804921495;4925.507449255046;4932.3094766731965;4940.950590494121;4432.135733531994;4435.955640443619;4439.755813430293;4445.555444455528;4449.087936972913;3516.24400753834;3713;3747.1756213632957;3772.849086036583;3786.2048969716116;1190.4285942747529;1224.8530176378893;1241.7019915220462;1243.359669770069;1246.4141853328922;1303.074816880007;1312.0422091872986;1319.9274039927896;1341.6914109754812;1343.5700575815645;7213.963930180421;7273;7322.377597904131;7409.518381305198;7571.410003899133;1099.4502748625687;1112.9666110016713;1115.682030621269;1117.2961034548182;1122.7922834275685;5825.592208545446;5876.941230587725;5886.1465087562065;5887;5915.349311575723;9291.256699464027;9325.393849399767;9570.521473926276;9698.127168554864;9776.657816976372;9644;9648.469334186688;9656.22750179984;9658.661946831828;9659.758506037264;7309.488335816442;7335.8532829344185;7464;7470.887936680954;7526.09686837572;7203.495755297079;7209.855802883808;7282.927170728225;7283;7285.198628151005;8184.590770461334;8197;8263.586820658822;8383.41316107891;8409.411341206056;8364.707235246737;8520.233179013918;8522.74431767048;8527.445716028438;8542.572871356531;6270.811875643738;6696.19645642526;6894.827629309308;6895.4138898194215;6924;7412.407007439284;7546.698132074655;7548.509346892434;7551.660175292015;7570.621468926642;6817.079694241214;6846.178458585002;6848.452123829982;6896.344847239504;6950.826229344105;6854.2117656470145;6942.652867356713;6991.965040174767;7076.256993015865;7092.290770922867;6973.372396484341;7088.291170882871;7136.4647651427385;7153.070100886852;7325.890111648223;6341.936580634319;6369.33122022181;6372.330905254881;6376.808695739135;6378;6230.532710046674;6249.437550620466;6260.937390626035;6266.185395898504;6266.248050234001 20:16:58 INFO - PROCESS | 19975 | |4;prototype.html;333.3649397897007;334.2812952152872;338.3824520250542;339.8351799377302;347.81044330839705;5779.508741756956;5854.853628659285;5906;5964.761409543618;6025.18659980903;5769.798057068004;5839;5875.76496940123;5904.911426328608;5915.5859089863725;4641.071785642868;4646.465656449518;4651.534846515356;4657.254839225725;4660.697054691451;4396.186705459484;4464.866054018385;4489.6408287336935;4512.661550383718;4639.6752227344095;4543.295789152687;4580.015296711206;4589.059242855224;4595.195840727876;4611.976940115312;4591.104734576759;4596.3794887690065;4601.309803529464;4606.516315786827;4612.1698094343;4076.6534844537955;4076.6942479313875;4079.796010199478;4091.2635725569385;4094.733842300241;5644.57665675076;5715.971420142914;5725.971370143123;5740.1102829061565;5746.166805813134;5361.463853614608;5364.490373414519;5377.489138531833;5381.381141168777;5384.0847056000575;5992;6298.401651843067;6304.747810087591;6312.968435157794;6313.2424109107205;4367.388565600819;4467.7542735149555;4473.507914129443;4487.326900964881;4487.461504619434;6541.0515475255825;6569.572977756478;6573.967130164367;6581.638009909453;6585.341465853424;4574.4739354973935;4587.334836448763;4590;4593.28804035375;4602.240630296031;4293.677974151951;4341.587549182823;4364.75993820343;4652.185867473178;4653.790579423934;5088.847334579968;5091.974540127276;5098.1842905135;5107.61692873036;5109.795608175631;6314.305426403092;6383.904241436289;6384.297727250092;6389.329120442287;6391.840203994844;1568.8195857476537;1584.4850423612372;1584.6672198838373;1585.1757086315051;1588.0233656301523;1046.99476502617;1052.1582733812918;1054.6045233037612;1068.6206396729206;1077.5959015369237;6062.333143354227;6063.7574497020505;6068.484178844759;6069.848253793691;6074.119252708332;6560.278369379364;6560.376764207393;6565.8358541035905;6569.83575410609;6584.144061272004;5944.405559444108;6044.24446944132;6047.697615119315;6058.1518587397795;6065;3462.79223246606;3538.6815186633326;3547.8935631931085;3551.3074950384425;3557.5197348358156;6790;6805.047293378931;6806.115205023315;6808.761693340709;6836.589804611739;6690.83272918181;6697.732090716317;6699;6700.463962882957;6700.832479187962;6639.070530125689;6767.154105736783;6870.931290687129;6887.035814985906;6907.861842763016;6353.428191462605;6477;6599.637019963948;6628.966855165886;6631.171103612049;6532.771353002622;6541.70562324706;6552.934470655233;6555.541112122106;6617.867642647217;6834.350736680008;6859.725610975505;6890.138732658418;6892.965535172292;6907.447404207752;4306.397104405323;4390.275604525217;4412.117576484652;4508.008238187594;4519.38988236597;6603.20761508622;6606.801795945937;6623.238327592196;6654.234763002317;6669;6363.268224154282;6393.680315984089;6394.840128996626;6397.680115994275;6420.935790642034;6262.655553944394;6372.789170057674;6379.202599675041;6429.099926010269;6466.288708242184;6310.1796766420075;6332.461740752087;6347.96826015867;6348.206474190726;6355.650439225887;6401.775937842153;6470.547061705635;6473.255575608865;6475.384838440341;6479.319671434431;6139.508839292936;6258.311585725475;6290.150829637941;6299.4645455135;6305.085762564494 20:16:58 INFO - PROCESS | 19975 | |5;yui.html;683.8632273545293;734.0457405373015;747.7046566606194;786.6656670914862;824.653645468903;13363.53227637033;13431.12697674653;13441.85744211742;13550;13576.93211533941;12903.096783225177;12936.094473386867;12944.546940857072;12948.546800861972;12953.935230323836;763.5914785589711;817.497239197892;817.8936738224022;818.1368656067846;818.153211426174;818.8444195602846;819.0785366462729;821.8274162425897;822.3873214455239;822.5147163173726;860.096898256831;869.8042940338405;869.8260347930408;870.1342164546254;870.3298460185654;857.2756021162108;862.8921384826897;863.5509535041774;865.6796985115516;866.9133086691344;637.6588525139028;637.8405398650337;637.987240255197;638.1735652330243;638.3106245255113;12518.436670349856;12539.93730031344;12563.18339307942;12563.623091307276;12577.371131443391;11898;12405.875941240653;12474.50101995919;12503.624891253277;12682.55611053618;9446.244300455946;9513.714588562354;9544.52277386128;9760.90239097607;9771.022897710172;3515.5374198466498;3640.763350382243;3645;3657.6159503252043;3659.2864391443677;50028.49971500275;50452;50614.7469262655;50827.49172508265;50917.74541127308;8992.505412202392;9214.44713317203;9273.258139348836;9387;9475.336726429221;16049.518514444586;16096.839031609768;16105.114218718083;16107;16144.434944776876;7285.854282914418;7396.852062958711;7436.293552112541;7622.161562228151;7851;4127.112670775738;4226.535081141072;4229.746215227035;4231.217224813419;4265.402843601898;3052.114886682837;3073.4006868660395;3077.476828939086;3079.9538006929915;3084.213525551015;563.1159080243978;578.2425023219596;583.804425517448;595.5652373767088;605.4944121658465;608.8721368512662;644.6551095164158;645.0904225042667;655.2366493035655;678.9849175482586;8411.789705257417;8610.956945215234;8625.223729864343;8707.608157632922;8779.378089968914;538.7602516880029;615.2647586134616;682.3279070115932;706.8444942112727;720.839448487934;3699.9075023124637;4288.442502474658;4341.240282950471;4376.474823021258;4404.075144219686;52842.47157528452;53574.196387054224;53813.730931345875;53831.461685382645;54048;40595.391069133984;45046;45370.31944520835;45660;52149.478505214465;38224.426633599964;43438;50320.74839625778;50496.242556361685;50753.492465075615;7681.654325555475;8332.625031873458;8551.315894728283;8592.183742544448;8791.648334066822;32249;33396.499052514715;33805.49291760576;34817;37570.624293757806;41479.585204147574;41721.37417938672;42324.78837605792;42537.78731106325;43004;10460.947695261475;10731.731706707395;10952.890471095187;11028.834567481656;11135.72160695989;11830.585929492427;11946.104042196695;11965.16243862956;12053.096017798525;12072.456739446921;11302.378369189773;11352.716182095513;11398.430078495876;11409.60066397672;11431.714207144887;10948.397838118979;11099.056580190774;11125.332480051224;11134.721631958942;11150.219484635998;10465.633702820365;10593.629222977466;10610.946945265225;10623.787524249627;10677.733056673645;9175.44947303164;9245.167934885892;9634.90365096368;9668.951655241679;9863.654772082942;9633.133018028131;9875.654352097643;9882.851757223503;9886.456244906312;9894.851577226491 20:16:58 INFO - PROCESS | 19975 | __end_tp_report 20:16:58 INFO - PROCESS | 19975 | __start_cc_report 20:16:58 INFO - PROCESS | 19975 | _x_x_mozilla_cycle_collect,821 20:16:58 INFO - PROCESS | 19975 | __end_cc_report 20:16:58 INFO - PROCESS | 19975 | __startTimestamp1455250618066__endTimestamp 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | ------- Summary: start ------- 20:16:58 INFO - PROCESS | 19975 | Number of tests: 6 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#0] dojo.html Cycles:165 Average:5102.67 Median:5228.45 stddev:549.24 (10.5%) stddev-sans-first:528.37 20:16:58 INFO - PROCESS | 19975 | Values: 3116.9 3117.7 3126.8 3136.7 3189.7 5013.2 5047.1 5103.1 5105.0 5131.2 5066.5 5084.3 5098.8 5114.9 5146.1 4611.6 4628.0 4640.0 4682.3 4854.1 4593.6 4762.8 4778.1 4791.3 4862.5 4642.3 4691.6 4712.3 4716.4 4764.6 4689.2 4691.2 4700.6 4722.4 4722.5 4604.0 4651.5 4682.0 4701.4 4722.2 4947.6 4983.7 4997.2 5003.7 5018.7 5521.2 5532.0 5536.7 5583.7 5584.0 5292.1 5514.2 5537.6 5584.8 5616.7 5193.4 5222.1 5223.0 5223.9 5228.5 5532.9 5605.6 5605.7 5656.9 5657.8 5348.3 5352.5 5377.6 5379.0 5398.5 5495.8 5511.0 5511.8 5517.7 5522.6 5379.0 5474.6 5512.2 5518.5 5578.3 5462.3 5502.1 5508.6 5511.4 5516.9 4197.6 4257.0 4258.0 4258.8 4295.1 3755.4 3794.4 3831.8 3876.4 3878.8 5152.2 5162.7 5179.1 5193.1 5242.1 5405.7 5415.8 5433.0 5438.0 5491.7 5007.0 5073.2 5081.9 5084.0 5104.8 4727.3 4738.3 4751.0 4756.7 4788.7 5709.8 5717.4 5718.6 5728.6 5733.9 5316.4 5399.6 5459.9 5467.9 5590.4 5710.7 5746.0 5748.2 5750.5 5762.4 5450.1 5467.1 5468.2 5469.8 5470.3 5397.9 5454.0 5506.0 5530.4 5577.1 5338.4 5356.5 5357.8 5361.6 5362.4 5189.6 5331.2 5346.9 5347.2 5391.9 5099.8 5148.7 5164.4 5188.2 5211.9 5295.2 5301.6 5301.7 5306.6 5326.0 5206.5 5224.2 5226.2 5266.8 5310.3 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#1] ext.html Cycles:180 Average:47318.69 Median:20261.62 stddev:83078.16 (410.0%) stddev-sans-first:83236.94 20:16:58 INFO - PROCESS | 19975 | Values: 528.9 532.6 534.2 549.6 556.3 28552.0 35650.5 36466.0 36570.0 36599.5 39341.4 39756.8 39757.4 39845.2 39901.6 8559.3 8744.3 8748.4 8751.9 8757.1 8481.4 8579.0 8585.1 8604.0 8606.4 8603.7 8838.4 8907.4 8908.6 8927.8 8780.3 8853.3 8854.3 8854.9 8857.8 8769.2 8896.4 8911.2 8912.4 8914.3 39860.6 40199.6 40291.8 40307.2 40318.8 3329.7 3690.0 4077.4 4083.4 4198.6 30143.0 30635.8 31251.1 31528.3 31549.7 3856.5 3868.9 3879.4 3881.8 3904.1 261700.0 262654.0 262796.7 263468.0 264353.0 55000.4 55007.1 55207.7 55341.4 55404.4 52494.7 53620.5 59406.7 59455.1 60672.4 13411.2 13472.2 13489.2 13511.7 13622.0 9134.5 11009.8 11056.4 11082.2 11087.4 18605.8 18929.4 18971.1 18979.2 19170.0 7407.1 7741.8 7753.8 7754.2 7912.9 962.5 988.9 1008.2 1086.8 1155.0 29666.3 29878.6 29925.7 30042.7 30104.5 1022.0 1036.9 1062.2 1141.5 1200.3 15251.0 15670.9 15741.9 15800.7 15920.8 301355.0 301443.0 302334.0 304624.0 305124.0 52073.7 52395.0 52592.5 52934.7 52946.5 672.3 980.8 1140.5 1247.9 1275.6 25126.2 26136.5 26221.9 26242.3 26289.2 40831.4 40885.8 41532.4 41635.6 41736.4 267348.0 386784.0 397601.0 398211.0 398718.0 29604.0 30029.5 30107.2 30126.0 30130.2 40840.0 41648.0 41702.4 42347.6 42418.4 35106.3 35449.0 35606.0 35902.0 35973.1 35295.8 36063.0 36083.3 36156.0 36162.8 35448.0 36649.6 36766.0 36833.3 36934.8 30372.2 33635.7 33810.8 33883.0 34064.3 24115.0 25129.9 25210.7 25284.1 25481.5 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#2] jquery.html Cycles:180 Average:27126.80 Median:22302.47 stddev:85248.30 (382.2%) stddev-sans-first:85463.71 20:16:58 INFO - PROCESS | 19975 | Values: 335.5 346.2 366.2 366.9 367.4 13942.9 14238.4 16523.3 17300.4 18843.0 15460.8 15922.7 16304.9 17085.3 17116.7 4897.4 5059.6 5062.2 5067.8 5068.7 3808.1 4979.9 5237.3 5426.2 5440.1 5312.0 5384.0 5414.1 5431.2 5437.9 5431.3 5441.3 5462.8 5485.7 5486.9 5195.4 5216.8 5221.0 5269.2 5449.7 12944.4 13106.6 15921.4 20798.3 20844.6 2159.0 2233.6 2235.1 2238.6 2259.5 9459.4 9483.7 9555.3 9644.8 9782.9 1791.8 1831.1 1831.5 1870.6 1882.4 57121.0 59515.4 61407.7 62164.0 62223.1 9880.4 10021.5 10057.1 10069.7 10343.8 12588.0 12701.1 12739.4 12740.8 12761.2 6558.5 6610.1 6642.2 6667.9 6702.6 6475.0 6480.8 6689.0 6690.5 6986.7 4101.9 4125.6 4167.0 4169.1 4335.9 1698.4 1721.8 1734.7 1752.6 1827.7 824.2 858.2 887.6 900.1 1013.5 16565.8 16912.5 17330.3 17448.4 17784.0 815.3 844.9 875.6 990.6 1055.3 9001.5 9241.9 9300.3 9330.9 9388.3 514976.0 516613.0 516753.0 523252.0 534591.0 70985.6 74927.0 75269.2 76754.0 77426.0 1049.5 1051.2 1111.2 1122.8 1125.5 14711.0 14752.4 14925.6 15234.6 15719.8 30712.5 30898.2 31216.0 31624.7 33956.2 40503.0 43477.3 43851.3 43871.3 43908.6 7329.3 7588.4 7618.4 7707.4 7750.0 9908.8 12011.5 12091.9 12104.3 12152.5 8789.8 10310.2 10471.8 10698.9 10915.5 10117.2 10516.6 10519.7 10569.5 10761.4 10816.8 11044.8 11149.6 11240.1 11271.8 6639.1 6805.5 7367.9 7626.4 7767.3 10229.8 10672.1 10763.8 11034.9 11167.3 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#3] mootools.html Cycles:180 Average:5518.27 Median:6255.19 stddev:2833.13 (45.3%) stddev-sans-first:2823.54 20:16:58 INFO - PROCESS | 19975 | Values: 1324.6 1463.2 1467.1 1653.9 1857.7 7033.7 7482.3 7652.5 7657.7 7674.9 7495.4 7685.2 7700.6 7731.1 7734.6 2027.0 2261.1 2269.4 2284.0 2315.0 2369.8 2373.3 2379.3 2381.2 2382.1 2269.1 2323.1 2327.3 2329.8 2330.9 2290.4 2305.9 2306.9 2309.1 2315.7 2299.2 2307.5 2319.4 2328.7 2348.4 7960.0 8010.9 8035.5 8039.6 8046.1 4728.9 4832.7 4864.8 4867.9 4876.6 3137.4 3178.9 3201.4 3299.0 3300.7 984.1 1009.8 1014.5 1016.8 1056.4 10793.8 10850.3 10854.7 10865.4 10865.7 4348.4 4361.3 4461.5 4466.3 4492.6 9498.4 9510.2 9522.3 9528.0 9536.9 4896.3 4922.0 4925.5 4932.3 4941.0 4432.1 4436.0 4439.8 4445.6 4449.1 3516.2 3713.0 3747.2 3772.8 3786.2 1190.4 1224.9 1241.7 1243.4 1246.4 1303.1 1312.0 1319.9 1341.7 1343.6 7214.0 7273.0 7322.4 7409.5 7571.4 1099.5 1113.0 1115.7 1117.3 1122.8 5825.6 5876.9 5886.1 5887.0 5915.3 9291.3 9325.4 9570.5 9698.1 9776.7 9644.0 9648.5 9656.2 9658.7 9659.8 7309.5 7335.9 7464.0 7470.9 7526.1 7203.5 7209.9 7282.9 7283.0 7285.2 8184.6 8197.0 8263.6 8383.4 8409.4 8364.7 8520.2 8522.7 8527.4 8542.6 6270.8 6696.2 6894.8 6895.4 6924.0 7412.4 7546.7 7548.5 7551.7 7570.6 6817.1 6846.2 6848.5 6896.3 6950.8 6854.2 6942.7 6992.0 7076.3 7092.3 6973.4 7088.3 7136.5 7153.1 7325.9 6341.9 6369.3 6372.3 6376.8 6378.0 6230.5 6249.4 6260.9 6266.2 6266.2 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#4] prototype.html Cycles:180 Average:5317.77 Median:6008.59 stddev:1609.70 (26.8%) stddev-sans-first:1570.14 20:16:58 INFO - PROCESS | 19975 | Values: 333.4 334.3 338.4 339.8 347.8 5779.5 5854.9 5906.0 5964.8 6025.2 5769.8 5839.0 5875.8 5904.9 5915.6 4641.1 4646.5 4651.5 4657.3 4660.7 4396.2 4464.9 4489.6 4512.7 4639.7 4543.3 4580.0 4589.1 4595.2 4612.0 4591.1 4596.4 4601.3 4606.5 4612.2 4076.7 4076.7 4079.8 4091.3 4094.7 5644.6 5716.0 5726.0 5740.1 5746.2 5361.5 5364.5 5377.5 5381.4 5384.1 5992.0 6298.4 6304.7 6313.0 6313.2 4367.4 4467.8 4473.5 4487.3 4487.5 6541.1 6569.6 6574.0 6581.6 6585.3 4574.5 4587.3 4590.0 4593.3 4602.2 4293.7 4341.6 4364.8 4652.2 4653.8 5088.8 5092.0 5098.2 5107.6 5109.8 6314.3 6383.9 6384.3 6389.3 6391.8 1568.8 1584.5 1584.7 1585.2 1588.0 1047.0 1052.2 1054.6 1068.6 1077.6 6062.3 6063.8 6068.5 6069.8 6074.1 6560.3 6560.4 6565.8 6569.8 6584.1 5944.4 6044.2 6047.7 6058.2 6065.0 3462.8 3538.7 3547.9 3551.3 3557.5 6790.0 6805.0 6806.1 6808.8 6836.6 6690.8 6697.7 6699.0 6700.5 6700.8 6639.1 6767.2 6870.9 6887.0 6907.9 6353.4 6477.0 6599.6 6629.0 6631.2 6532.8 6541.7 6552.9 6555.5 6617.9 6834.4 6859.7 6890.1 6893.0 6907.4 4306.4 4390.3 4412.1 4508.0 4519.4 6603.2 6606.8 6623.2 6654.2 6669.0 6363.3 6393.7 6394.8 6397.7 6420.9 6262.7 6372.8 6379.2 6429.1 6466.3 6310.2 6332.5 6348.0 6348.2 6355.7 6401.8 6470.5 6473.3 6475.4 6479.3 6139.5 6258.3 6290.2 6299.5 6305.1 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - PROCESS | 19975 | [#5] yui.html Cycles:180 Average:13363.17 Median:50684.12 stddev:15368.69 (30.3%) stddev-sans-first:15382.30 20:16:58 INFO - PROCESS | 19975 | Values: 683.9 734.0 747.7 786.7 824.7 13363.5 13431.1 13441.9 13550.0 13576.9 12903.1 12936.1 12944.5 12948.5 12953.9 763.6 817.5 817.9 818.1 818.2 818.8 819.1 821.8 822.4 822.5 860.1 869.8 869.8 870.1 870.3 857.3 862.9 863.6 865.7 866.9 637.7 637.8 638.0 638.2 638.3 12518.4 12539.9 12563.2 12563.6 12577.4 11898.0 12405.9 12474.5 12503.6 12682.6 9446.2 9513.7 9544.5 9760.9 9771.0 3515.5 3640.8 3645.0 3657.6 3659.3 50028.5 50452.0 50614.7 50827.5 50917.7 8992.5 9214.4 9273.3 9387.0 9475.3 16049.5 16096.8 16105.1 16107.0 16144.4 7285.9 7396.9 7436.3 7622.2 7851.0 4127.1 4226.5 4229.7 4231.2 4265.4 3052.1 3073.4 3077.5 3080.0 3084.2 563.1 578.2 583.8 595.6 605.5 608.9 644.7 645.1 655.2 679.0 8411.8 8611.0 8625.2 8707.6 8779.4 538.8 615.3 682.3 706.8 720.8 3699.9 4288.4 4341.2 4376.5 4404.1 52842.5 53574.2 53813.7 53831.5 54048.0 40595.4 45046.0 45370.3 45660.0 52149.5 38224.4 43438.0 50320.7 50496.2 50753.5 7681.7 8332.6 8551.3 8592.2 8791.6 32249.0 33396.5 33805.5 34817.0 37570.6 41479.6 41721.4 42324.8 42537.8 43004.0 10460.9 10731.7 10952.9 11028.8 11135.7 11830.6 11946.1 11965.2 12053.1 12072.5 11302.4 11352.7 11398.4 11409.6 11431.7 10948.4 11099.1 11125.3 11134.7 11150.2 10465.6 10593.6 10610.9 10623.8 10677.7 9175.4 9245.2 9634.9 9669.0 9863.7 9633.1 9875.7 9882.9 9886.5 9894.9 20:16:58 INFO - PROCESS | 19975 | -------- Summary: end -------- 20:16:58 INFO - PROCESS | 19975 | 20:16:58 INFO - TEST-INFO | 19975: exit 0 20:16:58 INFO - TEST-OK | dromaeo_css | took 1112160ms 20:16:58 INFO - TEST-START | kraken 20:16:58 INFO - operating with platform_type : linux_ 20:16:58 INFO - Initialising browser for kraken test... 20:16:58 INFO - TEST-INFO | started process 20159 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDImJAP/profile http://localhost:39380/getInfo.html) 20:17:02 INFO - PROCESS | 20159 | __metrics Screen width/height:1600/1200 20:17:02 INFO - PROCESS | 20159 | colorDepth:24 20:17:02 INFO - PROCESS | 20159 | Browser inner width/height: 1024/697 20:17:02 INFO - PROCESS | 20159 | __metrics 20:17:02 INFO - PROCESS | 20159 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:03 INFO - TEST-INFO | 20159: exit 0 20:17:03 INFO - Browser initialized. 20:17:03 INFO - Running cycle 1/1 for kraken test... 20:17:03 INFO - TEST-INFO | started process 20245 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDImJAP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:15 INFO - PROCESS | 20245 | RSS: Main: 154341376 20:17:15 INFO - PROCESS | 20245 | 20:17:17 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-beat-detection) 20:17:18 INFO - PROCESS | 20245 | RSS: Main: 195231744 20:17:18 INFO - PROCESS | 20245 | 20:17:20 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-dft) 20:17:21 INFO - PROCESS | 20245 | RSS: Main: 186023936 20:17:21 INFO - PROCESS | 20245 | 20:17:24 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-fft) 20:17:25 INFO - PROCESS | 20245 | RSS: Main: 170467328 20:17:25 INFO - PROCESS | 20245 | 20:17:27 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39380/tests/kraken/driver.html?testName=audio-oscillator) 20:17:27 INFO - PROCESS | 20245 | RSS: Main: 171909120 20:17:27 INFO - PROCESS | 20245 | 20:17:29 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:17:30 INFO - PROCESS | 20245 | RSS: Main: 175697920 20:17:30 INFO - PROCESS | 20245 | 20:17:33 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-darkroom) 20:17:34 INFO - PROCESS | 20245 | RSS: Main: 174346240 20:17:34 INFO - PROCESS | 20245 | 20:17:37 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39380/tests/kraken/driver.html?testName=imaging-desaturate) 20:17:38 INFO - PROCESS | 20245 | RSS: Main: 174870528 20:17:38 INFO - PROCESS | 20245 | 20:17:40 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39380/tests/kraken/driver.html?testName=json-parse-financial) 20:17:41 INFO - PROCESS | 20245 | RSS: Main: 175124480 20:17:41 INFO - PROCESS | 20245 | 20:17:42 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39380/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:17:43 INFO - PROCESS | 20245 | RSS: Main: 189956096 20:17:43 INFO - PROCESS | 20245 | 20:17:45 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:17:45 INFO - PROCESS | 20245 | RSS: Main: 185253888 20:17:45 INFO - PROCESS | 20245 | 20:17:47 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:17:48 INFO - PROCESS | 20245 | RSS: Main: 196055040 20:17:48 INFO - PROCESS | 20245 | 20:17:50 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:17:51 INFO - PROCESS | 20245 | RSS: Main: 200556544 20:17:51 INFO - PROCESS | 20245 | 20:17:54 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:17:54 INFO - PROCESS | 20245 | RSS: Main: 199819264 20:17:54 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | Cycle 1(1): loaded http://localhost:39380/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39380/tests/kraken/driver.html?testName=ai-astar) 20:17:56 INFO - PROCESS | 20245 | RSS: Main: 260685824 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | __start_tp_report 20:17:56 INFO - PROCESS | 20245 | _x_x_mozilla_page_load 20:17:56 INFO - PROCESS | 20245 | _x_x_mozilla_page_load_details 20:17:56 INFO - PROCESS | 20245 | |i|pagename|runs| 20:17:56 INFO - PROCESS | 20245 | |0;ai-astar;109;110;106;110;110;111;101;111;111;111 20:17:56 INFO - PROCESS | 20245 | |1;audio-beat-detection;152;125;151;165;128;153;148;129;170;126 20:17:56 INFO - PROCESS | 20245 | |2;audio-dft;162;164;163;169;161;161;162;163;163;162 20:17:56 INFO - PROCESS | 20245 | |3;audio-fft;73;75;94;101;74;73;76;120;96;73 20:17:56 INFO - PROCESS | 20245 | |4;audio-oscillator;96;97;150;95;96;95;145;96;96;136 20:17:56 INFO - PROCESS | 20245 | |5;imaging-gaussian-blur;119;116;114;115;115;115;114;115;114;115 20:17:56 INFO - PROCESS | 20245 | |6;imaging-darkroom;146;145;146;145;146;145;145;146;146;145 20:17:56 INFO - PROCESS | 20245 | |7;imaging-desaturate;96;96;96;96;96;96;97;96;96;96 20:17:56 INFO - PROCESS | 20245 | |8;json-parse-financial;57;56;56;55;55;55;56;64;52;53 20:17:56 INFO - PROCESS | 20245 | |9;json-stringify-tinderbox;66;67;67;67;68;68;67;66;67;67 20:17:56 INFO - PROCESS | 20245 | |10;stanford-crypto-aes;90;82;83;83;83;83;83;83;83;86 20:17:56 INFO - PROCESS | 20245 | |11;stanford-crypto-ccm;134;116;130;128;117;113;116;125;117;117 20:17:56 INFO - PROCESS | 20245 | |12;stanford-crypto-pbkdf2;157;141;149;149;155;151;150;148;149;149 20:17:56 INFO - PROCESS | 20245 | |13;stanford-crypto-sha256-iterative;75;70;70;69;69;67;70;69;68;67 20:17:56 INFO - PROCESS | 20245 | __end_tp_report 20:17:56 INFO - PROCESS | 20245 | __start_cc_report 20:17:56 INFO - PROCESS | 20245 | _x_x_mozilla_cycle_collect,980 20:17:56 INFO - PROCESS | 20245 | __end_cc_report 20:17:56 INFO - PROCESS | 20245 | __startTimestamp1455250676635__endTimestamp 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | ------- Summary: start ------- 20:17:56 INFO - PROCESS | 20245 | Number of tests: 14 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.20 (2.9%) stddev-sans-first:3.39 20:17:56 INFO - PROCESS | 20245 | Values: 109.0 110.0 106.0 110.0 110.0 111.0 101.0 111.0 111.0 111.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:16.63 (11.0%) stddev-sans-first:17.42 20:17:56 INFO - PROCESS | 20245 | Values: 152.0 125.0 151.0 165.0 128.0 153.0 148.0 129.0 170.0 126.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 20:17:56 INFO - PROCESS | 20245 | Values: 162.0 164.0 163.0 169.0 161.0 161.0 162.0 163.0 163.0 162.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#3] audio-fft Cycles:10 Average:85.50 Median:74.50 stddev:16.38 (22.0%) stddev-sans-first:16.74 20:17:56 INFO - PROCESS | 20245 | Values: 73.0 75.0 94.0 101.0 74.0 73.0 76.0 120.0 96.0 73.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:23.34 (24.3%) stddev-sans-first:24.19 20:17:56 INFO - PROCESS | 20245 | Values: 96.0 97.0 150.0 95.0 96.0 95.0 145.0 96.0 96.0 136.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.48 (1.3%) stddev-sans-first:0.67 20:17:56 INFO - PROCESS | 20245 | Values: 119.0 116.0 114.0 115.0 115.0 115.0 114.0 115.0 114.0 115.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:17:56 INFO - PROCESS | 20245 | Values: 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:17:56 INFO - PROCESS | 20245 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:3.21 (5.7%) stddev-sans-first:3.38 20:17:56 INFO - PROCESS | 20245 | Values: 57.0 56.0 56.0 55.0 55.0 55.0 56.0 64.0 52.0 53.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 20:17:56 INFO - PROCESS | 20245 | Values: 66.0 67.0 67.0 67.0 68.0 68.0 67.0 66.0 67.0 67.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.00 stddev:2.38 (2.9%) stddev-sans-first:1.09 20:17:56 INFO - PROCESS | 20245 | Values: 90.0 82.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 86.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:7.27 (6.0%) stddev-sans-first:6.09 20:17:56 INFO - PROCESS | 20245 | Values: 134.0 116.0 130.0 128.0 117.0 113.0 116.0 125.0 117.0 117.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:149.50 stddev:4.26 (2.9%) stddev-sans-first:3.64 20:17:56 INFO - PROCESS | 20245 | Values: 157.0 141.0 149.0 149.0 155.0 151.0 150.0 148.0 149.0 149.0 20:17:56 INFO - PROCESS | 20245 | 20:17:56 INFO - PROCESS | 20245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:2.27 (3.3%) stddev-sans-first:1.20 20:17:56 INFO - PROCESS | 20245 | Values: 75.0 70.0 70.0 69.0 69.0 67.0 70.0 69.0 68.0 67.0 20:17:56 INFO - PROCESS | 20245 | -------- Summary: end -------- 20:17:56 INFO - PROCESS | 20245 | 20:17:57 INFO - TEST-INFO | 20245: exit 0 20:17:57 INFO - TEST-OK | kraken | took 58807ms 20:17:57 INFO - SUITE-END | took 1170s 20:17:57 INFO - Completed test suite (00:19:31) 20:17:57 INFO - Working with test: dromaeo_css 20:17:57 INFO - Generating results file: dromaeo_css 20:17:57 INFO - Working with test: kraken 20:17:57 INFO - Generating results file: kraken 20:17:57 INFO - javascript benchmark 20:17:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:17:57 INFO - process_Request line: dromaeo_css 6830.26 graph.html#tests=[[72,64,35]] 20:17:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:17:58 INFO - process_Request line: kraken 1516.50 graph.html#tests=[[232,64,35]] 20:17:58 INFO - RETURN: dromaeo_css: 6830.26 20:17:58 INFO - RETURN: kraken: 1516.50 20:17:58 INFO - javascript benchmark 20:17:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3116.922076948076, 3117.7194052535283, 3126.765492588055, 3136.654967953526, 3189.7288730457904, 5013.172826483635, 5047.141985862403, 5103.081445339842, 5105.0, 5131.230315452684, 5066.544011039005, 5084.262781896623, 5098.821541246057, 5114.923276150861, 5146.125158723016, 4611.584957353837, 4627.999999999992, 4639.976800116012, 4682.274247491628, 4854.053459575384, 4593.586577208051, 4762.761861906908, 4778.116048531016, 4791.2813078038225, 4862.465128835825, 4642.257238841786, 4691.62467002639, 4712.3167140764735, 4716.363290955712, 4764.6426518011285, 4689.1793936061395, 4691.202495575761, 4700.576948074689, 4722.409698787652, 4722.527747225285, 4604.010137820384, 4651.488336283006, 4682.0, 4701.435827700698, 4722.197226471508, 4947.554720075211, 4983.700977941335, 4997.225430058311, 5003.74981250936, 5018.723970181639, 5521.199426083235, 5532.0, 5536.695481748502, 5583.6928968906695, 5583.972080139573, 5292.126799078147, 5514.200440936082, 5537.556995440355, 5584.804531841407, 5616.66300022, 5193.402758682724, 5222.138347172674, 5222.999999999962, 5223.895522089575, 5228.4510126436935, 5532.944670553324, 5605.607607467519, 5605.747741351649, 5656.8868622627315, 5657.773689052474, 5348.277982472394, 5352.464753524617, 5377.623566350318, 5379.0, 5398.541124004425, 5495.835124946258, 5511.0, 5511.807086751945, 5517.69652669099, 5522.585806064561, 5379.0, 5474.616776825664, 5512.228288039678, 5518.475744804237, 5578.330600327987, 5462.3445186577865, 5502.147167189092, 5508.55931525477, 5511.366192887789, 5516.889662206733, 4197.601227883346, 4256.978715106405, 4257.978710106429, 4258.787060646955, 4295.076558539929, 3755.399136138205, 3794.354959656865, 3831.750936189139, 3876.3797792353653, 3878.825452854628, 5152.201408781645, 5162.664426812245, 5179.067767801832, 5193.143131383279, 5242.056429842589, 5405.729713514309, 5415.783368665288, 5433.049216387117, 5437.972810136003, 5491.670499770026, 5007.0, 5073.239014147834, 5081.872953176126, 5084.0, 5104.846854594368, 4727.267273572602, 4738.289256611467, 4751.0, 4756.7145971241835, 4788.688735232199, 5709.8287051388525, 5717.428257174332, 5718.628289161191, 5728.598998070095, 5733.88532229353, 5316.388615309289, 5399.622026458111, 5459.863503412446, 5467.863303417446, 5590.385057643737, 5710.65736055838, 5746.0, 5748.195252664546, 5750.539956803362, 5762.394948530512, 5450.1007333789485, 5467.07059799843, 5468.207109968953, 5469.781208751605, 5470.343558772973, 5397.9190312144565, 5453.972730136324, 5506.0, 5530.364008138955, 5577.051901176728, 5338.4394638563945, 5356.544693701079, 5357.8392648220615, 5361.597880158925, 5362.383325917569, 5189.584833213258, 5331.226972088948, 5346.919796203138, 5347.171188465794, 5391.892162156813, 5099.77051032697, 5148.742562871917, 5164.431912489698, 5188.22176673502, 5211.895762084661, 5295.179247216687, 5301.602379821606, 5301.655392399482, 5306.575473961997, 5326.0, 5206.479352064915, 5224.164133738584, 5226.216067589892, 5266.762995665281, 5310.256564080954], "unit": "score", "name": "dojo.html", "value": 5068.471757793117}, {"lowerIsBetter": false, "replicates": [528.912729399649, 532.5872448852136, 534.1853673148448, 549.5795716277049, 556.251841273487, 28552.0, 35650.46524302135, 36465.99999999996, 36570.0, 36599.45100823483, 39341.409878851766, 39756.80121599395, 39757.40363894544, 39845.203095938065, 39901.60098399015, 8559.315254779634, 8744.34417418693, 8748.431351962134, 8751.868721969175, 8757.124287571256, 8481.363897707666, 8579.0, 8585.055643879168, 8604.0, 8606.354523410739, 8603.655853765842, 8838.381313308071, 8907.376483646147, 8908.643654253821, 8927.821443571125, 8780.25367843734, 8853.291736661116, 8854.29165666745, 8854.911450885473, 8857.778555536132, 8769.210771030637, 8896.37725359225, 8911.19799218067, 8912.376133670645, 8914.28685705142, 39860.6188164597, 40199.59800402017, 40291.798541007105, 40307.193856122714, 40318.79840600808, 3329.6503867094093, 3689.981550092259, 4077.3680079587416, 4083.3670781028986, 4198.6011328924005, 30143.0, 30635.846820765975, 31251.062468125994, 31528.32009279214, 31549.684503154906, 3856.5179352580926, 3868.9226215475815, 3879.4180872869297, 3881.8059097045034, 3904.082540602956, 261700.0, 262654.0, 262796.6860165706, 263468.0, 264353.0, 55000.44999549953, 55007.07475238347, 55207.72396138074, 55341.44658553363, 55404.44595554074, 52494.73752631212, 53620.463795362324, 59406.70296648489, 59455.10817337743, 60672.39327606756, 13411.195328280335, 13472.191668499921, 13489.190648561118, 13511.662208444868, 13621.978351623668, 9134.497602631785, 11009.83485247722, 11056.391898445663, 11082.168837337233, 11087.445627718582, 18605.81394186068, 18929.43211703651, 18971.146298416603, 18979.24083036663, 19170.0, 7407.148177959603, 7741.767746967487, 7753.8449231015065, 7754.224577542313, 7912.9208707912185, 962.4658314635304, 988.906053924876, 1008.2337423558149, 1086.8098082835472, 1154.9720748533812, 29666.258343541584, 29878.588403750786, 29925.651478302287, 30042.69957300399, 30104.548431773543, 1021.9846702299471, 1036.9377837329785, 1062.2033474893828, 1141.5490881102085, 1200.33981310279, 15251.0, 15670.921645391929, 15741.921290393475, 15800.68398632021, 15920.840791592167, 301355.0, 301443.0, 302334.0, 304624.0, 305124.0, 52073.73963130236, 52395.0, 52592.474075259524, 52934.73532632312, 52946.470535294924, 672.3310306245318, 980.7548112971757, 1140.4810811080938, 1247.8502579690496, 1275.6428200104172, 25126.246212613652, 26136.477270454103, 26221.868890656187, 26242.343941401617, 26289.21132366032, 40831.38752918768, 40885.795571021954, 41532.37701434542, 41635.583644164384, 41736.37395439132, 267348.0, 386784.0, 397601.0, 398211.0, 398718.0, 29604.0, 30029.5495567571, 30107.247318817204, 30126.0, 30130.24674383158, 40840.0, 41648.0, 41702.37446438367, 42347.57652423436, 42418.363724544775, 35106.29787404289, 35449.0, 35606.0, 35902.0, 35973.1006724834, 35295.82352088223, 36063.0, 36083.278334433686, 36156.0, 36162.819185904955, 35448.0, 36649.63350366462, 36766.0, 36833.26333473262, 36934.8153259232, 30372.240693981945, 33635.66364336325, 33810.83094584511, 33883.0, 34064.31871362509, 24115.0, 25129.87435062813, 25210.74789252084, 25284.058246311735, 25481.490370192863], "unit": "score", "name": "ext.html", "value": 18180.983590331118}, {"lowerIsBetter": false, "replicates": [335.49697355845797, 346.18818869750424, 366.152357292867, 366.8899330200941, 367.4304827517348, 13942.930285348559, 14238.430462781476, 16523.256453459595, 17300.394486192985, 18843.0, 15460.768088478682, 15922.681546369095, 16304.918475407607, 17085.316587336492, 17116.657666846655, 4897.363342765436, 5059.620528460362, 5062.240663900426, 5067.771950262247, 5068.695878247317, 3808.1431677872397, 4979.875503112415, 5237.319148510688, 5426.21319908613, 5440.129579267318, 5312.0, 5384.0, 5414.133738601825, 5431.2396264522995, 5437.945620543784, 5431.348238211401, 5441.2654291670515, 5462.8361149165585, 5485.725713714318, 5486.91769623456, 5195.428502864682, 5216.7913283468615, 5220.9738951305, 5269.235960785664, 5449.727513624303, 12944.352782360938, 13106.60680179596, 15921.363145474166, 20798.27206047781, 20844.5831083379, 2158.98920505398, 2233.6314508106143, 2235.0724449353497, 2238.597052530544, 2259.5254996450767, 9459.38513996588, 9483.715488535356, 9555.283353748497, 9644.807103857884, 9782.902170978341, 1791.7849858016991, 1831.0661562603036, 1831.5146486181172, 1870.560418301698, 1882.4352694191825, 57121.0, 59515.404845951416, 61407.69296153535, 62164.0, 62223.06665400023, 9880.40717556949, 10021.549030293654, 10057.075575245888, 10069.748256293506, 10343.793124137626, 12588.0, 12701.110922235355, 12739.36303184837, 12740.80888786669, 12761.234325940473, 6558.508111891627, 6610.107635469246, 6642.202935647753, 6667.933320666828, 6702.59784412927, 6474.9676251619385, 6480.837979050561, 6689.03009063683, 6690.4647628190605, 6986.720531178696, 4101.938470922939, 4125.64931980785, 4167.041580436517, 4169.10364271683, 4335.913281734411, 1698.4395149600603, 1721.8364255395968, 1734.7137722275936, 1752.5881417866792, 1827.7258411238154, 824.1511243419287, 858.1898459136575, 887.627196577439, 900.0729248873671, 1013.4881884648353, 16565.751513727304, 16912.492625221017, 17330.3067877286, 17448.389306374214, 17784.0, 815.3273549321715, 844.8648216285364, 875.6103533927342, 990.5592011554933, 1055.2771351624162, 9001.54992250385, 9241.861372079424, 9300.302477314228, 9330.92694340146, 9388.295877809192, 514976.0, 516613.0, 516753.0, 523252.0, 534591.0, 70985.64507177535, 74927.0, 75269.24730752732, 76754.0, 77426.0, 1049.459528342904, 1051.169576034924, 1111.2388014210292, 1122.8484154639182, 1125.4654039331251, 14711.0, 14752.409903603735, 14925.626859328604, 15234.619134521725, 15719.764203536728, 30712.464376781518, 30898.227544310674, 31216.0, 31624.683753162175, 33956.15109622279, 40503.0, 43477.34783978306, 43851.34222986594, 43871.34192987044, 43908.560914391725, 7329.267073292628, 7588.354989825927, 7618.428617853794, 7707.421943354383, 7750.0, 9908.752281193028, 12011.519539218334, 12091.879081209076, 12104.334261615695, 12152.513899444277, 8789.824203515765, 10310.226732995205, 10471.790564188826, 10698.89301106979, 10915.454227288763, 10117.19062475015, 10516.579336826748, 10519.73700657459, 10569.471526423802, 10761.354318740587, 10816.783664326513, 11044.834327484934, 11149.554017839195, 11240.100791936462, 11271.830922536332, 6639.070530125689, 6805.523613347018, 7367.852642947219, 7626.3898888089925, 7767.339776119094, 10229.84655230187, 10672.146228301563, 10763.838542421714, 11034.944825276143, 11167.274127182032], "unit": "score", "name": "jquery.html", "value": 8128.416909597171}, {"lowerIsBetter": false, "replicates": [1324.609240274119, 1463.1586837568398, 1467.1417220925757, 1653.9421120260793, 1857.684193687074, 7033.683484243208, 7482.326590606851, 7652.540847549137, 7657.655405506752, 7674.884876726854, 7495.400367970563, 7685.193054729257, 7700.614969251543, 7731.149573546905, 7734.5745983970855, 2027.0472877747509, 2261.072960086365, 2269.3986093685185, 2283.9885800570974, 2314.9652755208685, 2369.7985671217966, 2373.3473294843884, 2379.2624286471164, 2381.2499062795164, 2382.130522359335, 2269.126386341254, 2323.140438037928, 2327.3367090379247, 2329.77867102625, 2330.9184178553755, 2290.3586995641163, 2305.9077636894503, 2306.9307920762403, 2309.0763694522157, 2315.710536182977, 2299.1837897546297, 2307.492351682644, 2319.373769082355, 2328.6739856420113, 2348.377679914824, 7959.9602001989615, 8010.919890801076, 8035.477693949933, 8039.598020098972, 8046.074701409354, 4728.881777955578, 4832.73419961902, 4864.78108485119, 4867.878303042452, 4876.609871210295, 3137.403893260296, 3178.8728450861936, 3201.4237437261286, 3299.0, 3300.7029367356813, 984.0946329376991, 1009.7627057641448, 1014.4724743133603, 1016.755978565139, 1056.4084112896726, 10793.83809242862, 10850.348979061202, 10854.67435976922, 10865.402402867918, 10865.674029779118, 4348.43470348859, 4361.323994780751, 4461.505395692479, 4466.285394336891, 4492.595666390041, 9498.382605130782, 9510.191633711212, 9522.333436659368, 9527.952360238154, 9536.856947145798, 4896.290037944478, 4921.9507804921495, 4925.507449255046, 4932.3094766731965, 4940.950590494121, 4432.135733531994, 4435.955640443619, 4439.755813430293, 4445.555444455528, 4449.087936972913, 3516.24400753834, 3713.0, 3747.1756213632957, 3772.849086036583, 3786.2048969716116, 1190.4285942747529, 1224.8530176378893, 1241.7019915220462, 1243.359669770069, 1246.4141853328922, 1303.074816880007, 1312.0422091872986, 1319.9274039927896, 1341.6914109754812, 1343.5700575815645, 7213.963930180421, 7273.0, 7322.377597904131, 7409.518381305198, 7571.410003899133, 1099.4502748625687, 1112.9666110016713, 1115.682030621269, 1117.2961034548182, 1122.7922834275685, 5825.592208545446, 5876.941230587725, 5886.1465087562065, 5887.0, 5915.349311575723, 9291.256699464027, 9325.393849399767, 9570.521473926276, 9698.127168554864, 9776.657816976372, 9644.0, 9648.469334186688, 9656.22750179984, 9658.661946831828, 9659.758506037264, 7309.488335816442, 7335.8532829344185, 7464.0, 7470.887936680954, 7526.09686837572, 7203.495755297079, 7209.855802883808, 7282.927170728225, 7283.0, 7285.198628151005, 8184.590770461334, 8197.0, 8263.586820658822, 8383.41316107891, 8409.411341206056, 8364.707235246737, 8520.233179013918, 8522.74431767048, 8527.445716028438, 8542.572871356531, 6270.811875643738, 6696.19645642526, 6894.827629309308, 6895.4138898194215, 6924.0, 7412.407007439284, 7546.698132074655, 7548.509346892434, 7551.660175292015, 7570.621468926642, 6817.079694241214, 6846.178458585002, 6848.452123829982, 6896.344847239504, 6950.826229344105, 6854.2117656470145, 6942.652867356713, 6991.965040174767, 7076.256993015865, 7092.290770922867, 6973.372396484341, 7088.291170882871, 7136.4647651427385, 7153.070100886852, 7325.890111648223, 6341.936580634319, 6369.33122022181, 6372.330905254881, 6376.808695739135, 6378.0, 6230.532710046674, 6249.437550620466, 6260.937390626035, 6266.185395898504, 6266.248050234001], "unit": "score", "name": "mootools.html", "value": 4559.005816034885}, {"lowerIsBetter": false, "replicates": [333.3649397897007, 334.2812952152872, 338.3824520250542, 339.8351799377302, 347.81044330839705, 5779.508741756956, 5854.853628659285, 5906.0, 5964.761409543618, 6025.18659980903, 5769.798057068004, 5839.0, 5875.76496940123, 5904.911426328608, 5915.5859089863725, 4641.071785642868, 4646.465656449518, 4651.534846515356, 4657.254839225725, 4660.697054691451, 4396.186705459484, 4464.866054018385, 4489.6408287336935, 4512.661550383718, 4639.6752227344095, 4543.295789152687, 4580.015296711206, 4589.059242855224, 4595.195840727876, 4611.976940115312, 4591.104734576759, 4596.3794887690065, 4601.309803529464, 4606.516315786827, 4612.1698094343, 4076.6534844537955, 4076.6942479313875, 4079.796010199478, 4091.2635725569385, 4094.733842300241, 5644.57665675076, 5715.971420142914, 5725.971370143123, 5740.1102829061565, 5746.166805813134, 5361.463853614608, 5364.490373414519, 5377.489138531833, 5381.381141168777, 5384.0847056000575, 5992.0, 6298.401651843067, 6304.747810087591, 6312.968435157794, 6313.2424109107205, 4367.388565600819, 4467.7542735149555, 4473.507914129443, 4487.326900964881, 4487.461504619434, 6541.0515475255825, 6569.572977756478, 6573.967130164367, 6581.638009909453, 6585.341465853424, 4574.4739354973935, 4587.334836448763, 4590.0, 4593.28804035375, 4602.240630296031, 4293.677974151951, 4341.587549182823, 4364.75993820343, 4652.185867473178, 4653.790579423934, 5088.847334579968, 5091.974540127276, 5098.1842905135, 5107.61692873036, 5109.795608175631, 6314.305426403092, 6383.904241436289, 6384.297727250092, 6389.329120442287, 6391.840203994844, 1568.8195857476537, 1584.4850423612372, 1584.6672198838373, 1585.1757086315051, 1588.0233656301523, 1046.99476502617, 1052.1582733812918, 1054.6045233037612, 1068.6206396729206, 1077.5959015369237, 6062.333143354227, 6063.7574497020505, 6068.484178844759, 6069.848253793691, 6074.119252708332, 6560.278369379364, 6560.376764207393, 6565.8358541035905, 6569.83575410609, 6584.144061272004, 5944.405559444108, 6044.24446944132, 6047.697615119315, 6058.1518587397795, 6065.0, 3462.79223246606, 3538.6815186633326, 3547.8935631931085, 3551.3074950384425, 3557.5197348358156, 6790.0, 6805.047293378931, 6806.115205023315, 6808.761693340709, 6836.589804611739, 6690.83272918181, 6697.732090716317, 6699.0, 6700.463962882957, 6700.832479187962, 6639.070530125689, 6767.154105736783, 6870.931290687129, 6887.035814985906, 6907.861842763016, 6353.428191462605, 6477.0, 6599.637019963948, 6628.966855165886, 6631.171103612049, 6532.771353002622, 6541.70562324706, 6552.934470655233, 6555.541112122106, 6617.867642647217, 6834.350736680008, 6859.725610975505, 6890.138732658418, 6892.965535172292, 6907.447404207752, 4306.397104405323, 4390.275604525217, 4412.117576484652, 4508.008238187594, 4519.38988236597, 6603.20761508622, 6606.801795945937, 6623.238327592196, 6654.234763002317, 6669.0, 6363.268224154282, 6393.680315984089, 6394.840128996626, 6397.680115994275, 6420.935790642034, 6262.655553944394, 6372.789170057674, 6379.202599675041, 6429.099926010269, 6466.288708242184, 6310.1796766420075, 6332.461740752087, 6347.96826015867, 6348.206474190726, 6355.650439225887, 6401.775937842153, 6470.547061705635, 6473.255575608865, 6475.384838440341, 6479.319671434431, 6139.508839292936, 6258.311585725475, 6290.150829637941, 6299.4645455135, 6305.085762564494], "unit": "score", "name": "prototype.html", "value": 4792.964018626216}, {"lowerIsBetter": false, "replicates": [683.8632273545293, 734.0457405373015, 747.7046566606194, 786.6656670914862, 824.653645468903, 13363.53227637033, 13431.12697674653, 13441.85744211742, 13550.0, 13576.93211533941, 12903.096783225177, 12936.094473386867, 12944.546940857072, 12948.546800861972, 12953.935230323836, 763.5914785589711, 817.497239197892, 817.8936738224022, 818.1368656067846, 818.153211426174, 818.8444195602846, 819.0785366462729, 821.8274162425897, 822.3873214455239, 822.5147163173726, 860.096898256831, 869.8042940338405, 869.8260347930408, 870.1342164546254, 870.3298460185654, 857.2756021162108, 862.8921384826897, 863.5509535041774, 865.6796985115516, 866.9133086691344, 637.6588525139028, 637.8405398650337, 637.987240255197, 638.1735652330243, 638.3106245255113, 12518.436670349856, 12539.93730031344, 12563.18339307942, 12563.623091307276, 12577.371131443391, 11898.0, 12405.875941240653, 12474.50101995919, 12503.624891253277, 12682.55611053618, 9446.244300455946, 9513.714588562354, 9544.52277386128, 9760.90239097607, 9771.022897710172, 3515.5374198466498, 3640.763350382243, 3645.0, 3657.6159503252043, 3659.2864391443677, 50028.49971500275, 50452.0, 50614.7469262655, 50827.49172508265, 50917.74541127308, 8992.505412202392, 9214.44713317203, 9273.258139348836, 9387.0, 9475.336726429221, 16049.518514444586, 16096.839031609768, 16105.114218718083, 16107.0, 16144.434944776876, 7285.854282914418, 7396.852062958711, 7436.293552112541, 7622.161562228151, 7851.0, 4127.112670775738, 4226.535081141072, 4229.746215227035, 4231.217224813419, 4265.402843601898, 3052.114886682837, 3073.4006868660395, 3077.476828939086, 3079.9538006929915, 3084.213525551015, 563.1159080243978, 578.2425023219596, 583.804425517448, 595.5652373767088, 605.4944121658465, 608.8721368512662, 644.6551095164158, 645.0904225042667, 655.2366493035655, 678.9849175482586, 8411.789705257417, 8610.956945215234, 8625.223729864343, 8707.608157632922, 8779.378089968914, 538.7602516880029, 615.2647586134616, 682.3279070115932, 706.8444942112727, 720.839448487934, 3699.9075023124637, 4288.442502474658, 4341.240282950471, 4376.474823021258, 4404.075144219686, 52842.47157528452, 53574.196387054224, 53813.730931345875, 53831.461685382645, 54048.0, 40595.391069133984, 45046.0, 45370.31944520835, 45660.0, 52149.478505214465, 38224.426633599964, 43438.0, 50320.74839625778, 50496.242556361685, 50753.492465075615, 7681.654325555475, 8332.625031873458, 8551.315894728283, 8592.183742544448, 8791.648334066822, 32249.0, 33396.499052514715, 33805.49291760576, 34817.0, 37570.624293757806, 41479.585204147574, 41721.37417938672, 42324.78837605792, 42537.78731106325, 43004.0, 10460.947695261475, 10731.731706707395, 10952.890471095187, 11028.834567481656, 11135.72160695989, 11830.585929492427, 11946.104042196695, 11965.16243862956, 12053.096017798525, 12072.456739446921, 11302.378369189773, 11352.716182095513, 11398.430078495876, 11409.60066397672, 11431.714207144887, 10948.397838118979, 11099.056580190774, 11125.332480051224, 11134.721631958942, 11150.219484635998, 10465.633702820365, 10593.629222977466, 10610.946945265225, 10623.787524249627, 10677.733056673645, 9175.44947303164, 9245.167934885892, 9634.90365096368, 9668.951655241679, 9863.654772082942, 9633.133018028131, 9875.654352097643, 9882.851757223503, 9886.456244906312, 9894.851577226491], "unit": "score", "name": "yui.html", "value": 6203.155820296586}], "name": "dromaeo_css", "value": 6830.263510651134}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 106.0, 110.0, 110.0, 111.0, 101.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 151.0, 165.0, 128.0, 153.0, 148.0, 129.0, 170.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 169.0, 161.0, 161.0, 162.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 94.0, 101.0, 74.0, 73.0, 76.0, 120.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 95.0, 96.0, 95.0, 145.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [119.0, 116.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 55.0, 55.0, 56.0, 64.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [90.0, 82.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [134.0, 116.0, 130.0, 128.0, 117.0, 113.0, 116.0, 125.0, 117.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [157.0, 141.0, 149.0, 149.0, 155.0, 151.0, 150.0, 148.0, 149.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [75.0, 70.0, 70.0, 69.0, 69.0, 67.0, 70.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1516.5000000000002}]} 20:17:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1516.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6830.26"}}} 20:17:58 INFO - Return code: 0 20:17:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:17:58 INFO - # TBPL SUCCESS # 20:17:58 INFO - Running post-action listener: _resource_record_post_action 20:17:58 INFO - Running post-run listener: _resource_record_post_run 20:17:59 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 535261184; Read time: 0; Write time: 588236 20:17:59 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248356864; Read time: 0; Write time: 365708 20:17:59 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 286904320; Read time: 0; Write time: 222528 20:17:59 INFO - Running post-run listener: _upload_blobber_files 20:17:59 INFO - Blob upload gear active. 20:17:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:17: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 20:17: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'] 20:17: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 20:17:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:00 INFO - (blobuploader) - INFO - Done attempting. 20:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:01 INFO - (blobuploader) - INFO - Done attempting. 20:18:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:01 INFO - Return code: 0 20:18:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:18:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ebbf3d8482e6c19433f5bbee8c640d5cf7372fb2ea71df7f12073232bf6e0ca0fb9038dcaef5772c3df975479193462b2c055b10ef6c8335092beaaab0ead1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91c916c6e1a24fdf7a239470e0be322e68bbae288c4b45e69135cb096ce5e16eda0fd9fb368ebd69bfe1f3812dd2834549532574e5820f51004d54a323e71af"} 20:18:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:18:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:18:01 INFO - Contents: 20:18:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10ebbf3d8482e6c19433f5bbee8c640d5cf7372fb2ea71df7f12073232bf6e0ca0fb9038dcaef5772c3df975479193462b2c055b10ef6c8335092beaaab0ead1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91c916c6e1a24fdf7a239470e0be322e68bbae288c4b45e69135cb096ce5e16eda0fd9fb368ebd69bfe1f3812dd2834549532574e5820f51004d54a323e71af"} 20:18:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:01 INFO - Copying logs to upload dir... 20:18:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:18:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.346381 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-02-11 20:18:01.067234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 20:18:01.070768) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 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/10ebbf3d8482e6c19433f5bbee8c640d5cf7372fb2ea71df7f12073232bf6e0ca0fb9038dcaef5772c3df975479193462b2c055b10ef6c8335092beaaab0ead1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91c916c6e1a24fdf7a239470e0be322e68bbae288c4b45e69135cb096ce5e16eda0fd9fb368ebd69bfe1f3812dd2834549532574e5820f51004d54a323e71af"} build_url:https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/UScat5RYTiiLzo9Oo1V0lw/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/10ebbf3d8482e6c19433f5bbee8c640d5cf7372fb2ea71df7f12073232bf6e0ca0fb9038dcaef5772c3df975479193462b2c055b10ef6c8335092beaaab0ead1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a91c916c6e1a24fdf7a239470e0be322e68bbae288c4b45e69135cb096ce5e16eda0fd9fb368ebd69bfe1f3812dd2834549532574e5820f51004d54a323e71af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 20:18:01.095408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 20:18:01.095716) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1455241887.67954-874257711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 20:18:01.181276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 20:18:01.181621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 20:18:01.181947) ========= ========= Total master_lag: 0.29 =========