builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1456541050.87 results: success (0) buildid: 20160226163041 builduid: 084ed894a4844740ac33cf82506a9412 revision: 2d8118073de1024df419bb3879e7a7e0e2427aea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.870168) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.871214) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.871785) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009112 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.896186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.896500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.920691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.921318) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.974139) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.974829) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.975716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:10.976463) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 18:44:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.7M=0s 2016-02-26 18:44:11 (84.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.154446) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.155186) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014017 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.214800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.215146) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 2d8118073de1024df419bb3879e7a7e0e2427aea --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/mozilla-inbound --rev 2d8118073de1024df419bb3879e7a7e0e2427aea --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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 18:44:11,457 truncating revision to first 12 chars 2016-02-26 18:44:11,457 Setting DEBUG logging. 2016-02-26 18:44:11,457 attempt 1/10 2016-02-26 18:44:11,457 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/2d8118073de1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 18:44:11,761 unpacking tar archive at: mozilla-inbound-2d8118073de1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.842725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.843506) ========= echo 2d8118073de1024df419bb3879e7a7e0e2427aea in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2d8118073de1024df419bb3879e7a7e0e2427aea'] 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2d8118073de1024df419bb3879e7a7e0e2427aea program finished with exit code 0 elapsedTime=0.004581 script_repo_revision: '2d8118073de1024df419bb3879e7a7e0e2427aea' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.898329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.898656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 18:44:11.909491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2016-02-26 18:44:11.910106) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:44:12 INFO - MultiFileLogger online at 20160226 18:44:12 in /builds/slave/test-pgo 18:44:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:44:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:44:12 INFO - {'append_to_log': False, 18:44:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:44:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:44:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:44:12 INFO - 'branch': 'Mozilla-Inbound', 18:44:12 INFO - 'buildbot_json_path': 'buildprops.json', 18:44:12 INFO - 'config_files': ('talos/linux_config.py',), 18:44:12 INFO - 'default_actions': ('clobber', 18:44:12 INFO - 'read-buildbot-config', 18:44:12 INFO - 'download-and-extract', 18:44:12 INFO - 'populate-webroot', 18:44:12 INFO - 'create-virtualenv', 18:44:12 INFO - 'install', 18:44:12 INFO - 'run-tests'), 18:44:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:44:12 INFO - 'download_minidump_stackwalk': True, 18:44:12 INFO - 'download_symbols': 'ondemand', 18:44:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:44:12 INFO - 'tooltool.py': '/tools/tooltool.py', 18:44:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:44:12 INFO - '/tools/misc-python/virtualenv.py')}, 18:44:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:44:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:44:12 INFO - 'installer_path': 'installer.exe', 18:44:12 INFO - 'log_level': 'info', 18:44:12 INFO - 'log_name': 'talos', 18:44:12 INFO - 'log_to_console': True, 18:44:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:44:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:44:12 INFO - 'opt_config_files': (), 18:44:12 INFO - 'pip_index': False, 18:44:12 INFO - 'sps_profile': False, 18:44:12 INFO - 'sps_profile_interval': 0, 18:44:12 INFO - 'suite': 'dromaeojs', 18:44:12 INFO - 'system_bits': '32', 18:44:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:44:12 INFO - 'title': 'talos-linux64-ix-020', 18:44:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:44:12 INFO - 'use_talos_json': True, 18:44:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:44:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:44:12 INFO - 'work_dir': 'build'} 18:44:12 INFO - ##### 18:44:12 INFO - ##### Running clobber step. 18:44:12 INFO - ##### 18:44:12 INFO - Running pre-action listener: _resource_record_pre_action 18:44:12 INFO - Running main action method: clobber 18:44:12 INFO - rmtree: /builds/slave/test-pgo/build 18:44:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:44:13 INFO - Running post-action listener: _resource_record_post_action 18:44:13 INFO - ##### 18:44:13 INFO - ##### Running read-buildbot-config step. 18:44:13 INFO - ##### 18:44:13 INFO - Running pre-action listener: _resource_record_pre_action 18:44:13 INFO - Running main action method: read_buildbot_config 18:44:13 INFO - Using buildbot properties: 18:44:13 INFO - { 18:44:13 INFO - "project": "", 18:44:13 INFO - "product": "firefox", 18:44:13 INFO - "script_repo_revision": "production", 18:44:13 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:44:13 INFO - "repository": "", 18:44:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:44:13 INFO - "buildid": "20160226163041", 18:44:13 INFO - "pgo_build": "True", 18:44:13 INFO - "basedir": "/builds/slave/test-pgo", 18:44:13 INFO - "buildnumber": 1542, 18:44:13 INFO - "slavename": "talos-linux64-ix-020", 18:44:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:44:13 INFO - "platform": "ubuntu64_hw", 18:44:13 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:44:13 INFO - "branch": "mozilla-inbound", 18:44:13 INFO - "repo_path": "integration/mozilla-inbound", 18:44:13 INFO - "revision": "2d8118073de1024df419bb3879e7a7e0e2427aea", 18:44:13 INFO - "stage_platform": "linux64-pgo", 18:44:13 INFO - "builduid": "084ed894a4844740ac33cf82506a9412", 18:44:13 INFO - "slavebuilddir": "test" 18:44:13 INFO - } 18:44:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 18:44:13 INFO - Running post-action listener: _resource_record_post_action 18:44:13 INFO - ##### 18:44:13 INFO - ##### Running download-and-extract step. 18:44:13 INFO - ##### 18:44:13 INFO - Running pre-action listener: _resource_record_pre_action 18:44:13 INFO - Running main action method: download_and_extract 18:44:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:44:13 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')]} 18:44:13 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:44:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json 18:44:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json 18:44:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:44:13 INFO - Downloaded 1448 bytes. 18:44:13 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:44:13 INFO - Using the following test package requirements: 18:44:13 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:44:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:44:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'jsshell-linux-x86_64.zip'], 18:44:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:44:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:44:13 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:44:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:44:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 18:44:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 18:44:13 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:44:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:44:13 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')]} 18:44:13 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:15 INFO - Downloaded 23370843 bytes. 18:44:15 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'] 18:44:15 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 18:44:17 INFO - Return code: 0 18:44:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:17 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 18:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:18 INFO - Downloaded 23370843 bytes. 18:44:18 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'] 18:44:18 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 18:44:19 INFO - Return code: 0 18:44: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')]} 18:44:19 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 18:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:21 INFO - Downloaded 10713410 bytes. 18:44:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:44:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:44:21 INFO - Return code: 0 18:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:21 INFO - https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:44:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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 18:44:23 INFO - Downloaded 56628352 bytes. 18:44:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:23 INFO - mkdir: /builds/slave/test-pgo/properties 18:44:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:44:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:44:23 INFO - Contents: 18:44:23 INFO - build_url:https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 18:44:24 INFO - Running post-action listener: _resource_record_post_action 18:44:24 INFO - Running post-action listener: set_extra_try_arguments 18:44:24 INFO - ##### 18:44:24 INFO - ##### Running populate-webroot step. 18:44:24 INFO - ##### 18:44:24 INFO - Running pre-action listener: _resource_record_pre_action 18:44:24 INFO - Running main action method: populate_webroot 18:44:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:44:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:44:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:44:24 INFO - '--tppagecycles', 18:44:24 INFO - '7'], 18:44:24 INFO - 'tests': ['tsvgm']}}, 18:44:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:44:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:44:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:44:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:44:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:44:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'tests': ['damp', 'tps']}, 18:44:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['damp', 'tps']}, 18:44:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:44:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:44:24 INFO - 'other': {'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'other_l64': {'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'other_nol64': {'tests': ['a11yr', 18:44:24 INFO - 'ts_paint', 18:44:24 INFO - 'tpaint', 18:44:24 INFO - 'sessionrestore', 18:44:24 INFO - 'sessionrestore_no_auto_restore']}, 18:44:24 INFO - 'svgr': {'tests': ['tsvgx', 18:44:24 INFO - 'tsvgr_opacity', 18:44:24 INFO - 'tart', 18:44:24 INFO - 'tscrollx', 18:44:24 INFO - 'cart']}, 18:44:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['tsvgx', 18:44:24 INFO - 'tsvgr_opacity', 18:44:24 INFO - 'tart', 18:44:24 INFO - 'tscrollx', 18:44:24 INFO - 'cart']}, 18:44:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'tests': ['tp5o']}, 18:44:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'talos_options': ['--e10s'], 18:44:24 INFO - 'tests': ['tp5o']}, 18:44:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'talos_options': ['--xperf_path', 18:44:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:24 INFO - 'tests': ['tp5n']}, 18:44:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:44:24 INFO - 'talos_options': ['--e10s', 18:44:24 INFO - '--xperf_path', 18:44:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:44:24 INFO - 'tests': ['tp5n']}}, 18:44:24 INFO - 'talos.zip': {'path': '', 18:44:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:44:24 INFO - Running post-action listener: _resource_record_post_action 18:44:24 INFO - ##### 18:44:24 INFO - ##### Running create-virtualenv step. 18:44:24 INFO - ##### 18:44:24 INFO - Running pre-action listener: _resource_record_pre_action 18:44:24 INFO - Running main action method: create_virtualenv 18:44:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:44:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:44:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:44:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:44:24 INFO - Using real prefix '/usr' 18:44:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:44:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:44:27 INFO - Installing pip.................done. 18:44:27 INFO - Return code: 0 18:44:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:44:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:44:27 INFO - Using env: {'DISPLAY': ':0', 18:44:27 INFO - 'HOME': '/home/cltbld', 18:44:27 INFO - 'LANG': 'en_US.UTF-8', 18:44:27 INFO - 'LANGUAGE': 'en_US:en', 18:44:27 INFO - 'LOGNAME': 'cltbld', 18:44:27 INFO - 'MAIL': '/var/mail/cltbld', 18:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:27 INFO - 'MOZ_NO_REMOTE': '1', 18:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:27 INFO - 'NO_EM_RESTART': '1', 18:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:27 INFO - 'SHELL': '/bin/bash', 18:44:27 INFO - 'SHLVL': '1', 18:44:27 INFO - 'TERM': 'linux', 18:44:27 INFO - 'TMOUT': '86400', 18:44:27 INFO - 'USER': 'cltbld', 18:44:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:27 INFO - '_': '/tools/buildbot/bin/python'} 18:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:44:27 INFO - Cleaning up... 18:44:27 INFO - Return code: 0 18:44:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:44:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:44:27 INFO - Using env: {'DISPLAY': ':0', 18:44:27 INFO - 'HOME': '/home/cltbld', 18:44:27 INFO - 'LANG': 'en_US.UTF-8', 18:44:27 INFO - 'LANGUAGE': 'en_US:en', 18:44:27 INFO - 'LOGNAME': 'cltbld', 18:44:27 INFO - 'MAIL': '/var/mail/cltbld', 18:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:27 INFO - 'MOZ_NO_REMOTE': '1', 18:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:27 INFO - 'NO_EM_RESTART': '1', 18:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:27 INFO - 'SHELL': '/bin/bash', 18:44:27 INFO - 'SHLVL': '1', 18:44:27 INFO - 'TERM': 'linux', 18:44:27 INFO - 'TMOUT': '86400', 18:44:27 INFO - 'USER': 'cltbld', 18:44:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:27 INFO - '_': '/tools/buildbot/bin/python'} 18:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:27 INFO - Downloading/unpacking psutil>=0.7.1 18:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:29 INFO - Installing collected packages: psutil 18:44:29 INFO - Running setup.py install for psutil 18:44:29 INFO - building 'psutil._psutil_linux' extension 18:44:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:44:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:44:29 INFO - building 'psutil._psutil_posix' extension 18:44:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:44:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:29 INFO - Successfully installed psutil 18:44:29 INFO - Cleaning up... 18:44:30 INFO - Return code: 0 18:44:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:44:30 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')]} 18:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:30 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')]} 18:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:30 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 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:30 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 18:44:30 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 18:44:30 INFO - Using env: {'DISPLAY': ':0', 18:44:30 INFO - 'HOME': '/home/cltbld', 18:44:30 INFO - 'LANG': 'en_US.UTF-8', 18:44:30 INFO - 'LANGUAGE': 'en_US:en', 18:44:30 INFO - 'LOGNAME': 'cltbld', 18:44:30 INFO - 'MAIL': '/var/mail/cltbld', 18:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:30 INFO - 'MOZ_NO_REMOTE': '1', 18:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:30 INFO - 'NO_EM_RESTART': '1', 18:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:30 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:30 INFO - 'SHELL': '/bin/bash', 18:44:30 INFO - 'SHLVL': '1', 18:44:30 INFO - 'TERM': 'linux', 18:44:30 INFO - 'TMOUT': '86400', 18:44:30 INFO - 'USER': 'cltbld', 18:44:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:30 INFO - '_': '/tools/buildbot/bin/python'} 18:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:32 INFO - Installing collected packages: mozsystemmonitor 18:44:32 INFO - Running setup.py install for mozsystemmonitor 18:44:32 INFO - Successfully installed mozsystemmonitor 18:44:32 INFO - Cleaning up... 18:44:32 INFO - Return code: 0 18:44:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:44:32 INFO - Using env: {'DISPLAY': ':0', 18:44:32 INFO - 'HOME': '/home/cltbld', 18:44:32 INFO - 'LANG': 'en_US.UTF-8', 18:44:32 INFO - 'LANGUAGE': 'en_US:en', 18:44:32 INFO - 'LOGNAME': 'cltbld', 18:44:32 INFO - 'MAIL': '/var/mail/cltbld', 18:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:32 INFO - 'MOZ_NO_REMOTE': '1', 18:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:32 INFO - 'NO_EM_RESTART': '1', 18:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:32 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:32 INFO - 'SHELL': '/bin/bash', 18:44:32 INFO - 'SHLVL': '1', 18:44:32 INFO - 'TERM': 'linux', 18:44:32 INFO - 'TMOUT': '86400', 18:44:32 INFO - 'USER': 'cltbld', 18:44:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:32 INFO - '_': '/tools/buildbot/bin/python'} 18:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:32 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:44:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:34 INFO - Downloading docopt-0.6.1.tar.gz 18:44:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:34 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:34 INFO - Running setup.py install for blobuploader 18:44:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:44:35 INFO - Running setup.py install for requests 18:44:35 INFO - Running setup.py install for docopt 18:44:35 INFO - Successfully installed blobuploader requests docopt 18:44:35 INFO - Cleaning up... 18:44:35 INFO - Return code: 0 18:44:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:44:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:44:35 INFO - Using env: {'DISPLAY': ':0', 18:44:35 INFO - 'HOME': '/home/cltbld', 18:44:35 INFO - 'LANG': 'en_US.UTF-8', 18:44:35 INFO - 'LANGUAGE': 'en_US:en', 18:44:35 INFO - 'LOGNAME': 'cltbld', 18:44:35 INFO - 'MAIL': '/var/mail/cltbld', 18:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:35 INFO - 'MOZ_NO_REMOTE': '1', 18:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:35 INFO - 'NO_EM_RESTART': '1', 18:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:35 INFO - 'SHELL': '/bin/bash', 18:44:35 INFO - 'SHLVL': '1', 18:44:35 INFO - 'TERM': 'linux', 18:44:35 INFO - 'TMOUT': '86400', 18:44:35 INFO - 'USER': 'cltbld', 18:44:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:35 INFO - '_': '/tools/buildbot/bin/python'} 18:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:35 INFO - Running setup.py (path:/tmp/pip-ENY6U0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:35 INFO - Running setup.py (path:/tmp/pip-VuiIc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:35 INFO - Running setup.py (path:/tmp/pip-bZqxc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:36 INFO - Running setup.py (path:/tmp/pip-WrWy9N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:36 INFO - Running setup.py (path:/tmp/pip-hziR6N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:36 INFO - Running setup.py (path:/tmp/pip-MyPayt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:36 INFO - Running setup.py (path:/tmp/pip-EerS5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:36 INFO - Running setup.py (path:/tmp/pip-iE_uQk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:36 INFO - Running setup.py (path:/tmp/pip-Uebnw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:36 INFO - Running setup.py (path:/tmp/pip-145EWY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:36 INFO - Running setup.py (path:/tmp/pip-2n_zY0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:36 INFO - Running setup.py (path:/tmp/pip-4OyOnj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:36 INFO - Running setup.py (path:/tmp/pip-04pvxe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:36 INFO - Running setup.py (path:/tmp/pip-YxYriG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:36 INFO - Running setup.py (path:/tmp/pip-ewnXuo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:36 INFO - Running setup.py (path:/tmp/pip-7IgLri-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:36 INFO - Running setup.py (path:/tmp/pip-7k0_rm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:37 INFO - Running setup.py install for manifestparser 18:44:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Running setup.py install for mozcrash 18:44:37 INFO - Running setup.py install for mozdebug 18:44:37 INFO - Running setup.py install for mozdevice 18:44:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Running setup.py install for mozfile 18:44:37 INFO - Running setup.py install for mozhttpd 18:44:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Running setup.py install for mozinfo 18:44:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Running setup.py install for mozInstall 18:44:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:44:37 INFO - Running setup.py install for mozleak 18:44:37 INFO - Running setup.py install for mozlog 18:44:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for moznetwork 18:44:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for mozprocess 18:44:38 INFO - Running setup.py install for mozprofile 18:44:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for mozrunner 18:44:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Running setup.py install for mozscreenshot 18:44:38 INFO - Running setup.py install for moztest 18:44:38 INFO - Running setup.py install for mozversion 18:44:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:44:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:38 INFO - Cleaning up... 18:44:38 INFO - Return code: 0 18:44:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:44:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:44:38 INFO - Using env: {'DISPLAY': ':0', 18:44:38 INFO - 'HOME': '/home/cltbld', 18:44:38 INFO - 'LANG': 'en_US.UTF-8', 18:44:38 INFO - 'LANGUAGE': 'en_US:en', 18:44:38 INFO - 'LOGNAME': 'cltbld', 18:44:38 INFO - 'MAIL': '/var/mail/cltbld', 18:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:38 INFO - 'MOZ_NO_REMOTE': '1', 18:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:38 INFO - 'NO_EM_RESTART': '1', 18:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:38 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:38 INFO - 'SHELL': '/bin/bash', 18:44:38 INFO - 'SHLVL': '1', 18:44:38 INFO - 'TERM': 'linux', 18:44:38 INFO - 'TMOUT': '86400', 18:44:38 INFO - 'USER': 'cltbld', 18:44:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:38 INFO - '_': '/tools/buildbot/bin/python'} 18:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:39 INFO - Running setup.py (path:/tmp/pip-G_sIjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:39 INFO - Running setup.py (path:/tmp/pip-Jn_YYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:39 INFO - Running setup.py (path:/tmp/pip-4cr3f9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:39 INFO - Running setup.py (path:/tmp/pip-zV0m7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:39 INFO - Running setup.py (path:/tmp/pip-ruCu0U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:39 INFO - Running setup.py (path:/tmp/pip-wEjO_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:39 INFO - Running setup.py (path:/tmp/pip-DGrDqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:39 INFO - Running setup.py (path:/tmp/pip-k5zssc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:39 INFO - Running setup.py (path:/tmp/pip-uUa27N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:39 INFO - Running setup.py (path:/tmp/pip-9jNBjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:39 INFO - Running setup.py (path:/tmp/pip-54OLZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:39 INFO - Running setup.py (path:/tmp/pip-kgukMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:39 INFO - Running setup.py (path:/tmp/pip-JWcZ7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:44:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:39 INFO - Running setup.py (path:/tmp/pip-N5QDxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:40 INFO - Running setup.py (path:/tmp/pip-T0UkdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:40 INFO - Running setup.py (path:/tmp/pip-QT8M8s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:44:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:40 INFO - Running setup.py (path:/tmp/pip-U5JDgl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:44:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:42 INFO - Downloading blessings-1.6.tar.gz 18:44:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:42 INFO - Installing collected packages: blessings 18:44:42 INFO - Running setup.py install for blessings 18:44:42 INFO - Successfully installed blessings 18:44:42 INFO - Cleaning up... 18:44:42 INFO - Return code: 0 18:44:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:44:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:44:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:44:42 INFO - Reading from file tmpfile_stdout 18:44:42 INFO - Current package versions: 18:44:42 INFO - argparse == 1.2.1 18:44:42 INFO - blessings == 1.6 18:44:42 INFO - blobuploader == 1.2.4 18:44:42 INFO - docopt == 0.6.1 18:44:42 INFO - manifestparser == 1.1 18:44:42 INFO - mozInstall == 1.12 18:44:42 INFO - mozcrash == 0.16 18:44:42 INFO - mozdebug == 0.1 18:44:42 INFO - mozdevice == 0.48 18:44:42 INFO - mozfile == 1.2 18:44:42 INFO - mozhttpd == 0.7 18:44:42 INFO - mozinfo == 0.9 18:44:42 INFO - mozleak == 0.1 18:44:42 INFO - mozlog == 3.1 18:44:42 INFO - moznetwork == 0.27 18:44:42 INFO - mozprocess == 0.22 18:44:42 INFO - mozprofile == 0.28 18:44:42 INFO - mozrunner == 6.11 18:44:42 INFO - mozscreenshot == 0.1 18:44:42 INFO - mozsystemmonitor == 0.0 18:44:42 INFO - moztest == 0.7 18:44:42 INFO - mozversion == 1.4 18:44:42 INFO - psutil == 3.1.1 18:44:42 INFO - requests == 1.2.3 18:44:42 INFO - wsgiref == 0.1.2 18:44:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:44:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:44:42 INFO - Using env: {'DISPLAY': ':0', 18:44:42 INFO - 'HOME': '/home/cltbld', 18:44:42 INFO - 'LANG': 'en_US.UTF-8', 18:44:42 INFO - 'LANGUAGE': 'en_US:en', 18:44:42 INFO - 'LOGNAME': 'cltbld', 18:44:42 INFO - 'MAIL': '/var/mail/cltbld', 18:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:42 INFO - 'MOZ_NO_REMOTE': '1', 18:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:42 INFO - 'NO_EM_RESTART': '1', 18:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:42 INFO - 'SHELL': '/bin/bash', 18:44:42 INFO - 'SHLVL': '1', 18:44:42 INFO - 'TERM': 'linux', 18:44:42 INFO - 'TMOUT': '86400', 18:44:42 INFO - 'USER': 'cltbld', 18:44:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:42 INFO - '_': '/tools/buildbot/bin/python'} 18:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:44:42 INFO - Cleaning up... 18:44:42 INFO - Return code: 0 18:44:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:44:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:44:42 INFO - Using env: {'DISPLAY': ':0', 18:44:42 INFO - 'HOME': '/home/cltbld', 18:44:42 INFO - 'LANG': 'en_US.UTF-8', 18:44:42 INFO - 'LANGUAGE': 'en_US:en', 18:44:42 INFO - 'LOGNAME': 'cltbld', 18:44:42 INFO - 'MAIL': '/var/mail/cltbld', 18:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:42 INFO - 'MOZ_NO_REMOTE': '1', 18:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:42 INFO - 'NO_EM_RESTART': '1', 18:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:42 INFO - 'SHELL': '/bin/bash', 18:44:42 INFO - 'SHLVL': '1', 18:44:42 INFO - 'TERM': 'linux', 18:44:42 INFO - 'TMOUT': '86400', 18:44:42 INFO - 'USER': 'cltbld', 18:44:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:42 INFO - '_': '/tools/buildbot/bin/python'} 18:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:42 INFO - Downloading/unpacking jsonschema 18:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:44 INFO - Downloading/unpacking functools32 (from jsonschema) 18:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:44 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:45 INFO - warning: no files found matching '*.txt' 18:44:45 INFO - no previously-included directories found matching 'build' 18:44:45 INFO - no previously-included directories found matching 'dist' 18:44:45 INFO - no previously-included directories found matching '.git*' 18:44:45 INFO - Installing collected packages: jsonschema, functools32 18:44:45 INFO - Running setup.py install for functools32 18:44:45 INFO - warning: no files found matching '*.txt' 18:44:45 INFO - no previously-included directories found matching 'build' 18:44:45 INFO - no previously-included directories found matching 'dist' 18:44:45 INFO - no previously-included directories found matching '.git*' 18:44:45 INFO - Successfully installed jsonschema functools32 18:44:45 INFO - Cleaning up... 18:44:45 INFO - Return code: 0 18:44:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f00f1e7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, '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': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', '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 18:44:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:44:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:44:45 INFO - Using env: {'DISPLAY': ':0', 18:44:45 INFO - 'HOME': '/home/cltbld', 18:44:45 INFO - 'LANG': 'en_US.UTF-8', 18:44:45 INFO - 'LANGUAGE': 'en_US:en', 18:44:45 INFO - 'LOGNAME': 'cltbld', 18:44:45 INFO - 'MAIL': '/var/mail/cltbld', 18:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:45 INFO - 'MOZ_NO_REMOTE': '1', 18:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:45 INFO - 'NO_EM_RESTART': '1', 18:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:44:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:44:45 INFO - 'SHELL': '/bin/bash', 18:44:45 INFO - 'SHLVL': '1', 18:44:45 INFO - 'TERM': 'linux', 18:44:45 INFO - 'TMOUT': '86400', 18:44:45 INFO - 'USER': 'cltbld', 18:44:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:45 INFO - '_': '/tools/buildbot/bin/python'} 18:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:45 INFO - Downloading/unpacking flake8 18:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:44:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:44:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:44:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:47 INFO - no previously-included directories found matching 'docs/_build' 18:44:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:44:48 INFO - Running setup.py install for pep8 18:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:48 INFO - no previously-included directories found matching 'docs/_build' 18:44:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:44:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:44:48 INFO - Cleaning up... 18:44:48 INFO - Return code: 0 18:44:48 INFO - Running post-action listener: _resource_record_post_action 18:44:48 INFO - Running post-action listener: _start_resource_monitoring 18:44:48 INFO - Starting resource monitoring. 18:44:48 INFO - ##### 18:44:48 INFO - ##### Running install step. 18:44:48 INFO - ##### 18:44:48 INFO - Running pre-action listener: _resource_record_pre_action 18:44:48 INFO - Running main action method: install 18:44:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:44:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:44:48 INFO - Reading from file tmpfile_stdout 18:44:48 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:44:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:44:48 INFO - Reading from file tmpfile_stdout 18:44:48 INFO - Output received: 18:44:48 INFO - Usage: mozinstall [options] installer 18:44:48 INFO - Options: 18:44:48 INFO - -h, --help show this help message and exit 18:44:48 INFO - -d DEST, --destination=DEST 18:44:48 INFO - Directory to install application into. [default: 18:44:48 INFO - "/builds/slave/test-pgo"] 18:44:48 INFO - --app=APP Application being installed. [default: firefox] 18:44:48 INFO - mkdir: /builds/slave/test-pgo/build/application 18:44:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:44:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:45:05 INFO - Reading from file tmpfile_stdout 18:45:05 INFO - Output received: 18:45:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:45:05 INFO - Running post-action listener: _resource_record_post_action 18:45:05 INFO - ##### 18:45:05 INFO - ##### Running run-tests step. 18:45:05 INFO - ##### 18:45:05 INFO - Running pre-action listener: _resource_record_pre_action 18:45:05 INFO - Running main action method: run_tests 18:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:45:05 INFO - Python 2.7.3 18:45:05 INFO - Return code: 0 18:45:05 INFO - grabbing minidump binary from tooltool 18:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:45:05 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 0x14fe8c0>, '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 0x14ff7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffc50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:45:05 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 18:45:05 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 18:45:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:05 INFO - Return code: 0 18:45:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:45:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:45:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:45:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:45:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:45:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:45:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:45:06 INFO - Return code: 0 18:45:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:45:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 18:45:06 INFO - Using env: {'DISPLAY': ':0', 18:45:06 INFO - 'HOME': '/home/cltbld', 18:45:06 INFO - 'LANG': 'en_US.UTF-8', 18:45:06 INFO - 'LANGUAGE': 'en_US:en', 18:45:06 INFO - 'LOGNAME': 'cltbld', 18:45:06 INFO - 'MAIL': '/var/mail/cltbld', 18:45:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:45:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:06 INFO - 'MOZ_NO_REMOTE': '1', 18:45:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:45:06 INFO - 'NO_EM_RESTART': '1', 18:45:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:45:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:45:06 INFO - 'SHELL': '/bin/bash', 18:45:06 INFO - 'SHLVL': '1', 18:45:06 INFO - 'TERM': 'linux', 18:45:06 INFO - 'TMOUT': '86400', 18:45:06 INFO - 'USER': 'cltbld', 18:45:06 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648', 18:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:06 INFO - '_': '/tools/buildbot/bin/python'} 18:45:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 18:45:06 INFO - mozversion application_buildid: 20160226163041 18:45:06 INFO - mozversion application_changeset: 2d8118073de1024df419bb3879e7a7e0e2427aea 18:45:06 INFO - mozversion application_display_name: Nightly 18:45:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:06 INFO - mozversion application_name: Firefox 18:45:06 INFO - mozversion application_remotingname: firefox 18:45:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:45:06 INFO - mozversion application_vendor: Mozilla 18:45:06 INFO - mozversion application_version: 47.0a1 18:45:06 INFO - mozversion platform_buildid: 20160226163041 18:45:06 INFO - mozversion platform_changeset: 2d8118073de1024df419bb3879e7a7e0e2427aea 18:45:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:45:06 INFO - mozversion platform_version: 47.0a1 18:45:06 INFO - using testdate: 1456541106 18:45:06 INFO - actual date: 1456541106 18:45:07 INFO - starting webserver on 'localhost:43064' 18:45:07 INFO - SUITE-START | Running 2 tests 18:45:07 INFO - TEST-START | dromaeo_css 18:45:07 INFO - operating with platform_type : linux_ 18:45:07 INFO - Initialising browser for dromaeo_css test... 18:45:07 INFO - TEST-INFO | started process 21388 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUQkBym/profile http://localhost:43064/getInfo.html) 18:45:11 INFO - PROCESS | 21388 | __metrics Screen width/height:1600/1200 18:45:11 INFO - PROCESS | 21388 | colorDepth:24 18:45:11 INFO - PROCESS | 21388 | Browser inner width/height: 1024/697 18:45:11 INFO - PROCESS | 21388 | __metrics 18:45:12 INFO - PROCESS | 21388 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 18:45:12 INFO - PROCESS | 21388 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:45:13 INFO - TEST-INFO | 21388: exit 0 18:45:13 INFO - Browser initialized. 18:45:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:13 INFO - TEST-INFO | started process 21482 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUQkBym/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:25 INFO - PROCESS | 21482 | RSS: Main: 151265280 18:45:25 INFO - PROCESS | 21482 | 18:46:16 INFO - PROCESS | 21482 | 1456541176673 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] 18:48:24 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43064/tests/dromaeo/cssquery-ext.html) 18:48:25 INFO - PROCESS | 21482 | RSS: Main: 249839616 18:48:25 INFO - PROCESS | 21482 | 18:51:27 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-ext.html (next: http://localhost:43064/tests/dromaeo/cssquery-jquery.html) 18:51:28 INFO - PROCESS | 21482 | RSS: Main: 237654016 18:51:28 INFO - PROCESS | 21482 | 18:54:29 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43064/tests/dromaeo/cssquery-mootools.html) 18:54:30 INFO - PROCESS | 21482 | RSS: Main: 228028416 18:54:30 INFO - PROCESS | 21482 | 18:57:32 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43064/tests/dromaeo/cssquery-prototype.html) 18:57:33 INFO - PROCESS | 21482 | RSS: Main: 216526848 18:57:33 INFO - PROCESS | 21482 | 19:00:35 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43064/tests/dromaeo/cssquery-yui.html) 19:00:36 INFO - PROCESS | 21482 | RSS: Main: 217444352 19:00:36 INFO - PROCESS | 21482 | 19:03:38 INFO - PROCESS | 21482 | Cycle 1(1): loaded http://localhost:43064/tests/dromaeo/cssquery-yui.html (next: http://localhost:43064/tests/dromaeo/cssquery-dojo.html) 19:03:39 INFO - PROCESS | 21482 | RSS: Main: 294367232 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | __start_tp_report 19:03:39 INFO - PROCESS | 21482 | _x_x_mozilla_page_load 19:03:39 INFO - PROCESS | 21482 | _x_x_mozilla_page_load_details 19:03:39 INFO - PROCESS | 21482 | |i|pagename|runs| 19:03:39 INFO - PROCESS | 21482 | |0;dojo.html;3052.511598144297;3123.968760312396;3140.7644426668007;3166.3034132490857;3199.456092464281;4991.276264941581;5003.524665156809;5069.087564238435;5071.923921141186;5100.642954993152;4997.125503036963;5013.14776487997;5021.17150670139;5079.111155547774;5101.642884998052;4552.408186935694;4553.658475614326;4564.452265728118;4628.606568441686;4777.04459108178;4552.271636538155;4682.0635872825405;4690.7654617269;4707.05858828234;4763.118823017736;4590.104929538741;4590.242609969351;4603.631709463251;4637.86086417408;4675.135100006492;4487.19230538503;4513.616342610882;4517.909641807146;4542.772861356919;4576.130535198335;4453.532379100213;4481.148581769486;4485.573870482299;4501.4598248210095;4568.840090596813;4787.234042553175;4799.232122860326;4813.350197723297;4839.395075615548;4851.9272210916515;5338.332708411449;5342.813001544927;5344.679319240858;5355.919661205085;5392.838214853521;5244.265802787613;5370.785168593252;5375;5466.988607107698;5468.234447177399;4990.725510096943;5007.574356179693;5008.474110218447;5015.84952451427;5028.497150284942;5452.291202143696;5452.890942181213;5460.754266058037;5463.235147079412;5469.972650136724;5196.948030519722;5289.629725919226;5318.016167009116;5321.909008653217;5331.920021199685;5318.069337865858;5437.374701909331;5438.782448702008;5447.891042179134;5449.801043770364;5379.973100134553;5419.268398766195;5422.891542169214;5424.5660347172925;5471.124620060851;5262.684238945675;5402.432744561843;5408.864778380572;5424;5467.4532546745;4247.702660813713;4251.213525497731;4266.06146647737;4267.018585725301;4302.7848607569495;3777.112378591029;3830.5594856591847;3832.2718683450057;3878.6897048236074;3879.4568760373572;5087.058894104603;5096;5096.847094587169;5139.357580302462;5166.689998600096;5390.460953904578;5417.756200970965;5451.427600102012;5457.399686034533;5468.64453810509;4925.162722337212;5089.033083714083;5119.283300337956;5121.2574176744165;5124.205748109049;4615.284630882219;4621.745803980746;4641.2109941310055;4658.95341046592;4686.226772582554;5573.080441727069;5576.302962129734;5577.944220557823;5579.469950354791;5605.495505404533;5328.946710533;5335.919961200662;5354.491323324278;5409.675419474844;5466.262054622575;5584.329880414376;5589.105743081088;5592.776288948559;5612.691301978267;5630.23991761107;5267.525922666979;5292.153255479105;5298.81454149103;5308.628396012242;5341.839744807662;5355.758990845344;5357.19642053695;5357.410684824588;5413.945860541344;5420.83737487876;5185.42960274377;5200.6619569727845;5209.71346575942;5273.815416460406;5297.443768404262;5263.315768950012;5267.552258058108;5270.49930256625;5271.551918086852;5318.175682769177;5073.2897394365555;5139.717315547681;5151.098557752453;5155.510226528474;5206.453322401093;5193.454687257784;5238.921416178837;5244.082285600081;5249.842504724865;5266;5169.017886601534;5174.301469301596;5174.8965020700125;5176.741162941913;5200.4279529251 19:03:39 INFO - PROCESS | 21482 | |1;ext.html;476.3592967458767;516.5506009771499;516.8604476791264;530.0829564852804;556.4241010554076;28566.285842853915;37146.39975201737;37698.8115059425;37732.05669858255;37820.621793782055;40249;40843.79578102105;40912.18175636486;40927.38608920869;41014.58985410145;7405.296496832792;7543.849123017536;8416.284615807665;8524.8721269181;9878.357906736075;9909.752256193617;9922.454265015422;10008.199344052495;10062.899371006306;10064;10029.749256268578;10099.69700908974;10116.595336186543;10121.1903047756;10123.544440500194;9989.650362237324;10064.89935100647;10066.29535932485;10069.496525173785;10074.697759067203;9962.9501852491;10051.748706282327;10057;10067;10370.688879333633;39177;39470;39572.60427395718;39578.20843583141;39595.20809583821;3431.1936694876686;3441.9311613767836;3466.6533346665383;3472.4791281308007;3514.279572687593;30449.23876903095;30449.847750761324;30636.54045189324;30896;30950.226244343845;4009.67922566194;4017.27689015977;4026.8187931543152;4037.899052523681;4094.651954583864;194164;194296;194872;195150;195252;42235.36646950298;42725.35911961323;42753.572464274956;42776.78611606922;59878.40121598728;40474.1905161901;40703.59296407057;40789.38815917764;40891.1821763569;40932.38601420981;14989.775153372708;15232.086074835544;15247.923760381349;15250.618734531725;15254.161021143944;11469.197156198987;11541.134414918915;11548.884511154949;11569.6529104127;11691.123165762432;14517.528549344323;14551.3451894665;14571.781423278659;14592.343344549308;14644.290806200886;5723.170140329629;5802.216700745345;5821.505172060422;5859.707014649336;5897.882042359214;886.233408102;894.8031433084711;968.3028219681818;1013.2603199664139;1065.893410658928;28594.857025715155;29034.564481532794;29119.417611648074;29166.416671666448;29618.703812962027;1015.2537884654773;1058.1270451877233;1094.1465656787718;1111.5831563163813;1133.3030186435283;14656.413743450143;15129.697406051817;15163.241837908061;15384.538463846102;15424;291263;293327;294225;294485;295180;52687.73656131772;53182.20226696603;53191;53202.73398632982;53262.73368633132;1181.5155786127818;1258.219903659737;1317.1241124652;1341.3427420563853;1346.6902612399203;25919.22242332733;26858.462830743665;27077.1876843695;28475.715242848135;29115.272118197216;40035.1992960145;40419.79790101031;40469.19061618692;40502;41039.38440923448;178220;180866;186642;187630;188625;31397.686023139475;33011.834940825145;33013;33021.17447063843;33030;43060.13879722451;43746.781266093465;43849.78075109604;44042;44891.10217795691;37480.437793433666;37653.435198472594;37821.43267850929;37827.432588510645;38118.61881381151;36157.27685446224;36869;36982.815085925475;37123.44314835226;37448.62551374451;36130.45804312885;36527;36541.26917461582;37183.442248365754;37275;32376.83811580927;33109.17227069246;33208;33730.15674608154;33975.830120849234;25063;25477;25515.234542963743;25802.48395032051;25897.611535827353 19:03:39 INFO - PROCESS | 21482 | |2;jquery.html;351.68524170867073;354.57982290985177;361.1675088920039;363.33691013899625;367.04751170711995;16427.09650969196;16495.83504164958;17314;17320.220590073444;17322.133893305316;15909;16213.432529861428;16525.173741312945;16534.173291335446;16555.503334899942;5042.571381432583;5288.418273989858;5336.092864213074;5602.355729091146;5605.1872478490595;5475.288212532365;5503;5537.529310008654;5543.168524721304;5560.749766260528;5549.833504994856;5560.360558535759;5581.134924086773;5797.449242321973;5803.738831752581;5033;5706.4864162225595;5729.05470597353;5729.140628905677;5730.971345143268;4985.700857948535;4997.775100120503;5002.874928126789;5005.049040682259;5023.2214006829;12249.448774805156;12500.624981250578;12591.496340146383;12625.368731563385;12655.810162847472;2139.2726472999257;2169.8155656769195;2214.269291133922;2250.403643034581;2344.6951896253377;11367.488463019185;11779.116566257566;12296.20074695142;12333.321667308295;12904.935475322658;1781.2607767776358;1865.8414034807058;1881.6236752649525;1894.0624390926441;1931.864769466138;63221.68389158071;65401.34598654;66127;66272.66863665699;66478.33521664818;9940.602375905028;10149.492525373702;10185.439800810878;10317.84523232152;10419.687409377579;13351.132176408697;13386.263755493346;13526.120802148025;13558.322083895766;13580.864191358158;7420.740274090381;7553.962230188814;7578.507397019176;7690.807729806799;7690.846183076307;7464.328210461084;7511.661975211019;7516.6993320267675;7656.770296891103;7658.119316278699;4277.57224277576;4355.128974205171;4361.476622805284;4379.386885835986;4474.217012022883;1813.4015774794286;1838.2279442634126;1863.0870873272;1871.2608519634668;1882.6234753049446;404.76321352008813;431.34651003729374;440.5946529193086;449.5482040549293;853.7481442974338;10503.894961050444;10564.683059508227;10722.249442538947;10803.865594112505;11057.557697692002;415.92513347597117;430.6834476659653;434.32679347012004;445.2230857154222;454.18700526057984;5878.147668588031;5891.116332550152;5900.881982360329;5967.1347654589845;6064.302605200459;244841;293413;326103;327620.42846786586;424345;59619;63465.04802427967;67869.96390108304;72656;73256;475.8072980442926;492.1559525413932;494.58454897885946;496.12434053894907;496.2481840012384;8140.75577732669;8500.957495212484;9746.658866939622;10176;10353;33424.49863252102;35145;35330.29339413249;35698.643013569534;35856.820715896254;43891.341629874936;44160;44416;45079.94280514769;45325.09349813051;7679.2704693054075;7759.534427934342;7811.804704882424;8016.358691304565;8195.71315003972;12081.456334465145;12442.129050966345;12450;12830.743385132431;12856.935715321364;10556.947215263874;10565.418901960158;10892.292001019909;11017.779644407226;11037;10006.29955903109;10818.945905270422;11090;11143.72140696489;11291.661250162508;9921.156701680438;10809;11285.43572821372;11387.487563059516;11387.601433949772;7515;7725.613719314124;7842.64708088126;7980.760577182694;8028.959855200686;10140.695779126638;10862.34825910448;10890;11031.503582338653;11248.943755281498 19:03:39 INFO - PROCESS | 21482 | |3;mootools.html;1377.091119860892;1454.6217983324336;1477.8448262932393;1660.41055425324;1832.8991905445203;7088.184858741246;7230.566166030036;7257.74597889074;7260.382867456266;7261.60061196634;6981.930180698191;7111.85776284474;7116.537425067367;7117.928820711792;7128;1850.722391641251;2146.9355919322447;2151.612709712259;2174.7607763146043;2200.19692812124;2176.9564608707815;2178.56428714257;2181.3892110209167;2182.8581142225785;2190.3210004898533;2069.3584988653492;2209.6464565669494;2209.9116035358647;2211.369759618509;2211.469247380633;2055.9794402056013;2081.375587323804;2094.036743098177;2103.14822496889;2105.884176370299;2127.861688990226;2138.6791981202787;2140.9785902140934;2141.0793358855685;2143.3784202581232;7292.854142917165;7387.187409384964;7398.66705998226;7401.0748656417945;7410.5183163094225;4454.910901781978;4562.224421848294;4586.610138138262;4589.770511474447;4592.862214133581;2860.184847318504;2909.2435966648613;2951.940961180786;2957.1128661401494;2976.8065075770005;901.6663834381255;910.5492781073344;914.8673442350822;939.8543225800012;965.2615748952057;9912.950435247922;9932;9941.105300522988;9943.453110078943;9947.502624868728;4002.8999275017777;4067.1255680028344;4106.260873042821;4175.039740859619;4185.267578173807;8539.06070332263;8547.615357308936;8548.187922147386;8572.099929507312;8575.528345941033;4128.02991297045;4562.657800664963;4574.862754117382;4576.954230457719;4578.542145785462;3793.506844110248;3829.387298032357;4055.168690418457;4129.793510324472;4190.790460476964;3506.4214404622953;3556.78659280444;3560.7863528187872;3585.7848529088337;3605.7836529808296;1165.1086918507349;1166.1370585766642;1169.8128299472044;1179.2688533109356;1182.3319824299244;1311.5212947274176;1320.0627554436267;1350.4935649131576;1352.966175845592;1360.6394305509048;6982.057422248033;7007.5795452272005;7066.893996590055;7067.611281379471;7073.61095139762;478.7558345243951;491.2680106641079;493.390662531773;494.94803045679686;495.2126119469988;5393.164059570694;5429.375621803543;5439.102548079602;5454.890902182014;5468.972655136698;8360.45657032291;8420.747377578682;8579.184977427134;8672.436291641023;8693.956530217309;8498.532580707997;8558;8577.785555361166;8581.570921453902;8590.355723320776;6731.932680673131;6772.153480814898;6895.655217239118;6898.068760717239;6947.7220911163995;6616.636085015371;6648.90026649591;6664.966675166593;6668;6672.799816005528;7610.391168706601;7625.809354766176;7775.377969762519;7791.766247012599;7816.7264145754625;7815.218478152139;8014.238647328494;8019.558924258989;8038.075621303625;8109.351251899716;5711.457411545896;5819.098039803837;5898.262717160355;6428.389303016206;6461.030845373044;6668.133142691419;6716.731330746716;6740.325967403416;6747.865042699217;6750;5991.131285963598;6154.595083278264;6203.937960620517;6294.968525157345;6335.3981371769605;6127.632342059491;6205.22434695663;6213.440790328892;6283.308836027942;6315.621062736251;6408.647524386203;6416.101745755504;6451.258105317761;6468.029795530708;6471.288158302677;5597.524210442158;5622.297212848394;5626.043572592751;5641.041023026178;5725.141228815711;5943;5982.4316689914385;5996.490298324691;5996.790112346047;5997.460228579449 19:03:39 INFO - PROCESS | 21482 | |4;prototype.html;322.59514309541527;323.76688784075463;324.24936272529095;325.82405501029444;331.5971095119431;5928.614640048399;5967.134765459005;6017.75928962842;6032.245969253849;6042.033274676052;5865.706714664271;5880.206172166756;5881.382454842244;5882.29412470503;5886.911696324559;4303.880990942346;4409.206342858284;4464.441944756905;4521.3444050612725;4530.841420550281;4526.411566496351;4531.501534831166;4536.682432229745;4549.840755573556;4552.590266875981;4482.058767658796;4484.260097083978;4485.753283569403;4495.752733599667;4498.97750511247;4276.337167739005;4349.9995001149755;4428.7121337112985;4465.285554311327;4473;3908.0425295802424;3916.060145565072;3923.058465968176;3923.195744872294;3925.1953349563555;5603.719814009283;5611.466910643482;5612.579056570733;5620.91568626471;5627.043402621564;5203.713795741232;5203.973980130113;5218.843434696965;5219.373675159005;5228.79084836606;6267.62394256346;6269.028300613412;6278.748850045993;6280.811575652738;6280.937190628081;4119.711620186588;4231.513375961742;4234.788260586958;4363;4364.345348197764;6462.515311351621;6589.0445885346835;6617.834554136137;6631.966840165816;6643.335666433318;4219.810108545123;4243.915121697611;4247.108107297502;4251.957480425218;4251.957480425218;4299.548547402478;4302.182585308781;4302.333138363559;4306.0311429928015;4306.720063195882;5066;5066.6453348266;5070.847874563769;5074.82238121664;5078.13671675816;6128.938710612926;6300.653464059429;6324.841878953063;6336.429721325011;6338.207724034496;1598.1849256878843;1600.7598860170835;1605.871530277575;1607.3650907891551;1608.6380564373158;1021.2034613001871;1054.3146954479496;1076.364944682641;1083.4041277297456;1092.306385445248;5956.136360227742;5975.043992961106;5979.342272350038;6033.5173186145885;6070.089486576961;6457.547971642034;6483.448906842971;6488.805335839932;6504.447121994589;6504.837379065467;6034.125051867454;6043.879122417615;6046.637201767908;6049.0926361046195;6055;3464.72282217422;3500.8774692885627;3501.142220156078;3504.3867323218333;3507.7719948203285;6523.575967562093;6638.900416493757;6678.732850686015;6684.231313399021;6804.693788779517;6595.934040659628;6617.834554136185;6629.071929929813;6632.071509988606;6641.634710090992;6733.091032710619;6778.98315252716;6781.525293229427;6784.660766961632;6790.151231096113;6467;6467.773627923;6478.481721462366;6531.542792004514;6552;6330.335314792064;6400.743970241138;6403.935960640334;6405.775797847053;6555.901661474986;6929.965350173217;6937;6946.097007389007;6947.3747362737595;7021.508494405342;4395.230834603867;4430.224710675554;4431.158079964796;4436.733795972252;4437;6596.241432235354;6609.107770450928;6610.140681711347;6610.867782644224;6612.437942774725;6262.342454042442;6380.266269378895;6396.776112836028;6400.807975760735;6402.935970640234;6312.43188113072;6341.587796793194;6376.87246255063;6390.87218255623;6391.6804159792755;6179.62922224668;6200.038993955944;6209.720562574605;6212.658303793335;6217.906731399123;6394.26465956421;6395.744170233324;6406.583572067801;6414.647194404352;6416.294207637249;5995.130706047686;6118;6245.437910587887;6247.68761561911;6263.843403914939 19:03:39 INFO - PROCESS | 21482 | |5;yui.html;802.3260461212581;810.2383759266287;815.078960774325;827.991720082799;844.2359664503623;13815.585532434017;13876.514321998731;13981.091229070116;14031.368588413534;14064.78902816456;13208.537701180461;13225.867741322583;14377.353019114138;14944;14999.700005999874;693.230514129316;850.2177996243471;859.7936495241129;862.6851199312238;863.3783675753479;831.0276975938136;857.4083882121347;858.274757829633;860.5396113079504;861.1431625532604;888.1340692824476;893.3433926064338;893.5934149961752;893.8212357528488;894.5214310343968;724.9202587715347;869.3002133282705;882.0121463960373;885.1060428966725;888.4092078767612;655.2857385449882;656.1830521001336;656.4092316914815;656.8128083496229;657.1489920552896;14160.079594826304;14192.148471091768;14195.148291102567;14219.289035548181;14225.359858806378;12528.123031387806;12736;12754.947483425656;12967.805482917669;13058.804117938143;10331.036667458658;10635.680929572125;10665.893341066567;10845.945770271177;11073.723156921062;3579.0515513388973;3609.9278014439565;3611.404118320474;3619.8914032579064;3641.526601541809;51992.22011669828;52058.479415205744;52491.47508524904;52515.47484525144;52783.472165278625;9978.550965206583;10248.333858299187;10413.635522756667;10503.94748026255;10669.78660426787;18496.537586560175;18518.259269629332;18564.44306670802;18565.16456759422;18580.44258672242;7603.637216123001;7734.7679569613;7782.260685234894;7803.843923121506;7828.138904720477;4288.935665965013;4405.537418571068;4512.842050528216;4536.88657783558;4629.097326021393;3101.3332133590934;3140.9948816378537;3143.182772479172;3144.496880499109;3151.11768704763;557.4787573618598;566.7562947932346;576.0667718296303;586.3784388548153;587.8559752860576;534.836874753204;546.2652732075352;697.235992937868;702.5819637315789;708.4190963410057;7992.760217193493;8434.24091831738;8548.871766923501;8713.782155446164;8721.293276902892;629.4995478594528;645.1935081148564;675.2336098528206;692.9518458033203;694.8471336306004;4038.414429907647;4117.028035898663;4125.030617804813;4289.849855255051;4321.762303073361;52356.47643523592;52425.7378713104;52816;53188.202176967374;54708;44006.11987760227;44652;44969.775151124035;45005;45337.77331113389;43970.34044489335;44032.77983610061;44958;44989.32516012262;45314.54685453169;8338.66645334204;8459.873101903599;8630.482171069756;8740;8878.200961913459;33129.50305745464;33411.83294083514;33729.494057588665;34507.13732156716;34700.30599388049;39563.80218098891;39652.405213921236;41271;43784;44520.77739611281;10884.727881803019;10946.945265273942;11125.777484450427;11175.776484470103;11265.887341126483;11778.882211178121;12009.519619215134;12083.516659333529;12333.75332493363;12376.07179461562;11090.279131856403;11531.942340288246;11572.24780389272;11776.352300623204;11946.181767761469;11457.828132577852;11586.362750048827;11608.941955290169;11962.820557691468;12018.519259229533;11157.218994670295;11434.48544815502;12631.305278209788;12654.746905061664;12658.11393202467;9763.609455621696;9791.804163916824;9867.753306167404;9957.253206009724;10317.380957142595;8703.695370661997;9138.223251023737;9159.221466175182;9283.72148835536;9478.905210947802 19:03:39 INFO - PROCESS | 21482 | __end_tp_report 19:03:39 INFO - PROCESS | 21482 | __start_cc_report 19:03:39 INFO - PROCESS | 21482 | _x_x_mozilla_cycle_collect,828 19:03:39 INFO - PROCESS | 21482 | __end_cc_report 19:03:39 INFO - PROCESS | 21482 | __startTimestamp1456542219099__endTimestamp 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | ------- Summary: start ------- 19:03:39 INFO - PROCESS | 21482 | Number of tests: 6 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#0] dojo.html Cycles:165 Average:5012.80 Median:5176.74 stddev:525.52 (10.2%) stddev-sans-first:504.13 19:03:39 INFO - PROCESS | 21482 | Values: 3052.5 3124.0 3140.8 3166.3 3199.5 4991.3 5003.5 5069.1 5071.9 5100.6 4997.1 5013.1 5021.2 5079.1 5101.6 4552.4 4553.7 4564.5 4628.6 4777.0 4552.3 4682.1 4690.8 4707.1 4763.1 4590.1 4590.2 4603.6 4637.9 4675.1 4487.2 4513.6 4517.9 4542.8 4576.1 4453.5 4481.1 4485.6 4501.5 4568.8 4787.2 4799.2 4813.4 4839.4 4851.9 5338.3 5342.8 5344.7 5355.9 5392.8 5244.3 5370.8 5375.0 5467.0 5468.2 4990.7 5007.6 5008.5 5015.8 5028.5 5452.3 5452.9 5460.8 5463.2 5470.0 5196.9 5289.6 5318.0 5321.9 5331.9 5318.1 5437.4 5438.8 5447.9 5449.8 5380.0 5419.3 5422.9 5424.6 5471.1 5262.7 5402.4 5408.9 5424.0 5467.5 4247.7 4251.2 4266.1 4267.0 4302.8 3777.1 3830.6 3832.3 3878.7 3879.5 5087.1 5096.0 5096.8 5139.4 5166.7 5390.5 5417.8 5451.4 5457.4 5468.6 4925.2 5089.0 5119.3 5121.3 5124.2 4615.3 4621.7 4641.2 4659.0 4686.2 5573.1 5576.3 5577.9 5579.5 5605.5 5328.9 5335.9 5354.5 5409.7 5466.3 5584.3 5589.1 5592.8 5612.7 5630.2 5267.5 5292.2 5298.8 5308.6 5341.8 5355.8 5357.2 5357.4 5413.9 5420.8 5185.4 5200.7 5209.7 5273.8 5297.4 5263.3 5267.6 5270.5 5271.6 5318.2 5073.3 5139.7 5151.1 5155.5 5206.5 5193.5 5238.9 5244.1 5249.8 5266.0 5169.0 5174.3 5174.9 5176.7 5200.4 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#1] ext.html Cycles:180 Average:39603.91 Median:33158.59 stddev:59640.70 (179.9%) stddev-sans-first:59735.65 19:03:39 INFO - PROCESS | 21482 | Values: 476.4 516.6 516.9 530.1 556.4 28566.3 37146.4 37698.8 37732.1 37820.6 40249.0 40843.8 40912.2 40927.4 41014.6 7405.3 7543.8 8416.3 8524.9 9878.4 9909.8 9922.5 10008.2 10062.9 10064.0 10029.7 10099.7 10116.6 10121.2 10123.5 9989.7 10064.9 10066.3 10069.5 10074.7 9963.0 10051.7 10057.0 10067.0 10370.7 39177.0 39470.0 39572.6 39578.2 39595.2 3431.2 3441.9 3466.7 3472.5 3514.3 30449.2 30449.8 30636.5 30896.0 30950.2 4009.7 4017.3 4026.8 4037.9 4094.7 194164.0 194296.0 194872.0 195150.0 195252.0 42235.4 42725.4 42753.6 42776.8 59878.4 40474.2 40703.6 40789.4 40891.2 40932.4 14989.8 15232.1 15247.9 15250.6 15254.2 11469.2 11541.1 11548.9 11569.7 11691.1 14517.5 14551.3 14571.8 14592.3 14644.3 5723.2 5802.2 5821.5 5859.7 5897.9 886.2 894.8 968.3 1013.3 1065.9 28594.9 29034.6 29119.4 29166.4 29618.7 1015.3 1058.1 1094.1 1111.6 1133.3 14656.4 15129.7 15163.2 15384.5 15424.0 291263.0 293327.0 294225.0 294485.0 295180.0 52687.7 53182.2 53191.0 53202.7 53262.7 1181.5 1258.2 1317.1 1341.3 1346.7 25919.2 26858.5 27077.2 28475.7 29115.3 40035.2 40419.8 40469.2 40502.0 41039.4 178220.0 180866.0 186642.0 187630.0 188625.0 31397.7 33011.8 33013.0 33021.2 33030.0 43060.1 43746.8 43849.8 44042.0 44891.1 37480.4 37653.4 37821.4 37827.4 38118.6 36157.3 36869.0 36982.8 37123.4 37448.6 36130.5 36527.0 36541.3 37183.4 37275.0 32376.8 33109.2 33208.0 33730.2 33975.8 25063.0 25477.0 25515.2 25802.5 25897.6 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#2] jquery.html Cycles:180 Average:21379.45 Median:212380.46 stddev:54417.57 (25.6%) stddev-sans-first:54547.32 19:03:39 INFO - PROCESS | 21482 | Values: 351.7 354.6 361.2 363.3 367.0 16427.1 16495.8 17314.0 17320.2 17322.1 15909.0 16213.4 16525.2 16534.2 16555.5 5042.6 5288.4 5336.1 5602.4 5605.2 5475.3 5503.0 5537.5 5543.2 5560.7 5549.8 5560.4 5581.1 5797.4 5803.7 5033.0 5706.5 5729.1 5729.1 5731.0 4985.7 4997.8 5002.9 5005.0 5023.2 12249.4 12500.6 12591.5 12625.4 12655.8 2139.3 2169.8 2214.3 2250.4 2344.7 11367.5 11779.1 12296.2 12333.3 12904.9 1781.3 1865.8 1881.6 1894.1 1931.9 63221.7 65401.3 66127.0 66272.7 66478.3 9940.6 10149.5 10185.4 10317.8 10419.7 13351.1 13386.3 13526.1 13558.3 13580.9 7420.7 7554.0 7578.5 7690.8 7690.8 7464.3 7511.7 7516.7 7656.8 7658.1 4277.6 4355.1 4361.5 4379.4 4474.2 1813.4 1838.2 1863.1 1871.3 1882.6 404.8 431.3 440.6 449.5 853.7 10503.9 10564.7 10722.2 10803.9 11057.6 415.9 430.7 434.3 445.2 454.2 5878.1 5891.1 5900.9 5967.1 6064.3 244841.0 293413.0 326103.0 327620.4 424345.0 59619.0 63465.0 67870.0 72656.0 73256.0 475.8 492.2 494.6 496.1 496.2 8140.8 8501.0 9746.7 10176.0 10353.0 33424.5 35145.0 35330.3 35698.6 35856.8 43891.3 44160.0 44416.0 45079.9 45325.1 7679.3 7759.5 7811.8 8016.4 8195.7 12081.5 12442.1 12450.0 12830.7 12856.9 10556.9 10565.4 10892.3 11017.8 11037.0 10006.3 10818.9 11090.0 11143.7 11291.7 9921.2 10809.0 11285.4 11387.5 11387.6 7515.0 7725.6 7842.6 7980.8 8029.0 10140.7 10862.3 10890.0 11031.5 11248.9 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#3] mootools.html Cycles:180 Average:5058.35 Median:5993.81 stddev:2595.44 (43.3%) stddev-sans-first:2587.98 19:03:39 INFO - PROCESS | 21482 | Values: 1377.1 1454.6 1477.8 1660.4 1832.9 7088.2 7230.6 7257.7 7260.4 7261.6 6981.9 7111.9 7116.5 7117.9 7128.0 1850.7 2146.9 2151.6 2174.8 2200.2 2177.0 2178.6 2181.4 2182.9 2190.3 2069.4 2209.6 2209.9 2211.4 2211.5 2056.0 2081.4 2094.0 2103.1 2105.9 2127.9 2138.7 2141.0 2141.1 2143.4 7292.9 7387.2 7398.7 7401.1 7410.5 4454.9 4562.2 4586.6 4589.8 4592.9 2860.2 2909.2 2951.9 2957.1 2976.8 901.7 910.5 914.9 939.9 965.3 9913.0 9932.0 9941.1 9943.5 9947.5 4002.9 4067.1 4106.3 4175.0 4185.3 8539.1 8547.6 8548.2 8572.1 8575.5 4128.0 4562.7 4574.9 4577.0 4578.5 3793.5 3829.4 4055.2 4129.8 4190.8 3506.4 3556.8 3560.8 3585.8 3605.8 1165.1 1166.1 1169.8 1179.3 1182.3 1311.5 1320.1 1350.5 1353.0 1360.6 6982.1 7007.6 7066.9 7067.6 7073.6 478.8 491.3 493.4 494.9 495.2 5393.2 5429.4 5439.1 5454.9 5469.0 8360.5 8420.7 8579.2 8672.4 8694.0 8498.5 8558.0 8577.8 8581.6 8590.4 6731.9 6772.2 6895.7 6898.1 6947.7 6616.6 6648.9 6665.0 6668.0 6672.8 7610.4 7625.8 7775.4 7791.8 7816.7 7815.2 8014.2 8019.6 8038.1 8109.4 5711.5 5819.1 5898.3 6428.4 6461.0 6668.1 6716.7 6740.3 6747.9 6750.0 5991.1 6154.6 6203.9 6295.0 6335.4 6127.6 6205.2 6213.4 6283.3 6315.6 6408.6 6416.1 6451.3 6468.0 6471.3 5597.5 5622.3 5626.0 5641.0 5725.1 5943.0 5982.4 5996.5 5996.8 5997.5 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#4] prototype.html Cycles:180 Average:5251.23 Median:6006.44 stddev:1613.87 (26.9%) stddev-sans-first:1575.43 19:03:39 INFO - PROCESS | 21482 | Values: 322.6 323.8 324.2 325.8 331.6 5928.6 5967.1 6017.8 6032.2 6042.0 5865.7 5880.2 5881.4 5882.3 5886.9 4303.9 4409.2 4464.4 4521.3 4530.8 4526.4 4531.5 4536.7 4549.8 4552.6 4482.1 4484.3 4485.8 4495.8 4499.0 4276.3 4350.0 4428.7 4465.3 4473.0 3908.0 3916.1 3923.1 3923.2 3925.2 5603.7 5611.5 5612.6 5620.9 5627.0 5203.7 5204.0 5218.8 5219.4 5228.8 6267.6 6269.0 6278.7 6280.8 6280.9 4119.7 4231.5 4234.8 4363.0 4364.3 6462.5 6589.0 6617.8 6632.0 6643.3 4219.8 4243.9 4247.1 4252.0 4252.0 4299.5 4302.2 4302.3 4306.0 4306.7 5066.0 5066.6 5070.8 5074.8 5078.1 6128.9 6300.7 6324.8 6336.4 6338.2 1598.2 1600.8 1605.9 1607.4 1608.6 1021.2 1054.3 1076.4 1083.4 1092.3 5956.1 5975.0 5979.3 6033.5 6070.1 6457.5 6483.4 6488.8 6504.4 6504.8 6034.1 6043.9 6046.6 6049.1 6055.0 3464.7 3500.9 3501.1 3504.4 3507.8 6523.6 6638.9 6678.7 6684.2 6804.7 6595.9 6617.8 6629.1 6632.1 6641.6 6733.1 6779.0 6781.5 6784.7 6790.2 6467.0 6467.8 6478.5 6531.5 6552.0 6330.3 6400.7 6403.9 6405.8 6555.9 6930.0 6937.0 6946.1 6947.4 7021.5 4395.2 4430.2 4431.2 4436.7 4437.0 6596.2 6609.1 6610.1 6610.9 6612.4 6262.3 6380.3 6396.8 6400.8 6402.9 6312.4 6341.6 6376.9 6390.9 6391.7 6179.6 6200.0 6209.7 6212.7 6217.9 6394.3 6395.7 6406.6 6414.6 6416.3 5995.1 6118.0 6245.4 6247.7 6263.8 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | [#5] yui.html Cycles:180 Average:13611.88 Median:44805.00 stddev:15190.82 (33.9%) stddev-sans-first:15202.97 19:03:39 INFO - PROCESS | 21482 | Values: 802.3 810.2 815.1 828.0 844.2 13815.6 13876.5 13981.1 14031.4 14064.8 13208.5 13225.9 14377.4 14944.0 14999.7 693.2 850.2 859.8 862.7 863.4 831.0 857.4 858.3 860.5 861.1 888.1 893.3 893.6 893.8 894.5 724.9 869.3 882.0 885.1 888.4 655.3 656.2 656.4 656.8 657.1 14160.1 14192.1 14195.1 14219.3 14225.4 12528.1 12736.0 12754.9 12967.8 13058.8 10331.0 10635.7 10665.9 10845.9 11073.7 3579.1 3609.9 3611.4 3619.9 3641.5 51992.2 52058.5 52491.5 52515.5 52783.5 9978.6 10248.3 10413.6 10503.9 10669.8 18496.5 18518.3 18564.4 18565.2 18580.4 7603.6 7734.8 7782.3 7803.8 7828.1 4288.9 4405.5 4512.8 4536.9 4629.1 3101.3 3141.0 3143.2 3144.5 3151.1 557.5 566.8 576.1 586.4 587.9 534.8 546.3 697.2 702.6 708.4 7992.8 8434.2 8548.9 8713.8 8721.3 629.5 645.2 675.2 693.0 694.8 4038.4 4117.0 4125.0 4289.8 4321.8 52356.5 52425.7 52816.0 53188.2 54708.0 44006.1 44652.0 44969.8 45005.0 45337.8 43970.3 44032.8 44958.0 44989.3 45314.5 8338.7 8459.9 8630.5 8740.0 8878.2 33129.5 33411.8 33729.5 34507.1 34700.3 39563.8 39652.4 41271.0 43784.0 44520.8 10884.7 10946.9 11125.8 11175.8 11265.9 11778.9 12009.5 12083.5 12333.8 12376.1 11090.3 11531.9 11572.2 11776.4 11946.2 11457.8 11586.4 11608.9 11962.8 12018.5 11157.2 11434.5 12631.3 12654.7 12658.1 9763.6 9791.8 9867.8 9957.3 10317.4 8703.7 9138.2 9159.2 9283.7 9478.9 19:03:39 INFO - PROCESS | 21482 | -------- Summary: end -------- 19:03:39 INFO - PROCESS | 21482 | 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - PROCESS | 21482 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:39 INFO - TEST-INFO | 21482: exit 0 19:03:39 INFO - TEST-OK | dromaeo_css | took 1112861ms 19:03:39 INFO - TEST-START | kraken 19:03:39 INFO - operating with platform_type : linux_ 19:03:39 INFO - Initialising browser for kraken test... 19:03:39 INFO - TEST-INFO | started process 21673 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprV0VKQ/profile http://localhost:43064/getInfo.html) 19:03:44 INFO - PROCESS | 21673 | __metrics Screen width/height:1600/1200 19:03:44 INFO - PROCESS | 21673 | colorDepth:24 19:03:44 INFO - PROCESS | 21673 | Browser inner width/height: 1024/697 19:03:44 INFO - PROCESS | 21673 | __metrics 19:03:45 INFO - PROCESS | 21673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:45 INFO - PROCESS | 21673 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:03:46 INFO - TEST-INFO | 21673: exit 0 19:03:46 INFO - Browser initialized. 19:03:46 INFO - Running cycle 1/1 for kraken test... 19:03:46 INFO - TEST-INFO | started process 21756 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprV0VKQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:58 INFO - PROCESS | 21756 | RSS: Main: 151097344 19:03:58 INFO - PROCESS | 21756 | 19:04:00 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-beat-detection) 19:04:01 INFO - PROCESS | 21756 | RSS: Main: 194994176 19:04:01 INFO - PROCESS | 21756 | 19:04:03 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-dft) 19:04:04 INFO - PROCESS | 21756 | RSS: Main: 183054336 19:04:04 INFO - PROCESS | 21756 | 19:04:07 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-fft) 19:04:07 INFO - PROCESS | 21756 | RSS: Main: 168570880 19:04:07 INFO - PROCESS | 21756 | 19:04:09 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43064/tests/kraken/driver.html?testName=audio-oscillator) 19:04:10 INFO - PROCESS | 21756 | RSS: Main: 170057728 19:04:10 INFO - PROCESS | 21756 | 19:04:12 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:13 INFO - PROCESS | 21756 | RSS: Main: 172105728 19:04:13 INFO - PROCESS | 21756 | 19:04:16 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:16 INFO - PROCESS | 21756 | RSS: Main: 172429312 19:04:16 INFO - PROCESS | 21756 | 19:04:20 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43064/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:20 INFO - PROCESS | 21756 | RSS: Main: 172965888 19:04:20 INFO - PROCESS | 21756 | 19:04:23 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43064/tests/kraken/driver.html?testName=json-parse-financial) 19:04:24 INFO - PROCESS | 21756 | RSS: Main: 172257280 19:04:24 INFO - PROCESS | 21756 | 19:04:25 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43064/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:26 INFO - PROCESS | 21756 | RSS: Main: 184115200 19:04:26 INFO - PROCESS | 21756 | 19:04:28 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:28 INFO - PROCESS | 21756 | RSS: Main: 182845440 19:04:28 INFO - PROCESS | 21756 | 19:04:30 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:31 INFO - PROCESS | 21756 | RSS: Main: 193851392 19:04:31 INFO - PROCESS | 21756 | 19:04:33 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:34 INFO - PROCESS | 21756 | RSS: Main: 198320128 19:04:34 INFO - PROCESS | 21756 | 19:04:37 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:37 INFO - PROCESS | 21756 | RSS: Main: 197525504 19:04:37 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | Cycle 1(1): loaded http://localhost:43064/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43064/tests/kraken/driver.html?testName=ai-astar) 19:04:39 INFO - PROCESS | 21756 | RSS: Main: 257957888 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | __start_tp_report 19:04:39 INFO - PROCESS | 21756 | _x_x_mozilla_page_load 19:04:39 INFO - PROCESS | 21756 | _x_x_mozilla_page_load_details 19:04:39 INFO - PROCESS | 21756 | |i|pagename|runs| 19:04:39 INFO - PROCESS | 21756 | |0;ai-astar;111;111;107;111;112;112;101;111;112;111 19:04:39 INFO - PROCESS | 21756 | |1;audio-beat-detection;151;125;150;176;127;152;160;126;175;132 19:04:39 INFO - PROCESS | 21756 | |2;audio-dft;161;161;160;160;159;161;160;165;161;162 19:04:39 INFO - PROCESS | 21756 | |3;audio-fft;72;73;107;95;73;73;73;134;102;73 19:04:39 INFO - PROCESS | 21756 | |4;audio-oscillator;96;97;147;96;96;95;139;95;95;142 19:04:39 INFO - PROCESS | 21756 | |5;imaging-gaussian-blur;120;116;114;115;114;115;115;114;114;116 19:04:39 INFO - PROCESS | 21756 | |6;imaging-darkroom;145;145;145;145;145;145;146;145;145;145 19:04:39 INFO - PROCESS | 21756 | |7;imaging-desaturate;97;97;103;97;96;96;96;96;96;96 19:04:39 INFO - PROCESS | 21756 | |8;json-parse-financial;57;58;58;58;59;57;58;66;57;55 19:04:39 INFO - PROCESS | 21756 | |9;json-stringify-tinderbox;69;69;67;67;67;68;68;67;68;67 19:04:39 INFO - PROCESS | 21756 | |10;stanford-crypto-aes;82;79;82;82;81;82;83;81;82;82 19:04:39 INFO - PROCESS | 21756 | |11;stanford-crypto-ccm;117;122;116;119;123;116;118;122;118;118 19:04:39 INFO - PROCESS | 21756 | |12;stanford-crypto-pbkdf2;155;141;155;153;152;165;151;143;157;158 19:04:39 INFO - PROCESS | 21756 | |13;stanford-crypto-sha256-iterative;71;74;70;71;72;73;70;70;68;69 19:04:39 INFO - PROCESS | 21756 | __end_tp_report 19:04:39 INFO - PROCESS | 21756 | __start_cc_report 19:04:39 INFO - PROCESS | 21756 | _x_x_mozilla_cycle_collect,1082 19:04:39 INFO - PROCESS | 21756 | __end_cc_report 19:04:39 INFO - PROCESS | 21756 | __startTimestamp1456542279572__endTimestamp 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | ------- Summary: start ------- 19:04:39 INFO - PROCESS | 21756 | Number of tests: 14 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.45 (3.1%) stddev-sans-first:3.63 19:04:39 INFO - PROCESS | 21756 | Values: 111.0 111.0 107.0 111.0 112.0 112.0 101.0 111.0 112.0 111.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:151.50 stddev:19.41 (12.8%) stddev-sans-first:20.55 19:04:39 INFO - PROCESS | 21756 | Values: 151.0 125.0 150.0 176.0 127.0 152.0 160.0 126.0 175.0 132.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 19:04:39 INFO - PROCESS | 21756 | Values: 161.0 161.0 160.0 160.0 159.0 161.0 160.0 165.0 161.0 162.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#3] audio-fft Cycles:10 Average:87.50 Median:73.00 stddev:21.35 (29.2%) stddev-sans-first:21.89 19:04:39 INFO - PROCESS | 21756 | Values: 72.0 73.0 107.0 95.0 73.0 73.0 73.0 134.0 102.0 73.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.50 stddev:22.77 (23.8%) stddev-sans-first:23.60 19:04:39 INFO - PROCESS | 21756 | Values: 96.0 97.0 147.0 96.0 96.0 95.0 139.0 95.0 95.0 142.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.83 (1.6%) stddev-sans-first:0.83 19:04:39 INFO - PROCESS | 21756 | Values: 120.0 116.0 114.0 115.0 114.0 115.0 115.0 114.0 114.0 116.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:04:39 INFO - PROCESS | 21756 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 145.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.16 (2.3%) stddev-sans-first:2.29 19:04:39 INFO - PROCESS | 21756 | Values: 97.0 97.0 103.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:2.91 (5.0%) stddev-sans-first:3.05 19:04:39 INFO - PROCESS | 21756 | Values: 57.0 58.0 58.0 58.0 59.0 57.0 58.0 66.0 57.0 55.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 19:04:39 INFO - PROCESS | 21756 | Values: 69.0 69.0 67.0 67.0 67.0 68.0 68.0 67.0 68.0 67.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 19:04:39 INFO - PROCESS | 21756 | Values: 82.0 79.0 82.0 82.0 81.0 82.0 83.0 81.0 82.0 82.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:118.50 stddev:2.56 (2.2%) stddev-sans-first:2.62 19:04:39 INFO - PROCESS | 21756 | Values: 117.0 122.0 116.0 119.0 123.0 116.0 118.0 122.0 118.0 118.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:155.00 stddev:7.01 (4.5%) stddev-sans-first:7.40 19:04:39 INFO - PROCESS | 21756 | Values: 155.0 141.0 155.0 153.0 152.0 165.0 151.0 143.0 157.0 158.0 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.81 (2.6%) stddev-sans-first:1.92 19:04:39 INFO - PROCESS | 21756 | Values: 71.0 74.0 70.0 71.0 72.0 73.0 70.0 70.0 68.0 69.0 19:04:39 INFO - PROCESS | 21756 | -------- Summary: end -------- 19:04:39 INFO - PROCESS | 21756 | 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:39 INFO - PROCESS | 21756 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 19:04:40 INFO - TEST-INFO | 21756: exit 0 19:04:40 INFO - TEST-OK | kraken | took 60665ms 19:04:40 INFO - SUITE-END | took 1173s 19:04:40 INFO - Completed test suite (00:19:33) 19:04:40 INFO - Working with test: dromaeo_css 19:04:40 INFO - Generating results file: dromaeo_css 19:04:40 INFO - Working with test: kraken 19:04:40 INFO - Generating results file: kraken 19:04:40 INFO - javascript benchmark 19:04:40 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 19:04:40 INFO - process_Request line: dromaeo_css 6591.96 graph.html#tests=[[72,63,35]] 19:04:40 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:04:40 INFO - process_Request line: kraken 1523.30 graph.html#tests=[[232,63,35]] 19:04:40 INFO - RETURN: dromaeo_css: 6591.96 19:04:40 INFO - RETURN: kraken: 1523.30 19:04:40 INFO - javascript benchmark 19:04:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3052.511598144297, 3123.968760312396, 3140.7644426668007, 3166.3034132490857, 3199.456092464281, 4991.276264941581, 5003.524665156809, 5069.087564238435, 5071.923921141186, 5100.642954993152, 4997.125503036963, 5013.14776487997, 5021.17150670139, 5079.111155547774, 5101.642884998052, 4552.408186935694, 4553.658475614326, 4564.452265728118, 4628.606568441686, 4777.04459108178, 4552.271636538155, 4682.0635872825405, 4690.7654617269, 4707.05858828234, 4763.118823017736, 4590.104929538741, 4590.242609969351, 4603.631709463251, 4637.86086417408, 4675.135100006492, 4487.19230538503, 4513.616342610882, 4517.909641807146, 4542.772861356919, 4576.130535198335, 4453.532379100213, 4481.148581769486, 4485.573870482299, 4501.4598248210095, 4568.840090596813, 4787.234042553175, 4799.232122860326, 4813.350197723297, 4839.395075615548, 4851.9272210916515, 5338.332708411449, 5342.813001544927, 5344.679319240858, 5355.919661205085, 5392.838214853521, 5244.265802787613, 5370.785168593252, 5375.0, 5466.988607107698, 5468.234447177399, 4990.725510096943, 5007.574356179693, 5008.474110218447, 5015.84952451427, 5028.497150284942, 5452.291202143696, 5452.890942181213, 5460.754266058037, 5463.235147079412, 5469.972650136724, 5196.948030519722, 5289.629725919226, 5318.016167009116, 5321.909008653217, 5331.920021199685, 5318.069337865858, 5437.374701909331, 5438.782448702008, 5447.891042179134, 5449.801043770364, 5379.973100134553, 5419.268398766195, 5422.891542169214, 5424.5660347172925, 5471.124620060851, 5262.684238945675, 5402.432744561843, 5408.864778380572, 5424.0, 5467.4532546745, 4247.702660813713, 4251.213525497731, 4266.06146647737, 4267.018585725301, 4302.7848607569495, 3777.112378591029, 3830.5594856591847, 3832.2718683450057, 3878.6897048236074, 3879.4568760373572, 5087.058894104603, 5096.0, 5096.847094587169, 5139.357580302462, 5166.689998600096, 5390.460953904578, 5417.756200970965, 5451.427600102012, 5457.399686034533, 5468.64453810509, 4925.162722337212, 5089.033083714083, 5119.283300337956, 5121.2574176744165, 5124.205748109049, 4615.284630882219, 4621.745803980746, 4641.2109941310055, 4658.95341046592, 4686.226772582554, 5573.080441727069, 5576.302962129734, 5577.944220557823, 5579.469950354791, 5605.495505404533, 5328.946710533, 5335.919961200662, 5354.491323324278, 5409.675419474844, 5466.262054622575, 5584.329880414376, 5589.105743081088, 5592.776288948559, 5612.691301978267, 5630.23991761107, 5267.525922666979, 5292.153255479105, 5298.81454149103, 5308.628396012242, 5341.839744807662, 5355.758990845344, 5357.19642053695, 5357.410684824588, 5413.945860541344, 5420.83737487876, 5185.42960274377, 5200.6619569727845, 5209.71346575942, 5273.815416460406, 5297.443768404262, 5263.315768950012, 5267.552258058108, 5270.49930256625, 5271.551918086852, 5318.175682769177, 5073.2897394365555, 5139.717315547681, 5151.098557752453, 5155.510226528474, 5206.453322401093, 5193.454687257784, 5238.921416178837, 5244.082285600081, 5249.842504724865, 5266.0, 5169.017886601534, 5174.301469301596, 5174.8965020700125, 5176.741162941913, 5200.4279529251], "unit": "score", "name": "dojo.html", "value": 4981.195971188972}, {"lowerIsBetter": false, "replicates": [476.3592967458767, 516.5506009771499, 516.8604476791264, 530.0829564852804, 556.4241010554076, 28566.285842853915, 37146.39975201737, 37698.8115059425, 37732.05669858255, 37820.621793782055, 40249.0, 40843.79578102105, 40912.18175636486, 40927.38608920869, 41014.58985410145, 7405.296496832792, 7543.849123017536, 8416.284615807665, 8524.8721269181, 9878.357906736075, 9909.752256193617, 9922.454265015422, 10008.199344052495, 10062.899371006306, 10064.0, 10029.749256268578, 10099.69700908974, 10116.595336186543, 10121.1903047756, 10123.544440500194, 9989.650362237324, 10064.89935100647, 10066.29535932485, 10069.496525173785, 10074.697759067203, 9962.9501852491, 10051.748706282327, 10057.0, 10067.0, 10370.688879333633, 39177.0, 39470.0, 39572.60427395718, 39578.20843583141, 39595.20809583821, 3431.1936694876686, 3441.9311613767836, 3466.6533346665383, 3472.4791281308007, 3514.279572687593, 30449.23876903095, 30449.847750761324, 30636.54045189324, 30896.0, 30950.226244343845, 4009.67922566194, 4017.27689015977, 4026.8187931543152, 4037.899052523681, 4094.651954583864, 194164.0, 194296.0, 194872.0, 195150.0, 195252.0, 42235.36646950298, 42725.35911961323, 42753.572464274956, 42776.78611606922, 59878.40121598728, 40474.1905161901, 40703.59296407057, 40789.38815917764, 40891.1821763569, 40932.38601420981, 14989.775153372708, 15232.086074835544, 15247.923760381349, 15250.618734531725, 15254.161021143944, 11469.197156198987, 11541.134414918915, 11548.884511154949, 11569.6529104127, 11691.123165762432, 14517.528549344323, 14551.3451894665, 14571.781423278659, 14592.343344549308, 14644.290806200886, 5723.170140329629, 5802.216700745345, 5821.505172060422, 5859.707014649336, 5897.882042359214, 886.233408102, 894.8031433084711, 968.3028219681818, 1013.2603199664139, 1065.893410658928, 28594.857025715155, 29034.564481532794, 29119.417611648074, 29166.416671666448, 29618.703812962027, 1015.2537884654773, 1058.1270451877233, 1094.1465656787718, 1111.5831563163813, 1133.3030186435283, 14656.413743450143, 15129.697406051817, 15163.241837908061, 15384.538463846102, 15424.0, 291263.0, 293327.0, 294225.0, 294485.0, 295180.0, 52687.73656131772, 53182.20226696603, 53191.0, 53202.73398632982, 53262.73368633132, 1181.5155786127818, 1258.219903659737, 1317.1241124652, 1341.3427420563853, 1346.6902612399203, 25919.22242332733, 26858.462830743665, 27077.1876843695, 28475.715242848135, 29115.272118197216, 40035.1992960145, 40419.79790101031, 40469.19061618692, 40502.0, 41039.38440923448, 178220.0, 180866.0, 186642.0, 187630.0, 188625.0, 31397.686023139475, 33011.834940825145, 33013.0, 33021.17447063843, 33030.0, 43060.13879722451, 43746.781266093465, 43849.78075109604, 44042.0, 44891.10217795691, 37480.437793433666, 37653.435198472594, 37821.43267850929, 37827.432588510645, 38118.61881381151, 36157.27685446224, 36869.0, 36982.815085925475, 37123.44314835226, 37448.62551374451, 36130.45804312885, 36527.0, 36541.26917461582, 37183.442248365754, 37275.0, 32376.83811580927, 33109.17227069246, 33208.0, 33730.15674608154, 33975.830120849234, 25063.0, 25477.0, 25515.234542963743, 25802.48395032051, 25897.611535827353], "unit": "score", "name": "ext.html", "value": 17619.019800485177}, {"lowerIsBetter": false, "replicates": [351.68524170867073, 354.57982290985177, 361.1675088920039, 363.33691013899625, 367.04751170711995, 16427.09650969196, 16495.83504164958, 17314.0, 17320.220590073444, 17322.133893305316, 15909.0, 16213.432529861428, 16525.173741312945, 16534.173291335446, 16555.503334899942, 5042.571381432583, 5288.418273989858, 5336.092864213074, 5602.355729091146, 5605.1872478490595, 5475.288212532365, 5503.0, 5537.529310008654, 5543.168524721304, 5560.749766260528, 5549.833504994856, 5560.360558535759, 5581.134924086773, 5797.449242321973, 5803.738831752581, 5033.0, 5706.4864162225595, 5729.05470597353, 5729.140628905677, 5730.971345143268, 4985.700857948535, 4997.775100120503, 5002.874928126789, 5005.049040682259, 5023.2214006829, 12249.448774805156, 12500.624981250578, 12591.496340146383, 12625.368731563385, 12655.810162847472, 2139.2726472999257, 2169.8155656769195, 2214.269291133922, 2250.403643034581, 2344.6951896253377, 11367.488463019185, 11779.116566257566, 12296.20074695142, 12333.321667308295, 12904.935475322658, 1781.2607767776358, 1865.8414034807058, 1881.6236752649525, 1894.0624390926441, 1931.864769466138, 63221.68389158071, 65401.34598654, 66127.0, 66272.66863665699, 66478.33521664818, 9940.602375905028, 10149.492525373702, 10185.439800810878, 10317.84523232152, 10419.687409377579, 13351.132176408697, 13386.263755493346, 13526.120802148025, 13558.322083895766, 13580.864191358158, 7420.740274090381, 7553.962230188814, 7578.507397019176, 7690.807729806799, 7690.846183076307, 7464.328210461084, 7511.661975211019, 7516.6993320267675, 7656.770296891103, 7658.119316278699, 4277.57224277576, 4355.128974205171, 4361.476622805284, 4379.386885835986, 4474.217012022883, 1813.4015774794286, 1838.2279442634126, 1863.0870873272, 1871.2608519634668, 1882.6234753049446, 404.76321352008813, 431.34651003729374, 440.5946529193086, 449.5482040549293, 853.7481442974338, 10503.894961050444, 10564.683059508227, 10722.249442538947, 10803.865594112505, 11057.557697692002, 415.92513347597117, 430.6834476659653, 434.32679347012004, 445.2230857154222, 454.18700526057984, 5878.147668588031, 5891.116332550152, 5900.881982360329, 5967.1347654589845, 6064.302605200459, 244841.0, 293413.0, 326103.0, 327620.42846786586, 424345.0, 59619.0, 63465.04802427967, 67869.96390108304, 72656.0, 73256.0, 475.8072980442926, 492.1559525413932, 494.58454897885946, 496.12434053894907, 496.2481840012384, 8140.75577732669, 8500.957495212484, 9746.658866939622, 10176.0, 10353.0, 33424.49863252102, 35145.0, 35330.29339413249, 35698.643013569534, 35856.820715896254, 43891.341629874936, 44160.0, 44416.0, 45079.94280514769, 45325.09349813051, 7679.2704693054075, 7759.534427934342, 7811.804704882424, 8016.358691304565, 8195.71315003972, 12081.456334465145, 12442.129050966345, 12450.0, 12830.743385132431, 12856.935715321364, 10556.947215263874, 10565.418901960158, 10892.292001019909, 11017.779644407226, 11037.0, 10006.29955903109, 10818.945905270422, 11090.0, 11143.72140696489, 11291.661250162508, 9921.156701680438, 10809.0, 11285.43572821372, 11387.487563059516, 11387.601433949772, 7515.0, 7725.613719314124, 7842.64708088126, 7980.760577182694, 8028.959855200686, 10140.695779126638, 10862.34825910448, 10890.0, 11031.503582338653, 11248.943755281498], "unit": "score", "name": "jquery.html", "value": 7490.712240270017}, {"lowerIsBetter": false, "replicates": [1377.091119860892, 1454.6217983324336, 1477.8448262932393, 1660.41055425324, 1832.8991905445203, 7088.184858741246, 7230.566166030036, 7257.74597889074, 7260.382867456266, 7261.60061196634, 6981.930180698191, 7111.85776284474, 7116.537425067367, 7117.928820711792, 7128.0, 1850.722391641251, 2146.9355919322447, 2151.612709712259, 2174.7607763146043, 2200.19692812124, 2176.9564608707815, 2178.56428714257, 2181.3892110209167, 2182.8581142225785, 2190.3210004898533, 2069.3584988653492, 2209.6464565669494, 2209.9116035358647, 2211.369759618509, 2211.469247380633, 2055.9794402056013, 2081.375587323804, 2094.036743098177, 2103.14822496889, 2105.884176370299, 2127.861688990226, 2138.6791981202787, 2140.9785902140934, 2141.0793358855685, 2143.3784202581232, 7292.854142917165, 7387.187409384964, 7398.66705998226, 7401.0748656417945, 7410.5183163094225, 4454.910901781978, 4562.224421848294, 4586.610138138262, 4589.770511474447, 4592.862214133581, 2860.184847318504, 2909.2435966648613, 2951.940961180786, 2957.1128661401494, 2976.8065075770005, 901.6663834381255, 910.5492781073344, 914.8673442350822, 939.8543225800012, 965.2615748952057, 9912.950435247922, 9932.0, 9941.105300522988, 9943.453110078943, 9947.502624868728, 4002.8999275017777, 4067.1255680028344, 4106.260873042821, 4175.039740859619, 4185.267578173807, 8539.06070332263, 8547.615357308936, 8548.187922147386, 8572.099929507312, 8575.528345941033, 4128.02991297045, 4562.657800664963, 4574.862754117382, 4576.954230457719, 4578.542145785462, 3793.506844110248, 3829.387298032357, 4055.168690418457, 4129.793510324472, 4190.790460476964, 3506.4214404622953, 3556.78659280444, 3560.7863528187872, 3585.7848529088337, 3605.7836529808296, 1165.1086918507349, 1166.1370585766642, 1169.8128299472044, 1179.2688533109356, 1182.3319824299244, 1311.5212947274176, 1320.0627554436267, 1350.4935649131576, 1352.966175845592, 1360.6394305509048, 6982.057422248033, 7007.5795452272005, 7066.893996590055, 7067.611281379471, 7073.61095139762, 478.7558345243951, 491.2680106641079, 493.390662531773, 494.94803045679686, 495.2126119469988, 5393.164059570694, 5429.375621803543, 5439.102548079602, 5454.890902182014, 5468.972655136698, 8360.45657032291, 8420.747377578682, 8579.184977427134, 8672.436291641023, 8693.956530217309, 8498.532580707997, 8558.0, 8577.785555361166, 8581.570921453902, 8590.355723320776, 6731.932680673131, 6772.153480814898, 6895.655217239118, 6898.068760717239, 6947.7220911163995, 6616.636085015371, 6648.90026649591, 6664.966675166593, 6668.0, 6672.799816005528, 7610.391168706601, 7625.809354766176, 7775.377969762519, 7791.766247012599, 7816.7264145754625, 7815.218478152139, 8014.238647328494, 8019.558924258989, 8038.075621303625, 8109.351251899716, 5711.457411545896, 5819.098039803837, 5898.262717160355, 6428.389303016206, 6461.030845373044, 6668.133142691419, 6716.731330746716, 6740.325967403416, 6747.865042699217, 6750.0, 5991.131285963598, 6154.595083278264, 6203.937960620517, 6294.968525157345, 6335.3981371769605, 6127.632342059491, 6205.22434695663, 6213.440790328892, 6283.308836027942, 6315.621062736251, 6408.647524386203, 6416.101745755504, 6451.258105317761, 6468.029795530708, 6471.288158302677, 5597.524210442158, 5622.297212848394, 5626.043572592751, 5641.041023026178, 5725.141228815711, 5943.0, 5982.4316689914385, 5996.490298324691, 5996.790112346047, 5997.460228579449], "unit": "score", "name": "mootools.html", "value": 4132.044134620575}, {"lowerIsBetter": false, "replicates": [322.59514309541527, 323.76688784075463, 324.24936272529095, 325.82405501029444, 331.5971095119431, 5928.614640048399, 5967.134765459005, 6017.75928962842, 6032.245969253849, 6042.033274676052, 5865.706714664271, 5880.206172166756, 5881.382454842244, 5882.29412470503, 5886.911696324559, 4303.880990942346, 4409.206342858284, 4464.441944756905, 4521.3444050612725, 4530.841420550281, 4526.411566496351, 4531.501534831166, 4536.682432229745, 4549.840755573556, 4552.590266875981, 4482.058767658796, 4484.260097083978, 4485.753283569403, 4495.752733599667, 4498.97750511247, 4276.337167739005, 4349.9995001149755, 4428.7121337112985, 4465.285554311327, 4473.0, 3908.0425295802424, 3916.060145565072, 3923.058465968176, 3923.195744872294, 3925.1953349563555, 5603.719814009283, 5611.466910643482, 5612.579056570733, 5620.91568626471, 5627.043402621564, 5203.713795741232, 5203.973980130113, 5218.843434696965, 5219.373675159005, 5228.79084836606, 6267.62394256346, 6269.028300613412, 6278.748850045993, 6280.811575652738, 6280.937190628081, 4119.711620186588, 4231.513375961742, 4234.788260586958, 4363.0, 4364.345348197764, 6462.515311351621, 6589.0445885346835, 6617.834554136137, 6631.966840165816, 6643.335666433318, 4219.810108545123, 4243.915121697611, 4247.108107297502, 4251.957480425218, 4251.957480425218, 4299.548547402478, 4302.182585308781, 4302.333138363559, 4306.0311429928015, 4306.720063195882, 5066.0, 5066.6453348266, 5070.847874563769, 5074.82238121664, 5078.13671675816, 6128.938710612926, 6300.653464059429, 6324.841878953063, 6336.429721325011, 6338.207724034496, 1598.1849256878843, 1600.7598860170835, 1605.871530277575, 1607.3650907891551, 1608.6380564373158, 1021.2034613001871, 1054.3146954479496, 1076.364944682641, 1083.4041277297456, 1092.306385445248, 5956.136360227742, 5975.043992961106, 5979.342272350038, 6033.5173186145885, 6070.089486576961, 6457.547971642034, 6483.448906842971, 6488.805335839932, 6504.447121994589, 6504.837379065467, 6034.125051867454, 6043.879122417615, 6046.637201767908, 6049.0926361046195, 6055.0, 3464.72282217422, 3500.8774692885627, 3501.142220156078, 3504.3867323218333, 3507.7719948203285, 6523.575967562093, 6638.900416493757, 6678.732850686015, 6684.231313399021, 6804.693788779517, 6595.934040659628, 6617.834554136185, 6629.071929929813, 6632.071509988606, 6641.634710090992, 6733.091032710619, 6778.98315252716, 6781.525293229427, 6784.660766961632, 6790.151231096113, 6467.0, 6467.773627923, 6478.481721462366, 6531.542792004514, 6552.0, 6330.335314792064, 6400.743970241138, 6403.935960640334, 6405.775797847053, 6555.901661474986, 6929.965350173217, 6937.0, 6946.097007389007, 6947.3747362737595, 7021.508494405342, 4395.230834603867, 4430.224710675554, 4431.158079964796, 4436.733795972252, 4437.0, 6596.241432235354, 6609.107770450928, 6610.140681711347, 6610.867782644224, 6612.437942774725, 6262.342454042442, 6380.266269378895, 6396.776112836028, 6400.807975760735, 6402.935970640234, 6312.43188113072, 6341.587796793194, 6376.87246255063, 6390.87218255623, 6391.6804159792755, 6179.62922224668, 6200.038993955944, 6209.720562574605, 6212.658303793335, 6217.906731399123, 6394.26465956421, 6395.744170233324, 6406.583572067801, 6414.647194404352, 6416.294207637249, 5995.130706047686, 6118.0, 6245.437910587887, 6247.68761561911, 6263.843403914939], "unit": "score", "name": "prototype.html", "value": 4726.375656266523}, {"lowerIsBetter": false, "replicates": [802.3260461212581, 810.2383759266287, 815.078960774325, 827.991720082799, 844.2359664503623, 13815.585532434017, 13876.514321998731, 13981.091229070116, 14031.368588413534, 14064.78902816456, 13208.537701180461, 13225.867741322583, 14377.353019114138, 14944.0, 14999.700005999874, 693.230514129316, 850.2177996243471, 859.7936495241129, 862.6851199312238, 863.3783675753479, 831.0276975938136, 857.4083882121347, 858.274757829633, 860.5396113079504, 861.1431625532604, 888.1340692824476, 893.3433926064338, 893.5934149961752, 893.8212357528488, 894.5214310343968, 724.9202587715347, 869.3002133282705, 882.0121463960373, 885.1060428966725, 888.4092078767612, 655.2857385449882, 656.1830521001336, 656.4092316914815, 656.8128083496229, 657.1489920552896, 14160.079594826304, 14192.148471091768, 14195.148291102567, 14219.289035548181, 14225.359858806378, 12528.123031387806, 12736.0, 12754.947483425656, 12967.805482917669, 13058.804117938143, 10331.036667458658, 10635.680929572125, 10665.893341066567, 10845.945770271177, 11073.723156921062, 3579.0515513388973, 3609.9278014439565, 3611.404118320474, 3619.8914032579064, 3641.526601541809, 51992.22011669828, 52058.479415205744, 52491.47508524904, 52515.47484525144, 52783.472165278625, 9978.550965206583, 10248.333858299187, 10413.635522756667, 10503.94748026255, 10669.78660426787, 18496.537586560175, 18518.259269629332, 18564.44306670802, 18565.16456759422, 18580.44258672242, 7603.637216123001, 7734.7679569613, 7782.260685234894, 7803.843923121506, 7828.138904720477, 4288.935665965013, 4405.537418571068, 4512.842050528216, 4536.88657783558, 4629.097326021393, 3101.3332133590934, 3140.9948816378537, 3143.182772479172, 3144.496880499109, 3151.11768704763, 557.4787573618598, 566.7562947932346, 576.0667718296303, 586.3784388548153, 587.8559752860576, 534.836874753204, 546.2652732075352, 697.235992937868, 702.5819637315789, 708.4190963410057, 7992.760217193493, 8434.24091831738, 8548.871766923501, 8713.782155446164, 8721.293276902892, 629.4995478594528, 645.1935081148564, 675.2336098528206, 692.9518458033203, 694.8471336306004, 4038.414429907647, 4117.028035898663, 4125.030617804813, 4289.849855255051, 4321.762303073361, 52356.47643523592, 52425.7378713104, 52816.0, 53188.202176967374, 54708.0, 44006.11987760227, 44652.0, 44969.775151124035, 45005.0, 45337.77331113389, 43970.34044489335, 44032.77983610061, 44958.0, 44989.32516012262, 45314.54685453169, 8338.66645334204, 8459.873101903599, 8630.482171069756, 8740.0, 8878.200961913459, 33129.50305745464, 33411.83294083514, 33729.494057588665, 34507.13732156716, 34700.30599388049, 39563.80218098891, 39652.405213921236, 41271.0, 43784.0, 44520.77739611281, 10884.727881803019, 10946.945265273942, 11125.777484450427, 11175.776484470103, 11265.887341126483, 11778.882211178121, 12009.519619215134, 12083.516659333529, 12333.75332493363, 12376.07179461562, 11090.279131856403, 11531.942340288246, 11572.24780389272, 11776.352300623204, 11946.181767761469, 11457.828132577852, 11586.362750048827, 11608.941955290169, 11962.820557691468, 12018.519259229533, 11157.218994670295, 11434.48544815502, 12631.305278209788, 12654.746905061664, 12658.11393202467, 9763.609455621696, 9791.804163916824, 9867.753306167404, 9957.253206009724, 10317.380957142595, 8703.695370661997, 9138.223251023737, 9159.221466175182, 9283.72148835536, 9478.905210947802], "unit": "score", "name": "yui.html", "value": 6390.246444253474}], "name": "dromaeo_css", "value": 6591.963446764738}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 107.0, 111.0, 112.0, 112.0, 101.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 150.0, 176.0, 127.0, 152.0, 160.0, 126.0, 175.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 165.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 107.0, 95.0, 73.0, 73.0, 73.0, 134.0, 102.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 147.0, 96.0, 96.0, 95.0, 139.0, 95.0, 95.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 103.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 57.0, 58.0, 66.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [82.0, 79.0, 82.0, 82.0, 81.0, 82.0, 83.0, 81.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 116.0, 119.0, 123.0, 116.0, 118.0, 122.0, 118.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [155.0, 141.0, 155.0, 153.0, 152.0, 165.0, 151.0, 143.0, 157.0, 158.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 70.0, 71.0, 72.0, 73.0, 70.0, 70.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1523.3}]} 19:04:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1523.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6591.96"}}} 19:04:40 INFO - Return code: 0 19:04:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:04:40 INFO - # TBPL SUCCESS # 19:04:40 INFO - Running post-action listener: _resource_record_post_action 19:04:40 INFO - Running post-run listener: _resource_record_post_run 19:04:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 549273600; Read time: 908; Write time: 1355256 19:04:42 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 4096; Write bytes: 255946752; Read time: 484; Write time: 773544 19:04:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 293326848; Read time: 424; Write time: 581712 19:04:42 INFO - Running post-run listener: _upload_blobber_files 19:04:42 INFO - Blob upload gear active. 19:04:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:04:42 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 19:04:42 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:04:42 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:04:42 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:04:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:43 INFO - (blobuploader) - INFO - Done attempting. 19:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:04:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:44 INFO - (blobuploader) - INFO - Done attempting. 19:04:44 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:44 INFO - Return code: 0 19:04:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:04:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57882b2d0a6041d04a29668205d7e0f59ebfea524860ae56992c00b81630be74687f6e944181c09e52e2a8ea4e37c82ed4f34a4c3dfc084de9b225fb0a38bee8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afd9adcf478062973c312febc185cf19894351a8968f4f9425a5ac09747836fba515e9d70b7cc7d56bc65e7656351048309357691da50b293e18a537fa5911bf"} 19:04:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:04:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:04:44 INFO - Contents: 19:04:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57882b2d0a6041d04a29668205d7e0f59ebfea524860ae56992c00b81630be74687f6e944181c09e52e2a8ea4e37c82ed4f34a4c3dfc084de9b225fb0a38bee8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afd9adcf478062973c312febc185cf19894351a8968f4f9425a5ac09747836fba515e9d70b7cc7d56bc65e7656351048309357691da50b293e18a537fa5911bf"} 19:04:44 INFO - Running post-run listener: copy_logs_to_upload_dir 19:04:44 INFO - Copying logs to upload dir... 19:04:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:04:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.156974 ========= master_lag: 107.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2016-02-26 19:06:31.689753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:31.693070) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/57882b2d0a6041d04a29668205d7e0f59ebfea524860ae56992c00b81630be74687f6e944181c09e52e2a8ea4e37c82ed4f34a4c3dfc084de9b225fb0a38bee8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afd9adcf478062973c312febc185cf19894351a8968f4f9425a5ac09747836fba515e9d70b7cc7d56bc65e7656351048309357691da50b293e18a537fa5911bf"} build_url:https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/K9tmXzxyTSO7qRSsOoxfgQ/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/Mozilla-Inbound/sha512/57882b2d0a6041d04a29668205d7e0f59ebfea524860ae56992c00b81630be74687f6e944181c09e52e2a8ea4e37c82ed4f34a4c3dfc084de9b225fb0a38bee8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afd9adcf478062973c312febc185cf19894351a8968f4f9425a5ac09747836fba515e9d70b7cc7d56bc65e7656351048309357691da50b293e18a537fa5911bf"}' ========= master_lag: 0.51 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 19:06:32.214844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-02-26 19:06:32.215201) ========= 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=af724c981e2a0f424dbabf99000001e7-1456533114.52424-1358667648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 6.79 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-02-26 19:06:39.008651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 19:06:39.008998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 19:06:39.251602) ========= ========= Total master_lag: 115.11 =========