builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1456179461.3 results: success (0) buildid: 20160222113154 builduid: 119fd4a323e4471cb6a717e77c012442 revision: 7d4147c08c3e554544c4607766b1983d5922c0a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.301428) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.301815) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.302091) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005540 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.368004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.368316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.381286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.381537) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.429558) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.429820) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.430137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.430416) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 14:17:41-- 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% 84.6M=0s 2016-02-22 14:17:41 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157754 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.599874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.600177) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023337 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.650995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:41.651351) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7d4147c08c3e554544c4607766b1983d5922c0a6 --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 7d4147c08c3e554544c4607766b1983d5922c0a6 --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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 14:17:42,057 truncating revision to first 12 chars 2016-02-22 14:17:42,057 Setting DEBUG logging. 2016-02-22 14:17:42,057 attempt 1/10 2016-02-22 14:17:42,057 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7d4147c08c3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 14:17:42,285 unpacking tar archive at: fx-team-7d4147c08c3e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:42.202090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:42.202477) ========= echo 7d4147c08c3e554544c4607766b1983d5922c0a6 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7d4147c08c3e554544c4607766b1983d5922c0a6'] 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7d4147c08c3e554544c4607766b1983d5922c0a6 program finished with exit code 0 elapsedTime=0.003808 script_repo_revision: '7d4147c08c3e554544c4607766b1983d5922c0a6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:42.251958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:42.252274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 14:17:42.261895) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-22 14:17:42.262234) ========= /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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:42 INFO - MultiFileLogger online at 20160222 14:17:42 in /builds/slave/test-pgo 14:17:42 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 14:17:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:17:42 INFO - {'append_to_log': False, 14:17:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:17:42 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:17:42 INFO - 'branch': 'Fx-Team', 14:17:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:42 INFO - 'config_files': ('talos/linux_config.py',), 14:17:42 INFO - 'default_actions': ('clobber', 14:17:42 INFO - 'read-buildbot-config', 14:17:42 INFO - 'download-and-extract', 14:17:42 INFO - 'populate-webroot', 14:17:42 INFO - 'create-virtualenv', 14:17:42 INFO - 'install', 14:17:42 INFO - 'run-tests'), 14:17:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:42 INFO - 'download_minidump_stackwalk': True, 14:17:42 INFO - 'download_symbols': 'ondemand', 14:17:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:42 INFO - 'installer_path': 'installer.exe', 14:17:42 INFO - 'log_level': 'info', 14:17:42 INFO - 'log_name': 'talos', 14:17:42 INFO - 'log_to_console': True, 14:17:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:42 INFO - 'opt_config_files': (), 14:17:42 INFO - 'pip_index': False, 14:17:42 INFO - 'sps_profile': False, 14:17:42 INFO - 'sps_profile_interval': 0, 14:17:42 INFO - 'suite': 'dromaeojs', 14:17:42 INFO - 'system_bits': '32', 14:17:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:42 INFO - 'title': 'talos-linux64-ix-007', 14:17:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:42 INFO - 'use_talos_json': True, 14:17:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:17:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:42 INFO - 'work_dir': 'build'} 14:17:42 INFO - ##### 14:17:42 INFO - ##### Running clobber step. 14:17:42 INFO - ##### 14:17:42 INFO - Running pre-action listener: _resource_record_pre_action 14:17:42 INFO - Running main action method: clobber 14:17:42 INFO - rmtree: /builds/slave/test-pgo/build 14:17:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:17:43 INFO - Running post-action listener: _resource_record_post_action 14:17:43 INFO - ##### 14:17:43 INFO - ##### Running read-buildbot-config step. 14:17:43 INFO - ##### 14:17:43 INFO - Running pre-action listener: _resource_record_pre_action 14:17:43 INFO - Running main action method: read_buildbot_config 14:17:43 INFO - Using buildbot properties: 14:17:43 INFO - { 14:17:43 INFO - "project": "", 14:17:43 INFO - "product": "firefox", 14:17:43 INFO - "script_repo_revision": "production", 14:17:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:17:43 INFO - "repository": "", 14:17:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:17:43 INFO - "buildid": "20160222113154", 14:17:43 INFO - "pgo_build": "True", 14:17:43 INFO - "basedir": "/builds/slave/test-pgo", 14:17:43 INFO - "buildnumber": 659, 14:17:43 INFO - "slavename": "talos-linux64-ix-007", 14:17:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:17:43 INFO - "platform": "ubuntu64_hw", 14:17:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:17:43 INFO - "branch": "fx-team", 14:17:43 INFO - "repo_path": "integration/fx-team", 14:17:43 INFO - "revision": "7d4147c08c3e554544c4607766b1983d5922c0a6", 14:17:43 INFO - "stage_platform": "linux64-pgo", 14:17:43 INFO - "builduid": "119fd4a323e4471cb6a717e77c012442", 14:17:43 INFO - "slavebuilddir": "test" 14:17:43 INFO - } 14:17:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 14:17:43 INFO - Running post-action listener: _resource_record_post_action 14:17:43 INFO - ##### 14:17:43 INFO - ##### Running download-and-extract step. 14:17:43 INFO - ##### 14:17:43 INFO - Running pre-action listener: _resource_record_pre_action 14:17:43 INFO - Running main action method: download_and_extract 14:17:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:43 INFO - https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/test_packages.json 14:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/test_packages.json 14:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:17:43 INFO - Downloaded 1448 bytes. 14:17:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:17:43 INFO - Using the following test package requirements: 14:17:43 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'jsshell-linux-x86_64.zip'], 14:17:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:43 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:43 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:43 INFO - https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:53 INFO - Downloaded 23366490 bytes. 14:17:53 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'] 14:17:53 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 14:17:54 INFO - Return code: 0 14:17:54 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 14:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:54 INFO - https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 14:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:56 INFO - Downloaded 23366490 bytes. 14:17:56 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'] 14:17:56 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 14:17:57 INFO - Return code: 0 14:17:57 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')]} 14:17:57 INFO - https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:58 INFO - Downloaded 10707015 bytes. 14:17:58 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'] 14:17:58 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 14:17:58 INFO - Return code: 0 14:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:58 INFO - https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YbEfJky_T6ufF0H7OEPNYw/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 14:18:00 INFO - Downloaded 56500595 bytes. 14:18:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:00 INFO - mkdir: /builds/slave/test-pgo/properties 14:18:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:18:00 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:18:00 INFO - Contents: 14:18:00 INFO - build_url:https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 14:18:01 INFO - Running post-action listener: _resource_record_post_action 14:18:01 INFO - Running post-action listener: set_extra_try_arguments 14:18:01 INFO - ##### 14:18:01 INFO - ##### Running populate-webroot step. 14:18:01 INFO - ##### 14:18:01 INFO - Running pre-action listener: _resource_record_pre_action 14:18:01 INFO - Running main action method: populate_webroot 14:18:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:01 INFO - '--tppagecycles', 14:18:01 INFO - '7'], 14:18:01 INFO - 'tests': ['tsvgm']}}, 14:18:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:18:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:18:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'tests': ['damp', 'tps']}, 14:18:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['damp', 'tps']}, 14:18:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:18:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:01 INFO - 'other': {'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'other_l64': {'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'other_nol64': {'tests': ['a11yr', 14:18:01 INFO - 'ts_paint', 14:18:01 INFO - 'tpaint', 14:18:01 INFO - 'sessionrestore', 14:18:01 INFO - 'sessionrestore_no_auto_restore']}, 14:18:01 INFO - 'svgr': {'tests': ['tsvgx', 14:18:01 INFO - 'tsvgr_opacity', 14:18:01 INFO - 'tart', 14:18:01 INFO - 'tscrollx', 14:18:01 INFO - 'cart']}, 14:18:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['tsvgx', 14:18:01 INFO - 'tsvgr_opacity', 14:18:01 INFO - 'tart', 14:18:01 INFO - 'tscrollx', 14:18:01 INFO - 'cart']}, 14:18:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'tests': ['tp5o']}, 14:18:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'talos_options': ['--e10s'], 14:18:01 INFO - 'tests': ['tp5o']}, 14:18:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'talos_options': ['--xperf_path', 14:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:01 INFO - 'tests': ['tp5n']}, 14:18:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:01 INFO - 'talos_options': ['--e10s', 14:18:01 INFO - '--xperf_path', 14:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:01 INFO - 'tests': ['tp5n']}}, 14:18:01 INFO - 'talos.zip': {'path': '', 14:18:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:01 INFO - Running post-action listener: _resource_record_post_action 14:18:01 INFO - ##### 14:18:01 INFO - ##### Running create-virtualenv step. 14:18:01 INFO - ##### 14:18:01 INFO - Running pre-action listener: _resource_record_pre_action 14:18:01 INFO - Running main action method: create_virtualenv 14:18:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:18:01 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 14:18:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:18:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:01 INFO - Using real prefix '/usr' 14:18:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:18:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:03 INFO - Installing pip.................done. 14:18:03 INFO - Return code: 0 14:18:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:18: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')]} 14:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:18: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 pip>=1.5 14:18:03 INFO - Using env: {'DISPLAY': ':0', 14:18:03 INFO - 'HOME': '/home/cltbld', 14:18:03 INFO - 'LANG': 'en_US.UTF-8', 14:18:03 INFO - 'LANGUAGE': 'en_US:en', 14:18:03 INFO - 'LOGNAME': 'cltbld', 14:18:03 INFO - 'MAIL': '/var/mail/cltbld', 14:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:03 INFO - 'MOZ_NO_REMOTE': '1', 14:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:03 INFO - 'NO_EM_RESTART': '1', 14:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:03 INFO - 'SHELL': '/bin/bash', 14:18:03 INFO - 'SHLVL': '1', 14:18:03 INFO - 'TERM': 'linux', 14:18:03 INFO - 'TMOUT': '86400', 14:18:03 INFO - 'USER': 'cltbld', 14:18:03 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:03 INFO - '_': '/tools/buildbot/bin/python'} 14:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:04 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 14:18:04 INFO - Cleaning up... 14:18:04 INFO - Return code: 0 14:18:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:18:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:18:04 INFO - Using env: {'DISPLAY': ':0', 14:18:04 INFO - 'HOME': '/home/cltbld', 14:18:04 INFO - 'LANG': 'en_US.UTF-8', 14:18:04 INFO - 'LANGUAGE': 'en_US:en', 14:18:04 INFO - 'LOGNAME': 'cltbld', 14:18:04 INFO - 'MAIL': '/var/mail/cltbld', 14:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:04 INFO - 'MOZ_NO_REMOTE': '1', 14:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:04 INFO - 'NO_EM_RESTART': '1', 14:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:04 INFO - 'SHELL': '/bin/bash', 14:18:04 INFO - 'SHLVL': '1', 14:18:04 INFO - 'TERM': 'linux', 14:18:04 INFO - 'TMOUT': '86400', 14:18:04 INFO - 'USER': 'cltbld', 14:18:04 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:04 INFO - '_': '/tools/buildbot/bin/python'} 14:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:04 INFO - Downloading/unpacking psutil>=0.7.1 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:06 INFO - Installing collected packages: psutil 14:18:06 INFO - Running setup.py install for psutil 14:18:06 INFO - building 'psutil._psutil_linux' extension 14:18:06 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 14:18:06 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 14:18:06 INFO - building 'psutil._psutil_posix' extension 14:18:06 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 14:18:06 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 14:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:06 INFO - Successfully installed psutil 14:18:06 INFO - Cleaning up... 14:18:06 INFO - Return code: 0 14:18:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:06 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:06 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 14:18:06 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 14:18:06 INFO - Using env: {'DISPLAY': ':0', 14:18:06 INFO - 'HOME': '/home/cltbld', 14:18:06 INFO - 'LANG': 'en_US.UTF-8', 14:18:06 INFO - 'LANGUAGE': 'en_US:en', 14:18:06 INFO - 'LOGNAME': 'cltbld', 14:18:06 INFO - 'MAIL': '/var/mail/cltbld', 14:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:06 INFO - 'MOZ_NO_REMOTE': '1', 14:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:06 INFO - 'NO_EM_RESTART': '1', 14:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:06 INFO - 'SHELL': '/bin/bash', 14:18:06 INFO - 'SHLVL': '1', 14:18:06 INFO - 'TERM': 'linux', 14:18:06 INFO - 'TMOUT': '86400', 14:18:06 INFO - 'USER': 'cltbld', 14:18:06 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:06 INFO - '_': '/tools/buildbot/bin/python'} 14:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:18:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:18:08 INFO - Installing collected packages: mozsystemmonitor 14:18:08 INFO - Running setup.py install for mozsystemmonitor 14:18:08 INFO - Successfully installed mozsystemmonitor 14:18:08 INFO - Cleaning up... 14:18:09 INFO - Return code: 0 14:18:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:18:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:09 INFO - Using env: {'DISPLAY': ':0', 14:18:09 INFO - 'HOME': '/home/cltbld', 14:18:09 INFO - 'LANG': 'en_US.UTF-8', 14:18:09 INFO - 'LANGUAGE': 'en_US:en', 14:18:09 INFO - 'LOGNAME': 'cltbld', 14:18:09 INFO - 'MAIL': '/var/mail/cltbld', 14:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:09 INFO - 'MOZ_NO_REMOTE': '1', 14:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:09 INFO - 'NO_EM_RESTART': '1', 14:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:09 INFO - 'SHELL': '/bin/bash', 14:18:09 INFO - 'SHLVL': '1', 14:18:09 INFO - 'TERM': 'linux', 14:18:09 INFO - 'TMOUT': '86400', 14:18:09 INFO - 'USER': 'cltbld', 14:18:09 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:09 INFO - '_': '/tools/buildbot/bin/python'} 14:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:09 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:11 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:18:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:11 INFO - Downloading docopt-0.6.1.tar.gz 14:18:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:11 INFO - Running setup.py install for blobuploader 14:18:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:18:11 INFO - Running setup.py install for requests 14:18:12 INFO - Running setup.py install for docopt 14:18:12 INFO - Successfully installed blobuploader requests docopt 14:18:12 INFO - Cleaning up... 14:18:12 INFO - Return code: 0 14:18:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:12 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:12 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 14:18:12 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 14:18:12 INFO - Using env: {'DISPLAY': ':0', 14:18:12 INFO - 'HOME': '/home/cltbld', 14:18:12 INFO - 'LANG': 'en_US.UTF-8', 14:18:12 INFO - 'LANGUAGE': 'en_US:en', 14:18:12 INFO - 'LOGNAME': 'cltbld', 14:18:12 INFO - 'MAIL': '/var/mail/cltbld', 14:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:12 INFO - 'MOZ_NO_REMOTE': '1', 14:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:12 INFO - 'NO_EM_RESTART': '1', 14:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:12 INFO - 'SHELL': '/bin/bash', 14:18:12 INFO - 'SHLVL': '1', 14:18:12 INFO - 'TERM': 'linux', 14:18:12 INFO - 'TMOUT': '86400', 14:18:12 INFO - 'USER': 'cltbld', 14:18:12 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:12 INFO - '_': '/tools/buildbot/bin/python'} 14:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:12 INFO - Running setup.py (path:/tmp/pip-uTAu4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:12 INFO - Running setup.py (path:/tmp/pip-EhBoJG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:12 INFO - Running setup.py (path:/tmp/pip-BUuRGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:12 INFO - Running setup.py (path:/tmp/pip-fA2ktD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:12 INFO - Running setup.py (path:/tmp/pip-ga4prJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:12 INFO - Running setup.py (path:/tmp/pip-1oJXEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:13 INFO - Running setup.py (path:/tmp/pip-4q0XOX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:13 INFO - Running setup.py (path:/tmp/pip-SqBZ1u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:13 INFO - Running setup.py (path:/tmp/pip-5Fdrfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:13 INFO - Running setup.py (path:/tmp/pip-EXONrf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:13 INFO - Running setup.py (path:/tmp/pip-a5OfYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:13 INFO - Running setup.py (path:/tmp/pip-Gxszdl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:13 INFO - Running setup.py (path:/tmp/pip-V7xudV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:13 INFO - Running setup.py (path:/tmp/pip-Y7CXmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:13 INFO - Running setup.py (path:/tmp/pip-1WTCz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:13 INFO - Running setup.py (path:/tmp/pip-MNnOR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:13 INFO - Running setup.py (path:/tmp/pip-A0afPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:13 INFO - Running setup.py install for manifestparser 14:18:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:18:13 INFO - Running setup.py install for mozcrash 14:18:14 INFO - Running setup.py install for mozdebug 14:18:14 INFO - Running setup.py install for mozdevice 14:18:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for mozfile 14:18:14 INFO - Running setup.py install for mozhttpd 14:18:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for mozinfo 14:18:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for mozInstall 14:18:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for mozleak 14:18:14 INFO - Running setup.py install for mozlog 14:18:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for moznetwork 14:18:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:18:14 INFO - Running setup.py install for mozprocess 14:18:15 INFO - Running setup.py install for mozprofile 14:18:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:18:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:18:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:18:15 INFO - Running setup.py install for mozrunner 14:18:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:18:15 INFO - Running setup.py install for mozscreenshot 14:18:15 INFO - Running setup.py install for moztest 14:18:15 INFO - Running setup.py install for mozversion 14:18:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:18:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:15 INFO - Cleaning up... 14:18:15 INFO - Return code: 0 14:18:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:15 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')]} 14:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 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')]} 14:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:15 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:15 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 14:18:15 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 14:18:15 INFO - Using env: {'DISPLAY': ':0', 14:18:15 INFO - 'HOME': '/home/cltbld', 14:18:15 INFO - 'LANG': 'en_US.UTF-8', 14:18:15 INFO - 'LANGUAGE': 'en_US:en', 14:18:15 INFO - 'LOGNAME': 'cltbld', 14:18:15 INFO - 'MAIL': '/var/mail/cltbld', 14:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:15 INFO - 'MOZ_NO_REMOTE': '1', 14:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:15 INFO - 'NO_EM_RESTART': '1', 14:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:15 INFO - 'SHELL': '/bin/bash', 14:18:15 INFO - 'SHLVL': '1', 14:18:15 INFO - 'TERM': 'linux', 14:18:15 INFO - 'TMOUT': '86400', 14:18:15 INFO - 'USER': 'cltbld', 14:18:15 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:15 INFO - '_': '/tools/buildbot/bin/python'} 14:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:15 INFO - Running setup.py (path:/tmp/pip-fifpKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:15 INFO - Running setup.py (path:/tmp/pip-Ox27bM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:15 INFO - Running setup.py (path:/tmp/pip-jTmWJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:16 INFO - Running setup.py (path:/tmp/pip-Ixn3Hl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:16 INFO - Running setup.py (path:/tmp/pip-6QnxOR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:16 INFO - Running setup.py (path:/tmp/pip-1IRa9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:16 INFO - Running setup.py (path:/tmp/pip-OW7XZ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:16 INFO - Running setup.py (path:/tmp/pip-8G0lzX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:16 INFO - Running setup.py (path:/tmp/pip-10bCsl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:16 INFO - Running setup.py (path:/tmp/pip-aUjesn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:16 INFO - Running setup.py (path:/tmp/pip-_IBzYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:16 INFO - Running setup.py (path:/tmp/pip-wLB0UW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:16 INFO - Running setup.py (path:/tmp/pip-WVphoF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:16 INFO - Running setup.py (path:/tmp/pip-mG0H5L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:16 INFO - Running setup.py (path:/tmp/pip-Gsu5m4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:18:16 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)) 14:18:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:16 INFO - Running setup.py (path:/tmp/pip-pi2Eof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:18:17 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)) 14:18:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:17 INFO - Running setup.py (path:/tmp/pip-2dvdvs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 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)) 14:18:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:18 INFO - Downloading blessings-1.6.tar.gz 14:18:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:18 INFO - Installing collected packages: blessings 14:18:18 INFO - Running setup.py install for blessings 14:18:19 INFO - Successfully installed blessings 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:18:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:18:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:18:19 INFO - Reading from file tmpfile_stdout 14:18:19 INFO - Current package versions: 14:18:19 INFO - argparse == 1.2.1 14:18:19 INFO - blessings == 1.6 14:18:19 INFO - blobuploader == 1.2.4 14:18:19 INFO - docopt == 0.6.1 14:18:19 INFO - manifestparser == 1.1 14:18:19 INFO - mozInstall == 1.12 14:18:19 INFO - mozcrash == 0.16 14:18:19 INFO - mozdebug == 0.1 14:18:19 INFO - mozdevice == 0.48 14:18:19 INFO - mozfile == 1.2 14:18:19 INFO - mozhttpd == 0.7 14:18:19 INFO - mozinfo == 0.9 14:18:19 INFO - mozleak == 0.1 14:18:19 INFO - mozlog == 3.1 14:18:19 INFO - moznetwork == 0.27 14:18:19 INFO - mozprocess == 0.22 14:18:19 INFO - mozprofile == 0.28 14:18:19 INFO - mozrunner == 6.11 14:18:19 INFO - mozscreenshot == 0.1 14:18:19 INFO - mozsystemmonitor == 0.0 14:18:19 INFO - moztest == 0.7 14:18:19 INFO - mozversion == 1.4 14:18:19 INFO - psutil == 3.1.1 14:18:19 INFO - requests == 1.2.3 14:18:19 INFO - wsgiref == 0.1.2 14:18:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:18:19 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')]} 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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')]} 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:19 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 14:18:19 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 14:18:19 INFO - Using env: {'DISPLAY': ':0', 14:18:19 INFO - 'HOME': '/home/cltbld', 14:18:19 INFO - 'LANG': 'en_US.UTF-8', 14:18:19 INFO - 'LANGUAGE': 'en_US:en', 14:18:19 INFO - 'LOGNAME': 'cltbld', 14:18:19 INFO - 'MAIL': '/var/mail/cltbld', 14:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:19 INFO - 'MOZ_NO_REMOTE': '1', 14:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:19 INFO - 'NO_EM_RESTART': '1', 14:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:19 INFO - 'SHELL': '/bin/bash', 14:18:19 INFO - 'SHLVL': '1', 14:18:19 INFO - 'TERM': 'linux', 14:18:19 INFO - 'TMOUT': '86400', 14:18:19 INFO - 'USER': 'cltbld', 14:18:19 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:19 INFO - '_': '/tools/buildbot/bin/python'} 14:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 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)) 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:18:19 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')]} 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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')]} 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:19 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 14:18:19 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 14:18:19 INFO - Using env: {'DISPLAY': ':0', 14:18:19 INFO - 'HOME': '/home/cltbld', 14:18:19 INFO - 'LANG': 'en_US.UTF-8', 14:18:19 INFO - 'LANGUAGE': 'en_US:en', 14:18:19 INFO - 'LOGNAME': 'cltbld', 14:18:19 INFO - 'MAIL': '/var/mail/cltbld', 14:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:19 INFO - 'MOZ_NO_REMOTE': '1', 14:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:19 INFO - 'NO_EM_RESTART': '1', 14:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:19 INFO - 'SHELL': '/bin/bash', 14:18:19 INFO - 'SHLVL': '1', 14:18:19 INFO - 'TERM': 'linux', 14:18:19 INFO - 'TMOUT': '86400', 14:18:19 INFO - 'USER': 'cltbld', 14:18:19 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:19 INFO - '_': '/tools/buildbot/bin/python'} 14:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:19 INFO - Downloading/unpacking jsonschema 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:19 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 14:18:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:21 INFO - Downloading/unpacking functools32 (from jsonschema) 14:18:21 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 14:18:21 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 14:18:21 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 14:18:21 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 14:18:21 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 14:18:21 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 14:18:21 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:21 INFO - warning: no files found matching '*.txt' 14:18:21 INFO - no previously-included directories found matching 'build' 14:18:21 INFO - no previously-included directories found matching 'dist' 14:18:21 INFO - no previously-included directories found matching '.git*' 14:18:21 INFO - Installing collected packages: jsonschema, functools32 14:18:21 INFO - Running setup.py install for functools32 14:18:22 INFO - warning: no files found matching '*.txt' 14:18:22 INFO - no previously-included directories found matching 'build' 14:18:22 INFO - no previously-included directories found matching 'dist' 14:18:22 INFO - no previously-included directories found matching '.git*' 14:18:22 INFO - Successfully installed jsonschema functools32 14:18:22 INFO - Cleaning up... 14:18:22 INFO - Return code: 0 14:18:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:18:22 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')]} 14:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:22 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')]} 14:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:22 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 0x7f52e7364f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2781670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', '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 14:18:22 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 14:18:22 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 14:18:22 INFO - Using env: {'DISPLAY': ':0', 14:18:22 INFO - 'HOME': '/home/cltbld', 14:18:22 INFO - 'LANG': 'en_US.UTF-8', 14:18:22 INFO - 'LANGUAGE': 'en_US:en', 14:18:22 INFO - 'LOGNAME': 'cltbld', 14:18:22 INFO - 'MAIL': '/var/mail/cltbld', 14:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:22 INFO - 'MOZ_NO_REMOTE': '1', 14:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:22 INFO - 'NO_EM_RESTART': '1', 14:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:22 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:22 INFO - 'SHELL': '/bin/bash', 14:18:22 INFO - 'SHLVL': '1', 14:18:22 INFO - 'TERM': 'linux', 14:18:22 INFO - 'TMOUT': '86400', 14:18:22 INFO - 'USER': 'cltbld', 14:18:22 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:22 INFO - '_': '/tools/buildbot/bin/python'} 14:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:22 INFO - Downloading/unpacking flake8 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:24 INFO - no previously-included directories found matching 'docs/_build' 14:18:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:24 INFO - Running setup.py install for pep8 14:18:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:24 INFO - no previously-included directories found matching 'docs/_build' 14:18:25 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:18:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:25 INFO - Cleaning up... 14:18:25 INFO - Return code: 0 14:18:25 INFO - Running post-action listener: _resource_record_post_action 14:18:25 INFO - Running post-action listener: _start_resource_monitoring 14:18:25 INFO - Starting resource monitoring. 14:18:25 INFO - ##### 14:18:25 INFO - ##### Running install step. 14:18:25 INFO - ##### 14:18:25 INFO - Running pre-action listener: _resource_record_pre_action 14:18:25 INFO - Running main action method: install 14:18:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:18:25 INFO - Reading from file tmpfile_stdout 14:18:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:18:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:18:25 INFO - Reading from file tmpfile_stdout 14:18:25 INFO - Output received: 14:18:25 INFO - Usage: mozinstall [options] installer 14:18:25 INFO - Options: 14:18:25 INFO - -h, --help show this help message and exit 14:18:25 INFO - -d DEST, --destination=DEST 14:18:25 INFO - Directory to install application into. [default: 14:18:25 INFO - "/builds/slave/test-pgo"] 14:18:25 INFO - --app=APP Application being installed. [default: firefox] 14:18:25 INFO - mkdir: /builds/slave/test-pgo/build/application 14:18:25 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'] 14:18:25 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 14:18:41 INFO - Reading from file tmpfile_stdout 14:18:41 INFO - Output received: 14:18:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:18:41 INFO - Running post-action listener: _resource_record_post_action 14:18:41 INFO - ##### 14:18:41 INFO - ##### Running run-tests step. 14:18:41 INFO - ##### 14:18:41 INFO - Running pre-action listener: _resource_record_pre_action 14:18:41 INFO - Running main action method: run_tests 14:18:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:18:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:18:41 INFO - Python 2.7.3 14:18:41 INFO - Return code: 0 14:18:41 INFO - grabbing minidump binary from tooltool 14:18: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')]} 14:18:41 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 0x28108c0>, '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 0x28117c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2811c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:18:41 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 14:18:41 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 14:18:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:41 INFO - Return code: 0 14:18:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:18:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:18:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:18:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:18:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:18:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:18:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:18:42 INFO - Return code: 0 14:18:42 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/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:18:42 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/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 14:18:42 INFO - Using env: {'DISPLAY': ':0', 14:18:42 INFO - 'HOME': '/home/cltbld', 14:18:42 INFO - 'LANG': 'en_US.UTF-8', 14:18:42 INFO - 'LANGUAGE': 'en_US:en', 14:18:42 INFO - 'LOGNAME': 'cltbld', 14:18:42 INFO - 'MAIL': '/var/mail/cltbld', 14:18:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:18:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:42 INFO - 'MOZ_NO_REMOTE': '1', 14:18:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:42 INFO - 'NO_EM_RESTART': '1', 14:18:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:18:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:18:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:18:42 INFO - 'SHELL': '/bin/bash', 14:18:42 INFO - 'SHLVL': '1', 14:18:42 INFO - 'TERM': 'linux', 14:18:42 INFO - 'TMOUT': '86400', 14:18:42 INFO - 'USER': 'cltbld', 14:18:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955', 14:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:42 INFO - '_': '/tools/buildbot/bin/python'} 14:18:42 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/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 14:18:42 INFO - mozversion application_buildid: 20160222113154 14:18:42 INFO - mozversion application_changeset: 7d4147c08c3e554544c4607766b1983d5922c0a6 14:18:42 INFO - mozversion application_display_name: Nightly 14:18:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:42 INFO - mozversion application_name: Firefox 14:18:42 INFO - mozversion application_remotingname: firefox 14:18:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:42 INFO - mozversion application_vendor: Mozilla 14:18:42 INFO - mozversion application_version: 47.0a1 14:18:42 INFO - mozversion platform_buildid: 20160222113154 14:18:42 INFO - mozversion platform_changeset: 7d4147c08c3e554544c4607766b1983d5922c0a6 14:18:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:42 INFO - mozversion platform_version: 47.0a1 14:18:42 INFO - using testdate: 1456179522 14:18:42 INFO - actual date: 1456179522 14:18:42 INFO - starting webserver on 'localhost:50848' 14:18:42 INFO - SUITE-START | Running 2 tests 14:18:42 INFO - TEST-START | dromaeo_css 14:18:42 INFO - operating with platform_type : linux_ 14:18:42 INFO - Initialising browser for dromaeo_css test... 14:18:42 INFO - TEST-INFO | started process 28300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyoEIEI/profile http://localhost:50848/getInfo.html) 14:18:47 INFO - PROCESS | 28300 | __metrics Screen width/height:1600/1200 14:18:47 INFO - PROCESS | 28300 | colorDepth:24 14:18:47 INFO - PROCESS | 28300 | Browser inner width/height: 1024/697 14:18:47 INFO - PROCESS | 28300 | __metrics 14:18:48 INFO - PROCESS | 28300 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:49 INFO - TEST-INFO | 28300: exit 0 14:18:49 INFO - Browser initialized. 14:18:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:49 INFO - TEST-INFO | started process 28396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyoEIEI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:01 INFO - PROCESS | 28396 | RSS: Main: 149020672 14:19:01 INFO - PROCESS | 28396 | 14:19:52 INFO - PROCESS | 28396 | 1456179592674 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] 14:22:00 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50848/tests/dromaeo/cssquery-ext.html) 14:22:01 INFO - PROCESS | 28396 | RSS: Main: 274784256 14:22:01 INFO - PROCESS | 28396 | 14:25:04 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-ext.html (next: http://localhost:50848/tests/dromaeo/cssquery-jquery.html) 14:25:04 INFO - PROCESS | 28396 | RSS: Main: 231874560 14:25:04 INFO - PROCESS | 28396 | 14:28:06 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50848/tests/dromaeo/cssquery-mootools.html) 14:28:07 INFO - PROCESS | 28396 | RSS: Main: 227590144 14:28:07 INFO - PROCESS | 28396 | 14:31:09 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50848/tests/dromaeo/cssquery-prototype.html) 14:31:09 INFO - PROCESS | 28396 | RSS: Main: 190275584 14:31:09 INFO - PROCESS | 28396 | 14:34:12 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50848/tests/dromaeo/cssquery-yui.html) 14:34:12 INFO - PROCESS | 28396 | RSS: Main: 208330752 14:34:12 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | Cycle 1(1): loaded http://localhost:50848/tests/dromaeo/cssquery-yui.html (next: http://localhost:50848/tests/dromaeo/cssquery-dojo.html) 14:37:15 INFO - PROCESS | 28396 | RSS: Main: 275611648 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | __start_tp_report 14:37:15 INFO - PROCESS | 28396 | _x_x_mozilla_page_load 14:37:15 INFO - PROCESS | 28396 | _x_x_mozilla_page_load_details 14:37:15 INFO - PROCESS | 28396 | |i|pagename|runs| 14:37:15 INFO - PROCESS | 28396 | |0;dojo.html;3089;3152.401043801676;3194.2972546039864;3196.0411876437065;3233.1432170474823;4908.680935739183;5060;5076.162433198522;5125.974370128149;5127.282180494729;5083.135866902626;5090.490950904908;5095.03194393065;5104.744762761866;5156.974215128928;4528.04910968697;4607.193741095303;4669.649776266777;4700.365450664151;4764.642651801111;4538.591526762591;4628.236341003731;4671.672982891199;4676.766161691919;4765;4610;4610.308453731934;4646.999999999983;4661.114388266235;4676.321933319649;4616.746078965655;4624.237000894848;4624.953750462486;4648;4663.650226233046;4542.04617030424;4605.815767369301;4613.561711637389;4652.371929789469;4692.859214223578;4915.778789954461;4916.754162291907;4922.827701030446;4955.256711493269;4984.800607975677;5289.3652761668845;5419.945800542023;5426.9185962210595;5430.972845135749;5435.103207970719;5417.674939503642;5481.5340696040885;5487.42382049887;5506.476884695988;5554.72226388683;5106.5659418949435;5147.3051138096625;5160.638755287131;5165.431802501759;5171.2501687255135;5451.291332126877;5518.806841760599;5564.888702226014;5592.133219351007;5638.9436105638415;5228.92156617651;5230.08473517133;5236.581073514109;5252.212168174804;5256.842294731164;5324.653897496651;5330.840074797762;5346.385165705994;5348.304720386403;5381.973090134525;5284.762185701653;5392.892142157135;5410.513053825174;5428.6199966002005;5459.07195776711;5315.123004704258;5330.307060082165;5332.897104531382;5333.333333333333;5349.331333583302;4148.43996060534;4205.453291072141;4214.641755450821;4218.6625069994325;4273.145370925828;3762.9435558466644;3812.3328417526823;3818.522684664417;3835.32881745699;3839.0594304395604;4977.850664480072;5062.670926389773;5067.113255180328;5067.8986420271385;5083.110455670243;5321.627486075938;5393.43368946255;5396.568274538027;5418.2685337479725;5448.318960129984;5029.949700502948;5047.97476012625;5051.559718783227;5057.772400241998;5064.037832811754;4658.440987081572;4662.463816661128;4663.673542852036;4694.436667599842;4700.106979673851;5561.138023606348;5696.202531645573;5730.369659337386;5734.254546908875;5784.363719990882;5329.626926115135;5343.278657381204;5345.358556973188;5350.411454739898;5373.516383525502;5511.696856672921;5607.074832652566;5634.915476267777;5659.745311461076;5662.971685141548;5303.36359636846;5327.9733601331745;5333.893322133613;5336.546393556591;5374.113271310346;5375.731213439391;5378.97310513445;5380.031594312904;5380.650257733235;5423.050966080999;5154.845354639367;5173.534381905646;5198.792048318025;5251.448597897319;5270.051390749549;5338.519533242027;5341.145416733304;5352.437994010728;5369.650972686919;5370.355557332989;5135.435102138687;5260.736963151904;5291.576673866159;5293.338332708411;5322.600804939568;5287.9735601321745;5319.46805319465;5327.387350454593;5379.300690910157;5381.408045114956;5090.490950905028;5131.615128865425;5174.844754657366;5206.921896171485;5302.125149350314 14:37:15 INFO - PROCESS | 28396 | |1;ext.html;544.6595877576515;588.6909372579395;590.4390828712723;598.4225222660132;600.9459148676618;36861.63138368615;37645.62354376455;37657.435138472945;37682.05794855123;37719.811400942956;40956.38565421513;41308;41586.58413415865;41591.16817663645;41615.58384416155;8520.233179013887;8725.952885653698;8726.214640682338;8736.694215702451;8736.737897863042;8461.365397595206;8581.485110893334;8583;8833.293336533063;8833.46999180048;8845.115488451136;8907.109289071106;8918.777030574223;8919.152680495343;8924.286057115416;8763.036066032731;8818.779530511789;8827.249683776887;8838.337124715672;8847.955760221223;8522.659093636246;8683;8686.522241276727;8901.51041692713;8913.509756963364;40757.18485630301;41068.58931410708;41142.588574114474;41206.1758764823;41303;2216.3794137641326;3291.8024918504966;3322.0864262327814;3349.296647703961;3370.1574606348413;27990;29460;29993.70006299931;30226.697733022607;30884.691153088632;3737.103095257146;3877.243937432202;3883.980580097081;4030.2745505808944;4034.576369481221;234121.82939085367;234753;236045;236262;237274;53057;60786.39213607896;61569.692151538955;61649;61705;61177.38822611806;61481;61532.30846144232;61541.69229153915;61640;16188.75716864248;16352.75470867938;16380.754288685679;16397;16400.425985090704;11956.163068585289;11956.58151964677;11971.580994665144;12077.818832717516;12104.697382565506;20101.899490502456;20563.383098507067;20569.69145462819;20597.79402205959;20618.175272989214;7321.816954576178;7417.406607471389;7554.244575542401;7566.167721550625;7584.2794934481135;934.2946075712794;973.7711637765119;1007.6019972110975;1115.1914861725184;1152.4239019053628;29031.419371612872;29410.852945735136;29476.852615736785;29687.703122968494;30142.246443839078;912.7905525179165;1029.5727273181697;1041.9635312764017;1076.34343050739;1140.0252783869837;13955.511557095453;14128.293585320693;14295.356708948122;14297.92851035759;14527.92736036313;337818;338431;341788;342499;343597;45302.54697452983;54103;54463.45536544663;54546.454535454934;54584;1362.4550179928108;1389.638693939583;1395.5534229046607;1401.4534331610475;1402.214759734552;25904.352391190372;26519;26726;26852.865735671196;27022.72977270202;42067;44103.77948110239;44344.55655443533;44383.55616443794;44405.555944440144;213250;214387;214436;215318;215575;31894.202644933135;32392.35215295728;32829.83585082059;33108;33166.502502462965;44277.121987070735;45030.324545132506;45170;45354;45606.31590526078;36883.815580921924;37485.2502949934;38177.618223818514;38390.808045959595;38813.80593097129;36510.8174459126;36589.634103659686;37685.623143768215;37913.620863792115;38040.42939355857;37036.25927481381;37188.07029824168;37193.256134877694;37404.43893341657;37766.43350349692;30459;30695.846520767253;33177;33253.16867078342;33284.833575832934;24417.63373549434;24429.755702442748;24535.877320613996;24681.506369872863;24778 14:37:15 INFO - PROCESS | 28396 | |2;jquery.html;360.82860641195435;362.89294658075863;363.1955219189495;368.62400351641327;370.43323714716496;13593.252371119584;16651.33394664212;16914.49256522305;17119.229634666437;18480;15645.217739113055;15787.605309867231;15857.603559911007;15955.920220398912;16140.677186456263;5186.222066689989;5287.101192797234;5339.439358867321;5347.59893008024;5349.625526213166;3609.5848977367677;5232.555232805197;5253.264542963988;5457.2359869618285;5480.068388373966;5414.187871819239;5432.864178395552;5439.945600543983;5471.179323101527;5471.972640136793;5414.702191379472;5468;5837.299524057098;5904.734286957076;5991.910121348184;5310.787568497294;5333.120035194188;5337.039332920072;5338.252644629755;5346.331708536433;12865.421056052406;18643.254269829325;20401.77589344644;20584.176632934665;20656.896715516476;2007.7389939307795;2025.9594808103755;2170.858894171874;2209.359285807114;2668.4129491511835;9771.706848794547;9901.900980990169;11293;12383;12889.097763156582;1738.9043602601978;1790.4807605794433;1795.5870149865473;1809.348634491582;1812.1392338639173;62897.68551157261;63877.68061159665;64510.354896451376;64921;65156;9200.125988031126;9465.716028519155;9494.572744226527;9512.90487095134;9551.904480955101;11902.464389102512;11955.820662690066;11962.162648614514;12043.87956120445;12046.939765301116;7262.455315851226;7379.6679149438405;7469.327760501581;7566.810829729301;7575.2424757524905;7478.06524184477;7522.962385188039;7526.6989320427665;7547.320741133324;7572.20491848348;3965.6034396560112;3975.860844870416;3986.421968814506;3989.2819292527624;4026.1545075534464;1757.789065312145;1822.5170329862597;1854.4075810493823;1883.1262893421133;1887.37716553537;893.8257039877292;902.6660135749814;991.9900800992042;1012.4431562640518;1071.1591400750528;16580;16895.23971421289;17025.829741702673;17063.146842657818;17192.656146876994;940.6237504998055;966.6423423333271;979.3927764785878;997.7405874472689;999.9500524449445;7037.964810176019;7152.785416437515;9108.544572771334;9845.9447439824;9937.155341795884;416566;423718;435485;435984;437800;47359;47443.76278118588;68126;72159.6392018047;76063.61968190124;1003.1623594298696;1008.1128606825946;1014.8934361891895;1016.4409574733867;1019.6227395863579;15537.533873983799;15604.297806598503;15735.527934161535;15807.525774226791;15869.127198003758;32572;33464;34025.319493610485;34625.30749385049;35949.28101437904;40582.79708601438;44790.77604611956;45004.19983200766;45113.32330014987;45308.54691453043;7892.329152022143;8105.473144245605;8113.5131892086665;8277.255047045554;8438.367122465963;8774.378774378723;11601.477933492844;11930.701732456759;12711.364431778558;13024.54414095502;8006.967774045042;8760.25537829266;9869;10737.087347575543;10897;6363.809085727436;8155.306798922158;10364.948175259075;10405.479726013518;10745.086667633339;10913.18151138652;11041.282316649393;11174.329540227613;11194.776104477702;11275.718107047389;7756.603811314018;7818.804529886798;8057.677692892219;8269.669213231644;8274.420790544604;10416.531256093645;10488.895111049098;10511.369317840954;10545.630902918669;10607.734806629896 14:37:15 INFO - PROCESS | 28396 | |3;mootools.html;1311.1608570514877;1408.1973275233115;1416.7803990381492;1577.6055986003498;1786.3122697761366;7281;7434.256574342563;7438.590877501742;7441.9255807441905;7452.6273686315735;7290.380317673004;7371.299726525972;7393.297636724516;7420.406367490601;7442.776716698494;1881.4073566826473;1919.078842155766;2202.3503066595313;2219.456233222859;2258.8870556472193;2200.6038912995655;2201.933941981735;2203.911843526265;2206.3822129803602;2207.580559693661;2060.268604645352;2162.4485756132162;2164.3398763377163;2166.3392665237097;2167.306461932182;2198.8900554972347;2218.8335874809454;2227.4431392151964;2257.537204872997;2262.061244583496;2212.037763572851;2217.944551386212;2255.0528777913314;2257.1986944634746;2257.887105644711;7387.7783666490095;7437.405007599433;7439.442041846829;7440.627968601549;7446.367058800009;4403.757793321366;4516;4530.07133537624;4539.52335004823;4546.590806827368;3006.9849650751826;3080.337727388622;3103.7827352085365;3123.04747052149;3135.0908236611353;999.3004896572428;1010.9797804043951;1027.0961553832578;1044.8589440425596;1096.4682129167347;9929.950350248275;9988.800223995551;9998.550065247082;9999.50002499872;10007.699769006942;3891.5330160380936;3984.780837053932;4055.59444055598;4068.6948478864206;4076.449679293317;8188.303994160444;8388.8741668875;8454.196851299117;8455.95772021136;8470.534120623302;3966.5835087315995;4583.885402864955;4626.676132670748;4634.513376095461;4642.535746425398;4155.8753237402925;4233.005243767712;4255.553166917491;4256.446661933991;4266.317389217772;3392.8642854285554;3403.4384326585837;3427.246005878703;3447.3277710846646;3449.3101379724158;1012.6253286284121;1022.994885025585;1026.1534234256767;1033.7363972187195;1034.1209971524295;1325.5559387605067;1326.2970625568464;1358.3479929633831;1360.809486671847;1377.9035467517378;6938;7102.786916392516;7207.747728829466;7218.278172182845;7224.783256502314;1117.2067831839322;1121.971950701239;1133.7449073958458;1136.4545018391054;1155.0759392485977;5641.858953526113;5664.0937450007805;5667.971660141673;5712;5716.342620598602;8869.423487473294;9053.094690530894;9271.211946984447;9404.059594040542;9409.341346105706;9159.358844880795;9192.724218273463;9261.861072083924;9264.629414823332;9272.933612634499;6983.720651173896;7001;7066.328698773608;7080.681369338392;7099.3965512930945;6854.622995735083;6893.0694356261265;6893.241743408121;6897;6897.3447522485285;7930.60346982637;8027.75569786684;8065.395095367753;8077.555734434427;8176.918230817616;8114.107448180814;8273.089960104264;8278.958605206935;8289.461185023196;8402.201790829862;5516.282883225315;5985.581009329305;6030.185924900083;6328.145700330397;6337.556371053982;6868.072810170763;6904.965475172592;6923.169219693669;6944.930550694428;6947.201071876597;6148.4773794227995;6318.778842740482;6332.11350410952;6394.328595497592;6454.031895215755;6111.327753946974;6155;6172.722227499863;6245.313015568375;6284.057391391328;6471.546991710535;6482.740690372332;6504.739810407531;6637;6671.299513551007;6033.306169790355;6051.4553690168095;6105.236845394325;6106.1146133811235;6115.541334400027;6165.660888651168;6183.443490085914;6189.1025801257665;6212.968935155295;6218.53360997936 14:37:15 INFO - PROCESS | 28396 | |4;prototype.html;310.09143210393546;314.3665513989312;320.4472285307844;334.3647070565923;339.39926330395184;5943.791967281146;5967.582269241155;5969.820905372835;5976.701164941752;5981.5214782817375;5909.261342332208;5921.496672782808;5927.496162826154;5931.317898441681;5936.732847021884;4359.716618419792;4493.820247190125;4590.5638964298505;4637.791299391519;4648.116857797025;4586.7477288749105;4611.1930412177735;4612.677112602119;4613.8154473821005;4642.698224615389;4597.057603191354;4603.8158473661015;4607.9308810367875;4608.769561521911;4611.077784443125;4359.69482136249;4469.418975533176;4545.159145558082;4558.430196225472;4571.131485017836;4014.8193331300163;4020.1356708307853;4021.537523184842;4027.6375126238486;4035.757854528738;5564.888702225933;5633;5644.153376993484;5649.745761440745;5649.8587535311535;5323.813666521653;5338.519533242027;5341.0653135701095;5346.03771321162;5349.786008559653;6257.624542527417;6259.624422534663;6264.937350626481;6272.8118156455375;6277.121203031579;4386.8025938832825;4465.59809617136;4510.774461276956;4521.073179998092;4526.366308716782;6491.285958544557;6532.869342613121;6565.507586930999;6567.080608714784;6576.980568011966;4604.102200071021;4604.654650901196;4609.953900460952;4610.631149508098;4614.2617181250835;4670.299455081765;4676.2985552166765;4677.859664210079;4680.391549098664;4681.789319480631;5313.54834839043;5323.148296272578;5324.840254792362;5329.440408757102;5329.467053294717;6158.876822463615;6318.083877837687;6321.209848768904;6323.20959880015;6340.809775706736;1628.1940439482532;1652.2482270566863;1656.180190805535;1658;1661.1279078483892;1010.5705075343096;1084.7233955341337;1104.9005589496824;1105.7346236903086;1146.8451759012426;5929.080992446177;5969.343372229051;5971.462568368867;5995.700214989233;5997.490213331828;6385.201849768779;6441.452476539453;6450;6451.677416129269;6459.709313080829;5963.403659634002;5965.284165900033;5972.074328479092;5972.910406343908;5976.910346344808;3446.9827650861585;3481.89554313371;3488.1977145256733;3493.406120959443;3496.2133519957806;6540.771073012422;6749.3250674932115;6757.662116894136;6761.98570214462;6765.830854228585;6563.737450502022;6580.473562115019;6581.2102547694585;6592.17597800275;6595.637239951753;6699.196096468358;6728.932710672831;6730.057791909235;6730.663466826639;6738.292479289604;6417.1657684500715;6418.935810641834;6429.357064293533;6433.839154021187;6437.7103030362805;6154.907676384947;6304.936950630435;6343.52423568225;6359.777407790705;6361.363863613602;6684.4652427804685;6704.094947182263;6717.865642687021;6724.159480064992;6724.93275067243;4582.991741816795;4588.2888152336445;4588.426446694163;4590.517995610413;4595.977020114878;6383.744650213939;6386.201724784402;6393.328700486568;6398.200224971879;6398.616083035033;6083.178770865877;6225.097360882737;6231.4391704746795;6242.937570624235;6244.656543889948;6210.5031597473;6225.906611400742;6239.719212635533;6243.594166379353;6256.655883926428;6124.203853499017;6125.418085281891;6130.264368275657;6140.7104508052025;6142.078688196628;6236.314005459487;6259.405356491126;6259.499240060693;6260.843478913063;6265.780697675559;5952.494038006818;6045.093236014457;6126.969365153146;6152.477039451518;6191.133241346305 14:37:15 INFO - PROCESS | 28396 | |5;yui.html;759.4266328921664;761.2007392238148;766.2873527619312;769.2230846844689;773.0838955837332;13487.59537213884;13792.172469651829;13798.517051903185;13809.102408343451;13814.723705525883;12364.258144511314;12407.06946978978;12424.503019879217;12440.004799616032;12485.375731213448;643.9001954697006;801.6032064128265;803.6182813163759;813.8982627171604;817.4931542443693;814.5967745965755;815.351795322717;818.4925346285281;818.9959050204741;819.2749416766145;854.6196942360652;857.3141486810558;861.9741407757778;862.5557837713583;863.6502216602255;675.4258879952026;839.5088873009297;847.0216899481109;847.6651722569612;847.8007668197938;618.1839971237923;620.5966122020723;625.2996643758974;625.4183609243447;626.3266987987886;12334.259944403364;12408.317542535156;12444.315562644051;12517.687057823536;12535;12271.631851044483;12496.375181240901;12573.559925402658;12659.746805063847;12745;10439.582416703322;10462.686119416354;10476.738081547946;10583.10043646291;10749.570017199303;3505.1061979195397;3516.525269088666;3576.409892367756;3577.5349204603494;3650.817459127033;50691;51239.487605123846;51351;51353.48646513525;51419.228711569354;10024.348417352849;10047.346922450017;10147.819843018764;10155.086042256085;10189;17627.911860440614;17715.73426398605;17734;17737.935723856608;17746.29014839418;6947.131608548932;6960.477964152708;7020.1575810901995;7045.11936007999;7302.817429564303;3951.9012024699614;3955.426463162883;3983.322835118037;4012.8996775080855;4025.1144748155357;3116.2209447638093;3125.3749250150063;3139.607549056368;3141.7800753947463;3148.165736079941;533.0697932108495;558.1488230448517;564.7091747749912;564.9152627105885;566.7789562070795;600.3876046432614;634.0805831544279;642.8489305013318;656.0723859925549;664.6344510519292;7829.217078292125;8079.919200807916;8163.877541836877;8196.057453392817;8261.752147435587;546.1943633141165;546.5600191845602;623.0965100604142;676.4486943141324;680.792358330704;3626.658136489516;3720.5907350191455;3910.335243008695;4087.2438598859308;4156.231097247019;56768.71615641978;56776;57294.42705572974;57490.712546437;57792;45854.31218531725;46124.76937615291;47313;48272.27591586129;48964.75517622389;46420.535794642296;46645.30032049522;48074.27888581674;48268.27597586039;48315.51684483181;8181.6318265677;8316.584170791315;8335.541545214828;8360.581970901309;8431.241188293083;35003.47494787529;35096;35798.28403431969;36273.637263627024;36323.27353452969;39647;39862.800685996386;40398.59601403948;40487.1902561953;42475.3628695576;10018.3488073275;10330.483475826028;10365;10377.636782712569;10394.636187733393;11031.096072941891;11070.889291106985;11191.384473854016;11208.66374008781;11401.942990284995;9664.235035475336;10001;10164.390136591828;10195.894498388265;10260.538275777459;10080.495975201356;10289.691309260734;10453.790924181321;10745.817960024548;10791.946040269748;9815.312928094965;9931.354461959949;10288.845667314847;10482.580696772044;10521.105706014769;8346.62440190205;8378;8500.192481714228;8629.352798540009;8794.472331660121;8209;8418.663253470038;8493.150684931705;8552.828943421222;9007.954960225157 14:37:15 INFO - PROCESS | 28396 | __end_tp_report 14:37:15 INFO - PROCESS | 28396 | __start_cc_report 14:37:15 INFO - PROCESS | 28396 | _x_x_mozilla_cycle_collect,1008 14:37:15 INFO - PROCESS | 28396 | __end_cc_report 14:37:15 INFO - PROCESS | 28396 | __startTimestamp1456180635525__endTimestamp 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | ------- Summary: start ------- 14:37:15 INFO - PROCESS | 28396 | Number of tests: 6 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#0] dojo.html Cycles:165 Average:5040.18 Median:5206.92 stddev:527.39 (10.1%) stddev-sans-first:506.31 14:37:15 INFO - PROCESS | 28396 | Values: 3089.0 3152.4 3194.3 3196.0 3233.1 4908.7 5060.0 5076.2 5126.0 5127.3 5083.1 5090.5 5095.0 5104.7 5157.0 4528.0 4607.2 4669.6 4700.4 4764.6 4538.6 4628.2 4671.7 4676.8 4765.0 4610.0 4610.3 4647.0 4661.1 4676.3 4616.7 4624.2 4625.0 4648.0 4663.7 4542.0 4605.8 4613.6 4652.4 4692.9 4915.8 4916.8 4922.8 4955.3 4984.8 5289.4 5419.9 5426.9 5431.0 5435.1 5417.7 5481.5 5487.4 5506.5 5554.7 5106.6 5147.3 5160.6 5165.4 5171.3 5451.3 5518.8 5564.9 5592.1 5638.9 5228.9 5230.1 5236.6 5252.2 5256.8 5324.7 5330.8 5346.4 5348.3 5382.0 5284.8 5392.9 5410.5 5428.6 5459.1 5315.1 5330.3 5332.9 5333.3 5349.3 4148.4 4205.5 4214.6 4218.7 4273.1 3762.9 3812.3 3818.5 3835.3 3839.1 4977.9 5062.7 5067.1 5067.9 5083.1 5321.6 5393.4 5396.6 5418.3 5448.3 5029.9 5048.0 5051.6 5057.8 5064.0 4658.4 4662.5 4663.7 4694.4 4700.1 5561.1 5696.2 5730.4 5734.3 5784.4 5329.6 5343.3 5345.4 5350.4 5373.5 5511.7 5607.1 5634.9 5659.7 5663.0 5303.4 5328.0 5333.9 5336.5 5374.1 5375.7 5379.0 5380.0 5380.7 5423.1 5154.8 5173.5 5198.8 5251.4 5270.1 5338.5 5341.1 5352.4 5369.7 5370.4 5135.4 5260.7 5291.6 5293.3 5322.6 5288.0 5319.5 5327.4 5379.3 5381.4 5090.5 5131.6 5174.8 5206.9 5302.1 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#1] ext.html Cycles:180 Average:44090.91 Median:37444.84 stddev:70434.07 (188.1%) stddev-sans-first:70555.76 14:37:15 INFO - PROCESS | 28396 | Values: 544.7 588.7 590.4 598.4 600.9 36861.6 37645.6 37657.4 37682.1 37719.8 40956.4 41308.0 41586.6 41591.2 41615.6 8520.2 8726.0 8726.2 8736.7 8736.7 8461.4 8581.5 8583.0 8833.3 8833.5 8845.1 8907.1 8918.8 8919.2 8924.3 8763.0 8818.8 8827.2 8838.3 8848.0 8522.7 8683.0 8686.5 8901.5 8913.5 40757.2 41068.6 41142.6 41206.2 41303.0 2216.4 3291.8 3322.1 3349.3 3370.2 27990.0 29460.0 29993.7 30226.7 30884.7 3737.1 3877.2 3884.0 4030.3 4034.6 234121.8 234753.0 236045.0 236262.0 237274.0 53057.0 60786.4 61569.7 61649.0 61705.0 61177.4 61481.0 61532.3 61541.7 61640.0 16188.8 16352.8 16380.8 16397.0 16400.4 11956.2 11956.6 11971.6 12077.8 12104.7 20101.9 20563.4 20569.7 20597.8 20618.2 7321.8 7417.4 7554.2 7566.2 7584.3 934.3 973.8 1007.6 1115.2 1152.4 29031.4 29410.9 29476.9 29687.7 30142.2 912.8 1029.6 1042.0 1076.3 1140.0 13955.5 14128.3 14295.4 14297.9 14527.9 337818.0 338431.0 341788.0 342499.0 343597.0 45302.5 54103.0 54463.5 54546.5 54584.0 1362.5 1389.6 1395.6 1401.5 1402.2 25904.4 26519.0 26726.0 26852.9 27022.7 42067.0 44103.8 44344.6 44383.6 44405.6 213250.0 214387.0 214436.0 215318.0 215575.0 31894.2 32392.4 32829.8 33108.0 33166.5 44277.1 45030.3 45170.0 45354.0 45606.3 36883.8 37485.3 38177.6 38390.8 38813.8 36510.8 36589.6 37685.6 37913.6 38040.4 37036.3 37188.1 37193.3 37404.4 37766.4 30459.0 30695.8 33177.0 33253.2 33284.8 24417.6 24429.8 24535.9 24681.5 24778.0 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#2] jquery.html Cycles:180 Average:24527.04 Median:228574.40 stddev:70382.00 (30.8%) stddev-sans-first:70556.04 14:37:15 INFO - PROCESS | 28396 | Values: 360.8 362.9 363.2 368.6 370.4 13593.3 16651.3 16914.5 17119.2 18480.0 15645.2 15787.6 15857.6 15955.9 16140.7 5186.2 5287.1 5339.4 5347.6 5349.6 3609.6 5232.6 5253.3 5457.2 5480.1 5414.2 5432.9 5439.9 5471.2 5472.0 5414.7 5468.0 5837.3 5904.7 5991.9 5310.8 5333.1 5337.0 5338.3 5346.3 12865.4 18643.3 20401.8 20584.2 20656.9 2007.7 2026.0 2170.9 2209.4 2668.4 9771.7 9901.9 11293.0 12383.0 12889.1 1738.9 1790.5 1795.6 1809.3 1812.1 62897.7 63877.7 64510.4 64921.0 65156.0 9200.1 9465.7 9494.6 9512.9 9551.9 11902.5 11955.8 11962.2 12043.9 12046.9 7262.5 7379.7 7469.3 7566.8 7575.2 7478.1 7523.0 7526.7 7547.3 7572.2 3965.6 3975.9 3986.4 3989.3 4026.2 1757.8 1822.5 1854.4 1883.1 1887.4 893.8 902.7 992.0 1012.4 1071.2 16580.0 16895.2 17025.8 17063.1 17192.7 940.6 966.6 979.4 997.7 1000.0 7038.0 7152.8 9108.5 9845.9 9937.2 416566.0 423718.0 435485.0 435984.0 437800.0 47359.0 47443.8 68126.0 72159.6 76063.6 1003.2 1008.1 1014.9 1016.4 1019.6 15537.5 15604.3 15735.5 15807.5 15869.1 32572.0 33464.0 34025.3 34625.3 35949.3 40582.8 44790.8 45004.2 45113.3 45308.5 7892.3 8105.5 8113.5 8277.3 8438.4 8774.4 11601.5 11930.7 12711.4 13024.5 8007.0 8760.3 9869.0 10737.1 10897.0 6363.8 8155.3 10364.9 10405.5 10745.1 10913.2 11041.3 11174.3 11194.8 11275.7 7756.6 7818.8 8057.7 8269.7 8274.4 10416.5 10488.9 10511.4 10545.6 10607.7 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#3] mootools.html Cycles:180 Average:5198.44 Median:6105.68 stddev:2663.20 (43.6%) stddev-sans-first:2654.64 14:37:15 INFO - PROCESS | 28396 | Values: 1311.2 1408.2 1416.8 1577.6 1786.3 7281.0 7434.3 7438.6 7441.9 7452.6 7290.4 7371.3 7393.3 7420.4 7442.8 1881.4 1919.1 2202.4 2219.5 2258.9 2200.6 2201.9 2203.9 2206.4 2207.6 2060.3 2162.4 2164.3 2166.3 2167.3 2198.9 2218.8 2227.4 2257.5 2262.1 2212.0 2217.9 2255.1 2257.2 2257.9 7387.8 7437.4 7439.4 7440.6 7446.4 4403.8 4516.0 4530.1 4539.5 4546.6 3007.0 3080.3 3103.8 3123.0 3135.1 999.3 1011.0 1027.1 1044.9 1096.5 9930.0 9988.8 9998.6 9999.5 10007.7 3891.5 3984.8 4055.6 4068.7 4076.4 8188.3 8388.9 8454.2 8456.0 8470.5 3966.6 4583.9 4626.7 4634.5 4642.5 4155.9 4233.0 4255.6 4256.4 4266.3 3392.9 3403.4 3427.2 3447.3 3449.3 1012.6 1023.0 1026.2 1033.7 1034.1 1325.6 1326.3 1358.3 1360.8 1377.9 6938.0 7102.8 7207.7 7218.3 7224.8 1117.2 1122.0 1133.7 1136.5 1155.1 5641.9 5664.1 5668.0 5712.0 5716.3 8869.4 9053.1 9271.2 9404.1 9409.3 9159.4 9192.7 9261.9 9264.6 9272.9 6983.7 7001.0 7066.3 7080.7 7099.4 6854.6 6893.1 6893.2 6897.0 6897.3 7930.6 8027.8 8065.4 8077.6 8176.9 8114.1 8273.1 8279.0 8289.5 8402.2 5516.3 5985.6 6030.2 6328.1 6337.6 6868.1 6905.0 6923.2 6944.9 6947.2 6148.5 6318.8 6332.1 6394.3 6454.0 6111.3 6155.0 6172.7 6245.3 6284.1 6471.5 6482.7 6504.7 6637.0 6671.3 6033.3 6051.5 6105.2 6106.1 6115.5 6165.7 6183.4 6189.1 6213.0 6218.5 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#4] prototype.html Cycles:180 Average:5267.98 Median:5968.46 stddev:1555.72 (26.1%) stddev-sans-first:1514.93 14:37:15 INFO - PROCESS | 28396 | Values: 310.1 314.4 320.4 334.4 339.4 5943.8 5967.6 5969.8 5976.7 5981.5 5909.3 5921.5 5927.5 5931.3 5936.7 4359.7 4493.8 4590.6 4637.8 4648.1 4586.7 4611.2 4612.7 4613.8 4642.7 4597.1 4603.8 4607.9 4608.8 4611.1 4359.7 4469.4 4545.2 4558.4 4571.1 4014.8 4020.1 4021.5 4027.6 4035.8 5564.9 5633.0 5644.2 5649.7 5649.9 5323.8 5338.5 5341.1 5346.0 5349.8 6257.6 6259.6 6264.9 6272.8 6277.1 4386.8 4465.6 4510.8 4521.1 4526.4 6491.3 6532.9 6565.5 6567.1 6577.0 4604.1 4604.7 4610.0 4610.6 4614.3 4670.3 4676.3 4677.9 4680.4 4681.8 5313.5 5323.1 5324.8 5329.4 5329.5 6158.9 6318.1 6321.2 6323.2 6340.8 1628.2 1652.2 1656.2 1658.0 1661.1 1010.6 1084.7 1104.9 1105.7 1146.8 5929.1 5969.3 5971.5 5995.7 5997.5 6385.2 6441.5 6450.0 6451.7 6459.7 5963.4 5965.3 5972.1 5972.9 5976.9 3447.0 3481.9 3488.2 3493.4 3496.2 6540.8 6749.3 6757.7 6762.0 6765.8 6563.7 6580.5 6581.2 6592.2 6595.6 6699.2 6728.9 6730.1 6730.7 6738.3 6417.2 6418.9 6429.4 6433.8 6437.7 6154.9 6304.9 6343.5 6359.8 6361.4 6684.5 6704.1 6717.9 6724.2 6724.9 4583.0 4588.3 4588.4 4590.5 4596.0 6383.7 6386.2 6393.3 6398.2 6398.6 6083.2 6225.1 6231.4 6242.9 6244.7 6210.5 6225.9 6239.7 6243.6 6256.7 6124.2 6125.4 6130.3 6140.7 6142.1 6236.3 6259.4 6259.5 6260.8 6265.8 5952.5 6045.1 6127.0 6152.5 6191.1 14:37:15 INFO - PROCESS | 28396 | 14:37:15 INFO - PROCESS | 28396 | [#5] yui.html Cycles:180 Average:13414.09 Median:46979.15 stddev:15820.41 (33.7%) stddev-sans-first:15836.25 14:37:15 INFO - PROCESS | 28396 | Values: 759.4 761.2 766.3 769.2 773.1 13487.6 13792.2 13798.5 13809.1 13814.7 12364.3 12407.1 12424.5 12440.0 12485.4 643.9 801.6 803.6 813.9 817.5 814.6 815.4 818.5 819.0 819.3 854.6 857.3 862.0 862.6 863.7 675.4 839.5 847.0 847.7 847.8 618.2 620.6 625.3 625.4 626.3 12334.3 12408.3 12444.3 12517.7 12535.0 12271.6 12496.4 12573.6 12659.7 12745.0 10439.6 10462.7 10476.7 10583.1 10749.6 3505.1 3516.5 3576.4 3577.5 3650.8 50691.0 51239.5 51351.0 51353.5 51419.2 10024.3 10047.3 10147.8 10155.1 10189.0 17627.9 17715.7 17734.0 17737.9 17746.3 6947.1 6960.5 7020.2 7045.1 7302.8 3951.9 3955.4 3983.3 4012.9 4025.1 3116.2 3125.4 3139.6 3141.8 3148.2 533.1 558.1 564.7 564.9 566.8 600.4 634.1 642.8 656.1 664.6 7829.2 8079.9 8163.9 8196.1 8261.8 546.2 546.6 623.1 676.4 680.8 3626.7 3720.6 3910.3 4087.2 4156.2 56768.7 56776.0 57294.4 57490.7 57792.0 45854.3 46124.8 47313.0 48272.3 48964.8 46420.5 46645.3 48074.3 48268.3 48315.5 8181.6 8316.6 8335.5 8360.6 8431.2 35003.5 35096.0 35798.3 36273.6 36323.3 39647.0 39862.8 40398.6 40487.2 42475.4 10018.3 10330.5 10365.0 10377.6 10394.6 11031.1 11070.9 11191.4 11208.7 11401.9 9664.2 10001.0 10164.4 10195.9 10260.5 10080.5 10289.7 10453.8 10745.8 10791.9 9815.3 9931.4 10288.8 10482.6 10521.1 8346.6 8378.0 8500.2 8629.4 8794.5 8209.0 8418.7 8493.2 8552.8 9008.0 14:37:15 INFO - PROCESS | 28396 | -------- Summary: end -------- 14:37:15 INFO - PROCESS | 28396 | 14:37:16 INFO - TEST-INFO | 28396: exit 0 14:37:16 INFO - TEST-OK | dromaeo_css | took 1113282ms 14:37:16 INFO - TEST-START | kraken 14:37:16 INFO - operating with platform_type : linux_ 14:37:16 INFO - Initialising browser for kraken test... 14:37:16 INFO - TEST-INFO | started process 28579 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq1S4Ls/profile http://localhost:50848/getInfo.html) 14:37:20 INFO - PROCESS | 28579 | __metrics Screen width/height:1600/1200 14:37:20 INFO - PROCESS | 28579 | colorDepth:24 14:37:20 INFO - PROCESS | 28579 | Browser inner width/height: 1024/697 14:37:20 INFO - PROCESS | 28579 | __metrics 14:37:21 INFO - PROCESS | 28579 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:22 INFO - TEST-INFO | 28579: exit 0 14:37:22 INFO - Browser initialized. 14:37:22 INFO - Running cycle 1/1 for kraken test... 14:37:22 INFO - TEST-INFO | started process 28661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq1S4Ls/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:34 INFO - PROCESS | 28661 | RSS: Main: 147935232 14:37:34 INFO - PROCESS | 28661 | 14:37:36 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50848/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:37 INFO - PROCESS | 28661 | RSS: Main: 192679936 14:37:37 INFO - PROCESS | 28661 | 14:37:39 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50848/tests/kraken/driver.html?testName=audio-dft) 14:37:40 INFO - PROCESS | 28661 | RSS: Main: 181805056 14:37:40 INFO - PROCESS | 28661 | 14:37:43 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50848/tests/kraken/driver.html?testName=audio-fft) 14:37:44 INFO - PROCESS | 28661 | RSS: Main: 166359040 14:37:44 INFO - PROCESS | 28661 | 14:37:46 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50848/tests/kraken/driver.html?testName=audio-oscillator) 14:37:46 INFO - PROCESS | 28661 | RSS: Main: 168693760 14:37:46 INFO - PROCESS | 28661 | 14:37:48 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:49 INFO - PROCESS | 28661 | RSS: Main: 169893888 14:37:49 INFO - PROCESS | 28661 | 14:37:52 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50848/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:53 INFO - PROCESS | 28661 | RSS: Main: 168337408 14:37:53 INFO - PROCESS | 28661 | 14:37:56 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50848/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:56 INFO - PROCESS | 28661 | RSS: Main: 170987520 14:37:56 INFO - PROCESS | 28661 | 14:37:59 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50848/tests/kraken/driver.html?testName=json-parse-financial) 14:38:00 INFO - PROCESS | 28661 | RSS: Main: 171081728 14:38:00 INFO - PROCESS | 28661 | 14:38:01 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:02 INFO - PROCESS | 28661 | RSS: Main: 182128640 14:38:02 INFO - PROCESS | 28661 | 14:38:04 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:04 INFO - PROCESS | 28661 | RSS: Main: 176902144 14:38:04 INFO - PROCESS | 28661 | 14:38:06 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:07 INFO - PROCESS | 28661 | RSS: Main: 189743104 14:38:07 INFO - PROCESS | 28661 | 14:38:09 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:10 INFO - PROCESS | 28661 | RSS: Main: 199311360 14:38:10 INFO - PROCESS | 28661 | 14:38:13 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:13 INFO - PROCESS | 28661 | RSS: Main: 196022272 14:38:13 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | Cycle 1(1): loaded http://localhost:50848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50848/tests/kraken/driver.html?testName=ai-astar) 14:38:15 INFO - PROCESS | 28661 | RSS: Main: 256876544 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | __start_tp_report 14:38:15 INFO - PROCESS | 28661 | _x_x_mozilla_page_load 14:38:15 INFO - PROCESS | 28661 | _x_x_mozilla_page_load_details 14:38:15 INFO - PROCESS | 28661 | |i|pagename|runs| 14:38:15 INFO - PROCESS | 28661 | |0;ai-astar;112;114;106;111;113;111;100;111;112;111 14:38:15 INFO - PROCESS | 28661 | |1;audio-beat-detection;148;134;152;163;127;154;149;134;161;127 14:38:15 INFO - PROCESS | 28661 | |2;audio-dft;162;162;162;161;161;161;162;167;162;161 14:38:15 INFO - PROCESS | 28661 | |3;audio-fft;74;72;97;98;72;73;73;108;94;72 14:38:15 INFO - PROCESS | 28661 | |4;audio-oscillator;96;98;143;97;97;97;140;97;106;141 14:38:15 INFO - PROCESS | 28661 | |5;imaging-gaussian-blur;120;115;115;115;114;115;115;115;115;114 14:38:15 INFO - PROCESS | 28661 | |6;imaging-darkroom;145;145;146;146;146;146;145;145;146;145 14:38:15 INFO - PROCESS | 28661 | |7;imaging-desaturate;96;96;96;95;95;96;96;96;96;96 14:38:15 INFO - PROCESS | 28661 | |8;json-parse-financial;57;55;56;56;55;57;56;64;53;55 14:38:15 INFO - PROCESS | 28661 | |9;json-stringify-tinderbox;68;68;68;67;69;70;69;67;67;67 14:38:15 INFO - PROCESS | 28661 | |10;stanford-crypto-aes;87;82;83;91;83;84;85;85;90;83 14:38:15 INFO - PROCESS | 28661 | |11;stanford-crypto-ccm;126;115;116;116;114;136;126;118;116;123 14:38:15 INFO - PROCESS | 28661 | |12;stanford-crypto-pbkdf2;165;144;153;164;153;143;155;146;162;151 14:38:15 INFO - PROCESS | 28661 | |13;stanford-crypto-sha256-iterative;70;69;69;70;69;71;70;69;68;68 14:38:15 INFO - PROCESS | 28661 | __end_tp_report 14:38:15 INFO - PROCESS | 28661 | __start_cc_report 14:38:15 INFO - PROCESS | 28661 | _x_x_mozilla_cycle_collect,978 14:38:15 INFO - PROCESS | 28661 | __end_cc_report 14:38:15 INFO - PROCESS | 28661 | __startTimestamp1456180695666__endTimestamp 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | ------- Summary: start ------- 14:38:15 INFO - PROCESS | 28661 | Number of tests: 14 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:4.12 (3.7%) stddev-sans-first:4.31 14:38:15 INFO - PROCESS | 28661 | Values: 112.0 114.0 106.0 111.0 113.0 111.0 100.0 111.0 112.0 111.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:150.50 stddev:13.44 (8.9%) stddev-sans-first:14.20 14:38:15 INFO - PROCESS | 28661 | Values: 148.0 134.0 152.0 163.0 127.0 154.0 149.0 134.0 161.0 127.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 14:38:15 INFO - PROCESS | 28661 | Values: 162.0 162.0 162.0 161.0 161.0 161.0 162.0 167.0 162.0 161.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#3] audio-fft Cycles:10 Average:83.30 Median:73.50 stddev:14.18 (19.3%) stddev-sans-first:14.64 14:38:15 INFO - PROCESS | 28661 | Values: 74.0 72.0 97.0 98.0 72.0 73.0 73.0 108.0 94.0 72.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:97.00 stddev:21.00 (21.6%) stddev-sans-first:21.54 14:38:15 INFO - PROCESS | 28661 | Values: 96.0 98.0 143.0 97.0 97.0 97.0 140.0 97.0 106.0 141.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:0.44 14:38:15 INFO - PROCESS | 28661 | Values: 120.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 114.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:38:15 INFO - PROCESS | 28661 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:38:15 INFO - PROCESS | 28661 | Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.91 (5.2%) stddev-sans-first:3.08 14:38:15 INFO - PROCESS | 28661 | Values: 57.0 55.0 56.0 56.0 55.0 57.0 56.0 64.0 53.0 55.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 14:38:15 INFO - PROCESS | 28661 | Values: 68.0 68.0 68.0 67.0 69.0 70.0 69.0 67.0 67.0 67.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.00 stddev:3.09 (3.6%) stddev-sans-first:3.22 14:38:15 INFO - PROCESS | 28661 | Values: 87.0 82.0 83.0 91.0 83.0 84.0 85.0 85.0 90.0 83.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:7.04 (5.8%) stddev-sans-first:7.19 14:38:15 INFO - PROCESS | 28661 | Values: 126.0 115.0 116.0 116.0 114.0 136.0 126.0 118.0 116.0 123.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:154.00 stddev:8.03 (5.2%) stddev-sans-first:7.38 14:38:15 INFO - PROCESS | 28661 | Values: 165.0 144.0 153.0 164.0 153.0 143.0 155.0 146.0 162.0 151.0 14:38:15 INFO - PROCESS | 28661 | 14:38:15 INFO - PROCESS | 28661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 14:38:15 INFO - PROCESS | 28661 | Values: 70.0 69.0 69.0 70.0 69.0 71.0 70.0 69.0 68.0 68.0 14:38:15 INFO - PROCESS | 28661 | -------- Summary: end -------- 14:38:15 INFO - PROCESS | 28661 | 14:38:16 INFO - TEST-INFO | 28661: exit 0 14:38:16 INFO - TEST-OK | kraken | took 60348ms 14:38:16 INFO - SUITE-END | took 1173s 14:38:16 INFO - Completed test suite (00:19:33) 14:38:16 INFO - Working with test: dromaeo_css 14:38:16 INFO - Generating results file: dromaeo_css 14:38:16 INFO - Working with test: kraken 14:38:16 INFO - Generating results file: kraken 14:38:16 INFO - javascript benchmark 14:38:16 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:38:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:38:16 INFO - process_Request line: dromaeo_css 6741.84 graph.html#tests=[[72,64,35]] 14:38:16 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:38:16 INFO - process_Request line: kraken 1521.40 graph.html#tests=[[232,64,35]] 14:38:16 INFO - RETURN: dromaeo_css: 6741.84 14:38:16 INFO - RETURN: kraken: 1521.40 14:38:16 INFO - javascript benchmark 14:38:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3089.0, 3152.401043801676, 3194.2972546039864, 3196.0411876437065, 3233.1432170474823, 4908.680935739183, 5060.0, 5076.162433198522, 5125.974370128149, 5127.282180494729, 5083.135866902626, 5090.490950904908, 5095.03194393065, 5104.744762761866, 5156.974215128928, 4528.04910968697, 4607.193741095303, 4669.649776266777, 4700.365450664151, 4764.642651801111, 4538.591526762591, 4628.236341003731, 4671.672982891199, 4676.766161691919, 4765.0, 4610.0, 4610.308453731934, 4646.999999999983, 4661.114388266235, 4676.321933319649, 4616.746078965655, 4624.237000894848, 4624.953750462486, 4648.0, 4663.650226233046, 4542.04617030424, 4605.815767369301, 4613.561711637389, 4652.371929789469, 4692.859214223578, 4915.778789954461, 4916.754162291907, 4922.827701030446, 4955.256711493269, 4984.800607975677, 5289.3652761668845, 5419.945800542023, 5426.9185962210595, 5430.972845135749, 5435.103207970719, 5417.674939503642, 5481.5340696040885, 5487.42382049887, 5506.476884695988, 5554.72226388683, 5106.5659418949435, 5147.3051138096625, 5160.638755287131, 5165.431802501759, 5171.2501687255135, 5451.291332126877, 5518.806841760599, 5564.888702226014, 5592.133219351007, 5638.9436105638415, 5228.92156617651, 5230.08473517133, 5236.581073514109, 5252.212168174804, 5256.842294731164, 5324.653897496651, 5330.840074797762, 5346.385165705994, 5348.304720386403, 5381.973090134525, 5284.762185701653, 5392.892142157135, 5410.513053825174, 5428.6199966002005, 5459.07195776711, 5315.123004704258, 5330.307060082165, 5332.897104531382, 5333.333333333333, 5349.331333583302, 4148.43996060534, 4205.453291072141, 4214.641755450821, 4218.6625069994325, 4273.145370925828, 3762.9435558466644, 3812.3328417526823, 3818.522684664417, 3835.32881745699, 3839.0594304395604, 4977.850664480072, 5062.670926389773, 5067.113255180328, 5067.8986420271385, 5083.110455670243, 5321.627486075938, 5393.43368946255, 5396.568274538027, 5418.2685337479725, 5448.318960129984, 5029.949700502948, 5047.97476012625, 5051.559718783227, 5057.772400241998, 5064.037832811754, 4658.440987081572, 4662.463816661128, 4663.673542852036, 4694.436667599842, 4700.106979673851, 5561.138023606348, 5696.202531645573, 5730.369659337386, 5734.254546908875, 5784.363719990882, 5329.626926115135, 5343.278657381204, 5345.358556973188, 5350.411454739898, 5373.516383525502, 5511.696856672921, 5607.074832652566, 5634.915476267777, 5659.745311461076, 5662.971685141548, 5303.36359636846, 5327.9733601331745, 5333.893322133613, 5336.546393556591, 5374.113271310346, 5375.731213439391, 5378.97310513445, 5380.031594312904, 5380.650257733235, 5423.050966080999, 5154.845354639367, 5173.534381905646, 5198.792048318025, 5251.448597897319, 5270.051390749549, 5338.519533242027, 5341.145416733304, 5352.437994010728, 5369.650972686919, 5370.355557332989, 5135.435102138687, 5260.736963151904, 5291.576673866159, 5293.338332708411, 5322.600804939568, 5287.9735601321745, 5319.46805319465, 5327.387350454593, 5379.300690910157, 5381.408045114956, 5090.490950905028, 5131.615128865425, 5174.844754657366, 5206.921896171485, 5302.125149350314], "unit": "score", "name": "dojo.html", "value": 5008.538471893271}, {"lowerIsBetter": false, "replicates": [544.6595877576515, 588.6909372579395, 590.4390828712723, 598.4225222660132, 600.9459148676618, 36861.63138368615, 37645.62354376455, 37657.435138472945, 37682.05794855123, 37719.811400942956, 40956.38565421513, 41308.0, 41586.58413415865, 41591.16817663645, 41615.58384416155, 8520.233179013887, 8725.952885653698, 8726.214640682338, 8736.694215702451, 8736.737897863042, 8461.365397595206, 8581.485110893334, 8583.0, 8833.293336533063, 8833.46999180048, 8845.115488451136, 8907.109289071106, 8918.777030574223, 8919.152680495343, 8924.286057115416, 8763.036066032731, 8818.779530511789, 8827.249683776887, 8838.337124715672, 8847.955760221223, 8522.659093636246, 8683.0, 8686.522241276727, 8901.51041692713, 8913.509756963364, 40757.18485630301, 41068.58931410708, 41142.588574114474, 41206.1758764823, 41303.0, 2216.3794137641326, 3291.8024918504966, 3322.0864262327814, 3349.296647703961, 3370.1574606348413, 27990.0, 29460.0, 29993.70006299931, 30226.697733022607, 30884.691153088632, 3737.103095257146, 3877.243937432202, 3883.980580097081, 4030.2745505808944, 4034.576369481221, 234121.82939085367, 234753.0, 236045.0, 236262.0, 237274.0, 53057.0, 60786.39213607896, 61569.692151538955, 61649.0, 61705.0, 61177.38822611806, 61481.0, 61532.30846144232, 61541.69229153915, 61640.0, 16188.75716864248, 16352.75470867938, 16380.754288685679, 16397.0, 16400.425985090704, 11956.163068585289, 11956.58151964677, 11971.580994665144, 12077.818832717516, 12104.697382565506, 20101.899490502456, 20563.383098507067, 20569.69145462819, 20597.79402205959, 20618.175272989214, 7321.816954576178, 7417.406607471389, 7554.244575542401, 7566.167721550625, 7584.2794934481135, 934.2946075712794, 973.7711637765119, 1007.6019972110975, 1115.1914861725184, 1152.4239019053628, 29031.419371612872, 29410.852945735136, 29476.852615736785, 29687.703122968494, 30142.246443839078, 912.7905525179165, 1029.5727273181697, 1041.9635312764017, 1076.34343050739, 1140.0252783869837, 13955.511557095453, 14128.293585320693, 14295.356708948122, 14297.92851035759, 14527.92736036313, 337818.0, 338431.0, 341788.0, 342499.0, 343597.0, 45302.54697452983, 54103.0, 54463.45536544663, 54546.454535454934, 54584.0, 1362.4550179928108, 1389.638693939583, 1395.5534229046607, 1401.4534331610475, 1402.214759734552, 25904.352391190372, 26519.0, 26726.0, 26852.865735671196, 27022.72977270202, 42067.0, 44103.77948110239, 44344.55655443533, 44383.55616443794, 44405.555944440144, 213250.0, 214387.0, 214436.0, 215318.0, 215575.0, 31894.202644933135, 32392.35215295728, 32829.83585082059, 33108.0, 33166.502502462965, 44277.121987070735, 45030.324545132506, 45170.0, 45354.0, 45606.31590526078, 36883.815580921924, 37485.2502949934, 38177.618223818514, 38390.808045959595, 38813.80593097129, 36510.8174459126, 36589.634103659686, 37685.623143768215, 37913.620863792115, 38040.42939355857, 37036.25927481381, 37188.07029824168, 37193.256134877694, 37404.43893341657, 37766.43350349692, 30459.0, 30695.846520767253, 33177.0, 33253.16867078342, 33284.833575832934, 24417.63373549434, 24429.755702442748, 24535.877320613996, 24681.506369872863, 24778.0], "unit": "score", "name": "ext.html", "value": 18364.28584746677}, {"lowerIsBetter": false, "replicates": [360.82860641195435, 362.89294658075863, 363.1955219189495, 368.62400351641327, 370.43323714716496, 13593.252371119584, 16651.33394664212, 16914.49256522305, 17119.229634666437, 18480.0, 15645.217739113055, 15787.605309867231, 15857.603559911007, 15955.920220398912, 16140.677186456263, 5186.222066689989, 5287.101192797234, 5339.439358867321, 5347.59893008024, 5349.625526213166, 3609.5848977367677, 5232.555232805197, 5253.264542963988, 5457.2359869618285, 5480.068388373966, 5414.187871819239, 5432.864178395552, 5439.945600543983, 5471.179323101527, 5471.972640136793, 5414.702191379472, 5468.0, 5837.299524057098, 5904.734286957076, 5991.910121348184, 5310.787568497294, 5333.120035194188, 5337.039332920072, 5338.252644629755, 5346.331708536433, 12865.421056052406, 18643.254269829325, 20401.77589344644, 20584.176632934665, 20656.896715516476, 2007.7389939307795, 2025.9594808103755, 2170.858894171874, 2209.359285807114, 2668.4129491511835, 9771.706848794547, 9901.900980990169, 11293.0, 12383.0, 12889.097763156582, 1738.9043602601978, 1790.4807605794433, 1795.5870149865473, 1809.348634491582, 1812.1392338639173, 62897.68551157261, 63877.68061159665, 64510.354896451376, 64921.0, 65156.0, 9200.125988031126, 9465.716028519155, 9494.572744226527, 9512.90487095134, 9551.904480955101, 11902.464389102512, 11955.820662690066, 11962.162648614514, 12043.87956120445, 12046.939765301116, 7262.455315851226, 7379.6679149438405, 7469.327760501581, 7566.810829729301, 7575.2424757524905, 7478.06524184477, 7522.962385188039, 7526.6989320427665, 7547.320741133324, 7572.20491848348, 3965.6034396560112, 3975.860844870416, 3986.421968814506, 3989.2819292527624, 4026.1545075534464, 1757.789065312145, 1822.5170329862597, 1854.4075810493823, 1883.1262893421133, 1887.37716553537, 893.8257039877292, 902.6660135749814, 991.9900800992042, 1012.4431562640518, 1071.1591400750528, 16580.0, 16895.23971421289, 17025.829741702673, 17063.146842657818, 17192.656146876994, 940.6237504998055, 966.6423423333271, 979.3927764785878, 997.7405874472689, 999.9500524449445, 7037.964810176019, 7152.785416437515, 9108.544572771334, 9845.9447439824, 9937.155341795884, 416566.0, 423718.0, 435485.0, 435984.0, 437800.0, 47359.0, 47443.76278118588, 68126.0, 72159.6392018047, 76063.61968190124, 1003.1623594298696, 1008.1128606825946, 1014.8934361891895, 1016.4409574733867, 1019.6227395863579, 15537.533873983799, 15604.297806598503, 15735.527934161535, 15807.525774226791, 15869.127198003758, 32572.0, 33464.0, 34025.319493610485, 34625.30749385049, 35949.28101437904, 40582.79708601438, 44790.77604611956, 45004.19983200766, 45113.32330014987, 45308.54691453043, 7892.329152022143, 8105.473144245605, 8113.5131892086665, 8277.255047045554, 8438.367122465963, 8774.378774378723, 11601.477933492844, 11930.701732456759, 12711.364431778558, 13024.54414095502, 8006.967774045042, 8760.25537829266, 9869.0, 10737.087347575543, 10897.0, 6363.809085727436, 8155.306798922158, 10364.948175259075, 10405.479726013518, 10745.086667633339, 10913.18151138652, 11041.282316649393, 11174.329540227613, 11194.776104477702, 11275.718107047389, 7756.603811314018, 7818.804529886798, 8057.677692892219, 8269.669213231644, 8274.420790544604, 10416.531256093645, 10488.895111049098, 10511.369317840954, 10545.630902918669, 10607.734806629896], "unit": "score", "name": "jquery.html", "value": 8187.940689045145}, {"lowerIsBetter": false, "replicates": [1311.1608570514877, 1408.1973275233115, 1416.7803990381492, 1577.6055986003498, 1786.3122697761366, 7281.0, 7434.256574342563, 7438.590877501742, 7441.9255807441905, 7452.6273686315735, 7290.380317673004, 7371.299726525972, 7393.297636724516, 7420.406367490601, 7442.776716698494, 1881.4073566826473, 1919.078842155766, 2202.3503066595313, 2219.456233222859, 2258.8870556472193, 2200.6038912995655, 2201.933941981735, 2203.911843526265, 2206.3822129803602, 2207.580559693661, 2060.268604645352, 2162.4485756132162, 2164.3398763377163, 2166.3392665237097, 2167.306461932182, 2198.8900554972347, 2218.8335874809454, 2227.4431392151964, 2257.537204872997, 2262.061244583496, 2212.037763572851, 2217.944551386212, 2255.0528777913314, 2257.1986944634746, 2257.887105644711, 7387.7783666490095, 7437.405007599433, 7439.442041846829, 7440.627968601549, 7446.367058800009, 4403.757793321366, 4516.0, 4530.07133537624, 4539.52335004823, 4546.590806827368, 3006.9849650751826, 3080.337727388622, 3103.7827352085365, 3123.04747052149, 3135.0908236611353, 999.3004896572428, 1010.9797804043951, 1027.0961553832578, 1044.8589440425596, 1096.4682129167347, 9929.950350248275, 9988.800223995551, 9998.550065247082, 9999.50002499872, 10007.699769006942, 3891.5330160380936, 3984.780837053932, 4055.59444055598, 4068.6948478864206, 4076.449679293317, 8188.303994160444, 8388.8741668875, 8454.196851299117, 8455.95772021136, 8470.534120623302, 3966.5835087315995, 4583.885402864955, 4626.676132670748, 4634.513376095461, 4642.535746425398, 4155.8753237402925, 4233.005243767712, 4255.553166917491, 4256.446661933991, 4266.317389217772, 3392.8642854285554, 3403.4384326585837, 3427.246005878703, 3447.3277710846646, 3449.3101379724158, 1012.6253286284121, 1022.994885025585, 1026.1534234256767, 1033.7363972187195, 1034.1209971524295, 1325.5559387605067, 1326.2970625568464, 1358.3479929633831, 1360.809486671847, 1377.9035467517378, 6938.0, 7102.786916392516, 7207.747728829466, 7218.278172182845, 7224.783256502314, 1117.2067831839322, 1121.971950701239, 1133.7449073958458, 1136.4545018391054, 1155.0759392485977, 5641.858953526113, 5664.0937450007805, 5667.971660141673, 5712.0, 5716.342620598602, 8869.423487473294, 9053.094690530894, 9271.211946984447, 9404.059594040542, 9409.341346105706, 9159.358844880795, 9192.724218273463, 9261.861072083924, 9264.629414823332, 9272.933612634499, 6983.720651173896, 7001.0, 7066.328698773608, 7080.681369338392, 7099.3965512930945, 6854.622995735083, 6893.0694356261265, 6893.241743408121, 6897.0, 6897.3447522485285, 7930.60346982637, 8027.75569786684, 8065.395095367753, 8077.555734434427, 8176.918230817616, 8114.107448180814, 8273.089960104264, 8278.958605206935, 8289.461185023196, 8402.201790829862, 5516.282883225315, 5985.581009329305, 6030.185924900083, 6328.145700330397, 6337.556371053982, 6868.072810170763, 6904.965475172592, 6923.169219693669, 6944.930550694428, 6947.201071876597, 6148.4773794227995, 6318.778842740482, 6332.11350410952, 6394.328595497592, 6454.031895215755, 6111.327753946974, 6155.0, 6172.722227499863, 6245.313015568375, 6284.057391391328, 6471.546991710535, 6482.740690372332, 6504.739810407531, 6637.0, 6671.299513551007, 6033.306169790355, 6051.4553690168095, 6105.236845394325, 6106.1146133811235, 6115.541334400027, 6165.660888651168, 6183.443490085914, 6189.1025801257665, 6212.968935155295, 6218.53360997936], "unit": "score", "name": "mootools.html", "value": 4306.911396952593}, {"lowerIsBetter": false, "replicates": [310.09143210393546, 314.3665513989312, 320.4472285307844, 334.3647070565923, 339.39926330395184, 5943.791967281146, 5967.582269241155, 5969.820905372835, 5976.701164941752, 5981.5214782817375, 5909.261342332208, 5921.496672782808, 5927.496162826154, 5931.317898441681, 5936.732847021884, 4359.716618419792, 4493.820247190125, 4590.5638964298505, 4637.791299391519, 4648.116857797025, 4586.7477288749105, 4611.1930412177735, 4612.677112602119, 4613.8154473821005, 4642.698224615389, 4597.057603191354, 4603.8158473661015, 4607.9308810367875, 4608.769561521911, 4611.077784443125, 4359.69482136249, 4469.418975533176, 4545.159145558082, 4558.430196225472, 4571.131485017836, 4014.8193331300163, 4020.1356708307853, 4021.537523184842, 4027.6375126238486, 4035.757854528738, 5564.888702225933, 5633.0, 5644.153376993484, 5649.745761440745, 5649.8587535311535, 5323.813666521653, 5338.519533242027, 5341.0653135701095, 5346.03771321162, 5349.786008559653, 6257.624542527417, 6259.624422534663, 6264.937350626481, 6272.8118156455375, 6277.121203031579, 4386.8025938832825, 4465.59809617136, 4510.774461276956, 4521.073179998092, 4526.366308716782, 6491.285958544557, 6532.869342613121, 6565.507586930999, 6567.080608714784, 6576.980568011966, 4604.102200071021, 4604.654650901196, 4609.953900460952, 4610.631149508098, 4614.2617181250835, 4670.299455081765, 4676.2985552166765, 4677.859664210079, 4680.391549098664, 4681.789319480631, 5313.54834839043, 5323.148296272578, 5324.840254792362, 5329.440408757102, 5329.467053294717, 6158.876822463615, 6318.083877837687, 6321.209848768904, 6323.20959880015, 6340.809775706736, 1628.1940439482532, 1652.2482270566863, 1656.180190805535, 1658.0, 1661.1279078483892, 1010.5705075343096, 1084.7233955341337, 1104.9005589496824, 1105.7346236903086, 1146.8451759012426, 5929.080992446177, 5969.343372229051, 5971.462568368867, 5995.700214989233, 5997.490213331828, 6385.201849768779, 6441.452476539453, 6450.0, 6451.677416129269, 6459.709313080829, 5963.403659634002, 5965.284165900033, 5972.074328479092, 5972.910406343908, 5976.910346344808, 3446.9827650861585, 3481.89554313371, 3488.1977145256733, 3493.406120959443, 3496.2133519957806, 6540.771073012422, 6749.3250674932115, 6757.662116894136, 6761.98570214462, 6765.830854228585, 6563.737450502022, 6580.473562115019, 6581.2102547694585, 6592.17597800275, 6595.637239951753, 6699.196096468358, 6728.932710672831, 6730.057791909235, 6730.663466826639, 6738.292479289604, 6417.1657684500715, 6418.935810641834, 6429.357064293533, 6433.839154021187, 6437.7103030362805, 6154.907676384947, 6304.936950630435, 6343.52423568225, 6359.777407790705, 6361.363863613602, 6684.4652427804685, 6704.094947182263, 6717.865642687021, 6724.159480064992, 6724.93275067243, 4582.991741816795, 4588.2888152336445, 4588.426446694163, 4590.517995610413, 4595.977020114878, 6383.744650213939, 6386.201724784402, 6393.328700486568, 6398.200224971879, 6398.616083035033, 6083.178770865877, 6225.097360882737, 6231.4391704746795, 6242.937570624235, 6244.656543889948, 6210.5031597473, 6225.906611400742, 6239.719212635533, 6243.594166379353, 6256.655883926428, 6124.203853499017, 6125.418085281891, 6130.264368275657, 6140.7104508052025, 6142.078688196628, 6236.314005459487, 6259.405356491126, 6259.499240060693, 6260.843478913063, 6265.780697675559, 5952.494038006818, 6045.093236014457, 6126.969365153146, 6152.477039451518, 6191.133241346305], "unit": "score", "name": "prototype.html", "value": 4759.92297452912}, {"lowerIsBetter": false, "replicates": [759.4266328921664, 761.2007392238148, 766.2873527619312, 769.2230846844689, 773.0838955837332, 13487.59537213884, 13792.172469651829, 13798.517051903185, 13809.102408343451, 13814.723705525883, 12364.258144511314, 12407.06946978978, 12424.503019879217, 12440.004799616032, 12485.375731213448, 643.9001954697006, 801.6032064128265, 803.6182813163759, 813.8982627171604, 817.4931542443693, 814.5967745965755, 815.351795322717, 818.4925346285281, 818.9959050204741, 819.2749416766145, 854.6196942360652, 857.3141486810558, 861.9741407757778, 862.5557837713583, 863.6502216602255, 675.4258879952026, 839.5088873009297, 847.0216899481109, 847.6651722569612, 847.8007668197938, 618.1839971237923, 620.5966122020723, 625.2996643758974, 625.4183609243447, 626.3266987987886, 12334.259944403364, 12408.317542535156, 12444.315562644051, 12517.687057823536, 12535.0, 12271.631851044483, 12496.375181240901, 12573.559925402658, 12659.746805063847, 12745.0, 10439.582416703322, 10462.686119416354, 10476.738081547946, 10583.10043646291, 10749.570017199303, 3505.1061979195397, 3516.525269088666, 3576.409892367756, 3577.5349204603494, 3650.817459127033, 50691.0, 51239.487605123846, 51351.0, 51353.48646513525, 51419.228711569354, 10024.348417352849, 10047.346922450017, 10147.819843018764, 10155.086042256085, 10189.0, 17627.911860440614, 17715.73426398605, 17734.0, 17737.935723856608, 17746.29014839418, 6947.131608548932, 6960.477964152708, 7020.1575810901995, 7045.11936007999, 7302.817429564303, 3951.9012024699614, 3955.426463162883, 3983.322835118037, 4012.8996775080855, 4025.1144748155357, 3116.2209447638093, 3125.3749250150063, 3139.607549056368, 3141.7800753947463, 3148.165736079941, 533.0697932108495, 558.1488230448517, 564.7091747749912, 564.9152627105885, 566.7789562070795, 600.3876046432614, 634.0805831544279, 642.8489305013318, 656.0723859925549, 664.6344510519292, 7829.217078292125, 8079.919200807916, 8163.877541836877, 8196.057453392817, 8261.752147435587, 546.1943633141165, 546.5600191845602, 623.0965100604142, 676.4486943141324, 680.792358330704, 3626.658136489516, 3720.5907350191455, 3910.335243008695, 4087.2438598859308, 4156.231097247019, 56768.71615641978, 56776.0, 57294.42705572974, 57490.712546437, 57792.0, 45854.31218531725, 46124.76937615291, 47313.0, 48272.27591586129, 48964.75517622389, 46420.535794642296, 46645.30032049522, 48074.27888581674, 48268.27597586039, 48315.51684483181, 8181.6318265677, 8316.584170791315, 8335.541545214828, 8360.581970901309, 8431.241188293083, 35003.47494787529, 35096.0, 35798.28403431969, 36273.637263627024, 36323.27353452969, 39647.0, 39862.800685996386, 40398.59601403948, 40487.1902561953, 42475.3628695576, 10018.3488073275, 10330.483475826028, 10365.0, 10377.636782712569, 10394.636187733393, 11031.096072941891, 11070.889291106985, 11191.384473854016, 11208.66374008781, 11401.942990284995, 9664.235035475336, 10001.0, 10164.390136591828, 10195.894498388265, 10260.538275777459, 10080.495975201356, 10289.691309260734, 10453.790924181321, 10745.817960024548, 10791.946040269748, 9815.312928094965, 9931.354461959949, 10288.845667314847, 10482.580696772044, 10521.105706014769, 8346.62440190205, 8378.0, 8500.192481714228, 8629.352798540009, 8794.472331660121, 8209.0, 8418.663253470038, 8493.150684931705, 8552.828943421222, 9007.954960225157], "unit": "score", "name": "yui.html", "value": 6081.428251160892}], "name": "dromaeo_css", "value": 6741.842379401424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 111.0, 113.0, 111.0, 100.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 152.0, 163.0, 127.0, 154.0, 149.0, 134.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 167.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 97.0, 98.0, 72.0, 73.0, 73.0, 108.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 143.0, 97.0, 97.0, 97.0, 140.0, 97.0, 106.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 56.0, 55.0, 57.0, 56.0, 64.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 70.0, 69.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [87.0, 82.0, 83.0, 91.0, 83.0, 84.0, 85.0, 85.0, 90.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [126.0, 115.0, 116.0, 116.0, 114.0, 136.0, 126.0, 118.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [165.0, 144.0, 153.0, 164.0, 153.0, 143.0, 155.0, 146.0, 162.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.6}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 69.0, 71.0, 70.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1521.3999999999996}]} 14:38:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1521.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6741.84"}}} 14:38:16 INFO - Return code: 0 14:38:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:38:17 INFO - # TBPL SUCCESS # 14:38:17 INFO - Running post-action listener: _resource_record_post_action 14:38:17 INFO - Running post-run listener: _resource_record_post_run 14:38:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 543494144; Read time: 0; Write time: 646408 14:38:18 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251006976; Read time: 0; Write time: 351036 14:38:18 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 292487168; Read time: 0; Write time: 295372 14:38:18 INFO - Running post-run listener: _upload_blobber_files 14:38:18 INFO - Blob upload gear active. 14:38:18 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:38:18 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 14:38:18 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'] 14:38:18 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 14:38:18 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:19 INFO - (blobuploader) - INFO - Done attempting. 14:38:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:20 INFO - (blobuploader) - INFO - Done attempting. 14:38:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:20 INFO - Return code: 0 14:38:20 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:38:20 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8435fa76c0890caa087594917a12454877f57c95fc79b5632d3cc089a734351eee685a6066645be11554a2a26a2a78b233d4bbd7da0c5cf852cbb5eb7c548348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28f67c2dbc7ac313ed86b07f6e53d8e72f548098f88a29a6a7fdbd3f5c4febfa344e2ca63c6664248c78c4a918bc472cd9ef7595aa94202ab9307ac7b55fa5db"} 14:38:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:38:20 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:38:20 INFO - Contents: 14:38:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8435fa76c0890caa087594917a12454877f57c95fc79b5632d3cc089a734351eee685a6066645be11554a2a26a2a78b233d4bbd7da0c5cf852cbb5eb7c548348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28f67c2dbc7ac313ed86b07f6e53d8e72f548098f88a29a6a7fdbd3f5c4febfa344e2ca63c6664248c78c4a918bc472cd9ef7595aa94202ab9307ac7b55fa5db"} 14:38:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:20 INFO - Copying logs to upload dir... 14:38:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 14:38:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.158664 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-02-22 14:38:20.429561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 14:38:20.432698) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 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/8435fa76c0890caa087594917a12454877f57c95fc79b5632d3cc089a734351eee685a6066645be11554a2a26a2a78b233d4bbd7da0c5cf852cbb5eb7c548348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28f67c2dbc7ac313ed86b07f6e53d8e72f548098f88a29a6a7fdbd3f5c4febfa344e2ca63c6664248c78c4a918bc472cd9ef7595aa94202ab9307ac7b55fa5db"} build_url:https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/YbEfJky_T6ufF0H7OEPNYw/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/8435fa76c0890caa087594917a12454877f57c95fc79b5632d3cc089a734351eee685a6066645be11554a2a26a2a78b233d4bbd7da0c5cf852cbb5eb7c548348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/28f67c2dbc7ac313ed86b07f6e53d8e72f548098f88a29a6a7fdbd3f5c4febfa344e2ca63c6664248c78c4a918bc472cd9ef7595aa94202ab9307ac7b55fa5db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 14:38:20.457496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:38:20.457831) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1456179460.923642-1168809955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 14:38:20.540989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 14:38:20.541317) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 14:38:20.541614) ========= ========= Total master_lag: 0.30 =========