builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1452755364.53 results: success (0) buildid: 20160113203303 builduid: 1c1336dc4eb14ee5acade5bf18c8faf9 revision: efdb75b49dc877bd0858989d24da43bf7ce394be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.528031) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.528539) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.528824) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.555943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.556289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.574040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.574367) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.623657) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.623951) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.624335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.624639) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 23:09:24-- 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% 219M=0s 2016-01-13 23:09:25 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.800482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.800796) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.849539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:24.849855) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev efdb75b49dc877bd0858989d24da43bf7ce394be --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/b2g-inbound --rev efdb75b49dc877bd0858989d24da43bf7ce394be --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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 23:09:25,265 truncating revision to first 12 chars 2016-01-13 23:09:25,265 Setting DEBUG logging. 2016-01-13 23:09:25,265 attempt 1/10 2016-01-13 23:09:25,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/efdb75b49dc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 23:09:25,598 unpacking tar archive at: b2g-inbound-efdb75b49dc8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628617 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:25.492205) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:25.492504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:25.499591) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:25.499844) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 23:09:25.500232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-13 23:09:25.500528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:25 INFO - MultiFileLogger online at 20160113 23:09:25 in /builds/slave/test-pgo 23:09:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 23:09:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:09:26 INFO - {'append_to_log': False, 23:09:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:09:26 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:09:26 INFO - 'branch': 'B2G-Inbound', 23:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:26 INFO - 'config_files': ('talos/linux_config.py',), 23:09:26 INFO - 'default_actions': ('clobber', 23:09:26 INFO - 'read-buildbot-config', 23:09:26 INFO - 'download-and-extract', 23:09:26 INFO - 'populate-webroot', 23:09:26 INFO - 'create-virtualenv', 23:09:26 INFO - 'install', 23:09:26 INFO - 'run-tests'), 23:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:26 INFO - 'download_minidump_stackwalk': True, 23:09:26 INFO - 'download_symbols': 'ondemand', 23:09:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:26 INFO - 'installer_path': 'installer.exe', 23:09:26 INFO - 'log_level': 'info', 23:09:26 INFO - 'log_name': 'talos', 23:09:26 INFO - 'log_to_console': True, 23:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:26 INFO - 'opt_config_files': (), 23:09:26 INFO - 'pip_index': False, 23:09:26 INFO - 'sps_profile': False, 23:09:26 INFO - 'sps_profile_interval': 0, 23:09:26 INFO - 'suite': 'dromaeojs', 23:09:26 INFO - 'system_bits': '32', 23:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:26 INFO - 'title': 'talos-linux64-ix-026', 23:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:26 INFO - 'use_talos_json': True, 23:09:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:26 INFO - 'work_dir': 'build'} 23:09:26 INFO - ##### 23:09:26 INFO - ##### Running clobber step. 23:09:26 INFO - ##### 23:09:26 INFO - Running pre-action listener: _resource_record_pre_action 23:09:26 INFO - Running main action method: clobber 23:09:26 INFO - rmtree: /builds/slave/test-pgo/build 23:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:09:26 INFO - Running post-action listener: _resource_record_post_action 23:09:26 INFO - ##### 23:09:26 INFO - ##### Running read-buildbot-config step. 23:09:26 INFO - ##### 23:09:26 INFO - Running pre-action listener: _resource_record_pre_action 23:09:26 INFO - Running main action method: read_buildbot_config 23:09:26 INFO - Using buildbot properties: 23:09:26 INFO - { 23:09:26 INFO - "project": "", 23:09:26 INFO - "product": "firefox", 23:09:26 INFO - "script_repo_revision": "production", 23:09:26 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:09:26 INFO - "repository": "", 23:09:26 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:09:26 INFO - "buildid": "20160113203303", 23:09:26 INFO - "pgo_build": "True", 23:09:26 INFO - "basedir": "/builds/slave/test-pgo", 23:09:26 INFO - "buildnumber": 1107, 23:09:26 INFO - "slavename": "talos-linux64-ix-026", 23:09:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:09:26 INFO - "platform": "ubuntu64_hw", 23:09:26 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:09:26 INFO - "branch": "b2g-inbound", 23:09:26 INFO - "repo_path": "integration/b2g-inbound", 23:09:26 INFO - "revision": "efdb75b49dc877bd0858989d24da43bf7ce394be", 23:09:26 INFO - "stage_platform": "linux64-pgo", 23:09:26 INFO - "builduid": "1c1336dc4eb14ee5acade5bf18c8faf9", 23:09:26 INFO - "slavebuilddir": "test" 23:09:26 INFO - } 23:09:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:09:26 INFO - Running post-action listener: _resource_record_post_action 23:09:26 INFO - ##### 23:09:26 INFO - ##### Running download-and-extract step. 23:09:26 INFO - ##### 23:09:26 INFO - Running pre-action listener: _resource_record_pre_action 23:09:26 INFO - Running main action method: download_and_extract 23:09:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:09:26 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')]} 23:09:26 INFO - https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/test_packages.json 23:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/test_packages.json 23:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:09:27 INFO - Downloaded 1448 bytes. 23:09:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:09:27 INFO - Using the following test package requirements: 23:09:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:27 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'jsshell-linux-x86_64.zip'], 23:09:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09: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')]} 23:09:27 INFO - https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:29 INFO - Downloaded 24031010 bytes. 23:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 23:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:09:30 INFO - Return code: 0 23:09:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09: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')]} 23:09:30 INFO - https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:33 INFO - Downloaded 24031010 bytes. 23:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 23:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:09:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 23:09:34 INFO - Return code: 0 23:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:34 INFO - https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:37 INFO - Downloaded 11132279 bytes. 23:09:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 23:09:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 23:09:37 INFO - Return code: 0 23:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:37 INFO - https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:49 INFO - Downloaded 55884544 bytes. 23:09:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:09:49 INFO - mkdir: /builds/slave/test-pgo/properties 23:09:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:09:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:09:49 INFO - Contents: 23:09:49 INFO - build_url:https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:09:49 INFO - Running post-action listener: _resource_record_post_action 23:09:49 INFO - Running post-action listener: set_extra_try_arguments 23:09:49 INFO - ##### 23:09:49 INFO - ##### Running populate-webroot step. 23:09:49 INFO - ##### 23:09:49 INFO - Running pre-action listener: _resource_record_pre_action 23:09:49 INFO - Running main action method: populate_webroot 23:09:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:49 INFO - '--tppagecycles', 23:09:49 INFO - '7'], 23:09:49 INFO - 'tests': ['tsvgm']}}, 23:09:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:09:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:09:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:09:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'tests': ['damp', 'tps']}, 23:09:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['damp', 'tps']}, 23:09:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:09:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:49 INFO - 'other': {'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'other_l64': {'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'other_nol64': {'tests': ['a11yr', 23:09:49 INFO - 'ts_paint', 23:09:49 INFO - 'tpaint', 23:09:49 INFO - 'sessionrestore', 23:09:49 INFO - 'sessionrestore_no_auto_restore']}, 23:09:49 INFO - 'svgr': {'tests': ['tsvgx', 23:09:49 INFO - 'tsvgr_opacity', 23:09:49 INFO - 'tart', 23:09:49 INFO - 'tscrollx', 23:09:49 INFO - 'cart']}, 23:09:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['tsvgx', 23:09:49 INFO - 'tsvgr_opacity', 23:09:49 INFO - 'tart', 23:09:49 INFO - 'tscrollx', 23:09:49 INFO - 'cart']}, 23:09:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'tests': ['tp5o']}, 23:09:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'talos_options': ['--e10s'], 23:09:49 INFO - 'tests': ['tp5o']}, 23:09:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'talos_options': ['--xperf_path', 23:09:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:49 INFO - 'tests': ['tp5n']}, 23:09:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:49 INFO - 'talos_options': ['--e10s', 23:09:49 INFO - '--xperf_path', 23:09:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:49 INFO - 'tests': ['tp5n']}}, 23:09:49 INFO - 'talos.zip': {'path': '', 23:09:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:49 INFO - Running post-action listener: _resource_record_post_action 23:09:49 INFO - ##### 23:09:49 INFO - ##### Running create-virtualenv step. 23:09:49 INFO - ##### 23:09:49 INFO - Running pre-action listener: _resource_record_pre_action 23:09:49 INFO - Running main action method: create_virtualenv 23:09:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:09:49 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 23:09:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:09:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:49 INFO - Using real prefix '/usr' 23:09:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:09:50 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:52 INFO - Installing pip.................done. 23:09:52 INFO - Return code: 0 23:09:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:09:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:09:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:09:52 INFO - Using env: {'DISPLAY': ':0', 23:09:52 INFO - 'HOME': '/home/cltbld', 23:09:52 INFO - 'LANG': 'en_US.UTF-8', 23:09:52 INFO - 'LANGUAGE': 'en_US:en', 23:09:52 INFO - 'LOGNAME': 'cltbld', 23:09:52 INFO - 'MAIL': '/var/mail/cltbld', 23:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:52 INFO - 'MOZ_NO_REMOTE': '1', 23:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:52 INFO - 'NO_EM_RESTART': '1', 23:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:09:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:09:52 INFO - 'SHELL': '/bin/bash', 23:09:52 INFO - 'SHLVL': '1', 23:09:52 INFO - 'TERM': 'linux', 23:09:52 INFO - 'TMOUT': '86400', 23:09:52 INFO - 'USER': 'cltbld', 23:09:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:52 INFO - '_': '/tools/buildbot/bin/python'} 23:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:52 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 23:09:52 INFO - Cleaning up... 23:09:52 INFO - Return code: 0 23:09:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:09:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:09:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:09:52 INFO - Using env: {'DISPLAY': ':0', 23:09:52 INFO - 'HOME': '/home/cltbld', 23:09:52 INFO - 'LANG': 'en_US.UTF-8', 23:09:52 INFO - 'LANGUAGE': 'en_US:en', 23:09:52 INFO - 'LOGNAME': 'cltbld', 23:09:52 INFO - 'MAIL': '/var/mail/cltbld', 23:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:52 INFO - 'MOZ_NO_REMOTE': '1', 23:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:52 INFO - 'NO_EM_RESTART': '1', 23:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:09:52 INFO - 'PWD': '/builds/slave/test-pgo', 23:09:52 INFO - 'SHELL': '/bin/bash', 23:09:52 INFO - 'SHLVL': '1', 23:09:52 INFO - 'TERM': 'linux', 23:09:52 INFO - 'TMOUT': '86400', 23:09:52 INFO - 'USER': 'cltbld', 23:09:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:52 INFO - '_': '/tools/buildbot/bin/python'} 23:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:52 INFO - Downloading/unpacking psutil>=0.7.1 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:52 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 23:09:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:09:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:09:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:54 INFO - Installing collected packages: psutil 23:09:54 INFO - Running setup.py install for psutil 23:09:54 INFO - building 'psutil._psutil_linux' extension 23:09:54 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 23:09:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:09:54 INFO - building 'psutil._psutil_posix' extension 23:09:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:09:55 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 23:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:55 INFO - Successfully installed psutil 23:09:55 INFO - Cleaning up... 23:09:55 INFO - Return code: 0 23:09:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:09:55 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')]} 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:55 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')]} 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:09:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:09:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:09:55 INFO - Using env: {'DISPLAY': ':0', 23:09:55 INFO - 'HOME': '/home/cltbld', 23:09:55 INFO - 'LANG': 'en_US.UTF-8', 23:09:55 INFO - 'LANGUAGE': 'en_US:en', 23:09:55 INFO - 'LOGNAME': 'cltbld', 23:09:55 INFO - 'MAIL': '/var/mail/cltbld', 23:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:55 INFO - 'MOZ_NO_REMOTE': '1', 23:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:55 INFO - 'NO_EM_RESTART': '1', 23:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:09:55 INFO - 'PWD': '/builds/slave/test-pgo', 23:09:55 INFO - 'SHELL': '/bin/bash', 23:09:55 INFO - 'SHLVL': '1', 23:09:55 INFO - 'TERM': 'linux', 23:09:55 INFO - 'TMOUT': '86400', 23:09:55 INFO - 'USER': 'cltbld', 23:09:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:55 INFO - '_': '/tools/buildbot/bin/python'} 23:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:09:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:09:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:09:57 INFO - Installing collected packages: mozsystemmonitor 23:09:57 INFO - Running setup.py install for mozsystemmonitor 23:09:57 INFO - Successfully installed mozsystemmonitor 23:09:57 INFO - Cleaning up... 23:09:57 INFO - Return code: 0 23:09:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:09:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:09:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:09:57 INFO - Using env: {'DISPLAY': ':0', 23:09:57 INFO - 'HOME': '/home/cltbld', 23:09:57 INFO - 'LANG': 'en_US.UTF-8', 23:09:57 INFO - 'LANGUAGE': 'en_US:en', 23:09:57 INFO - 'LOGNAME': 'cltbld', 23:09:57 INFO - 'MAIL': '/var/mail/cltbld', 23:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:57 INFO - 'MOZ_NO_REMOTE': '1', 23:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:57 INFO - 'NO_EM_RESTART': '1', 23:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:09:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:09:57 INFO - 'SHELL': '/bin/bash', 23:09:57 INFO - 'SHLVL': '1', 23:09:57 INFO - 'TERM': 'linux', 23:09:57 INFO - 'TMOUT': '86400', 23:09:57 INFO - 'USER': 'cltbld', 23:09:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:57 INFO - '_': '/tools/buildbot/bin/python'} 23:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:57 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:57 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 23:09:57 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 23:09:57 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 23:09:57 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 23:09:57 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 23:09:57 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 23:09:59 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:09:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:09:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:09:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:59 INFO - Downloading docopt-0.6.1.tar.gz 23:09:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:09:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:00 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:00 INFO - Running setup.py install for blobuploader 23:10:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:00 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:10:00 INFO - Running setup.py install for requests 23:10:00 INFO - Running setup.py install for docopt 23:10:00 INFO - Successfully installed blobuploader requests docopt 23:10:00 INFO - Cleaning up... 23:10:00 INFO - Return code: 0 23:10:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:10:00 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')]} 23:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:00 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')]} 23:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:10:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:10:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:10:00 INFO - Using env: {'DISPLAY': ':0', 23:10:00 INFO - 'HOME': '/home/cltbld', 23:10:00 INFO - 'LANG': 'en_US.UTF-8', 23:10:00 INFO - 'LANGUAGE': 'en_US:en', 23:10:00 INFO - 'LOGNAME': 'cltbld', 23:10:00 INFO - 'MAIL': '/var/mail/cltbld', 23:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:00 INFO - 'MOZ_NO_REMOTE': '1', 23:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:00 INFO - 'NO_EM_RESTART': '1', 23:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:00 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:00 INFO - 'SHELL': '/bin/bash', 23:10:00 INFO - 'SHLVL': '1', 23:10:00 INFO - 'TERM': 'linux', 23:10:00 INFO - 'TMOUT': '86400', 23:10:00 INFO - 'USER': 'cltbld', 23:10:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:00 INFO - '_': '/tools/buildbot/bin/python'} 23:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:10:00 INFO - Running setup.py (path:/tmp/pip-6evn08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:10:00 INFO - Running setup.py (path:/tmp/pip-uPxTkc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:10:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:10:00 INFO - Running setup.py (path:/tmp/pip-9Qpn3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:10:01 INFO - Running setup.py (path:/tmp/pip-f7rSEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:10:01 INFO - Running setup.py (path:/tmp/pip-EvWEmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:10:01 INFO - Running setup.py (path:/tmp/pip-yhYn75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:10:01 INFO - Running setup.py (path:/tmp/pip-GB8Ntc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:10:01 INFO - Running setup.py (path:/tmp/pip-MvY8Mv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:10:01 INFO - Running setup.py (path:/tmp/pip-1X4laj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:10:01 INFO - Running setup.py (path:/tmp/pip-jghqjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:10:01 INFO - Running setup.py (path:/tmp/pip-VrKMWN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:10:01 INFO - Running setup.py (path:/tmp/pip-eOeGhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:10:01 INFO - Running setup.py (path:/tmp/pip-6z3XD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:10:01 INFO - Running setup.py (path:/tmp/pip-RXiS4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:10:01 INFO - Running setup.py (path:/tmp/pip-7H_vo2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:10:01 INFO - Running setup.py (path:/tmp/pip-MRNw1w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:10:01 INFO - Running setup.py (path:/tmp/pip-E99BY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:10:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:02 INFO - Running setup.py install for manifestparser 23:10:02 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Running setup.py install for mozcrash 23:10:02 INFO - Running setup.py install for mozdebug 23:10:02 INFO - Running setup.py install for mozdevice 23:10:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Running setup.py install for mozfile 23:10:02 INFO - Running setup.py install for mozhttpd 23:10:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Running setup.py install for mozinfo 23:10:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Running setup.py install for mozInstall 23:10:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:10:02 INFO - Running setup.py install for mozleak 23:10:02 INFO - Running setup.py install for mozlog 23:10:03 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Running setup.py install for moznetwork 23:10:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Running setup.py install for mozprocess 23:10:03 INFO - Running setup.py install for mozprofile 23:10:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Running setup.py install for mozrunner 23:10:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Running setup.py install for mozscreenshot 23:10:03 INFO - Running setup.py install for moztest 23:10:03 INFO - Running setup.py install for mozversion 23:10:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:10:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:03 INFO - Cleaning up... 23:10:03 INFO - Return code: 0 23:10:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:10:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:10:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:10:03 INFO - Using env: {'DISPLAY': ':0', 23:10:03 INFO - 'HOME': '/home/cltbld', 23:10:03 INFO - 'LANG': 'en_US.UTF-8', 23:10:03 INFO - 'LANGUAGE': 'en_US:en', 23:10:03 INFO - 'LOGNAME': 'cltbld', 23:10:03 INFO - 'MAIL': '/var/mail/cltbld', 23:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:03 INFO - 'MOZ_NO_REMOTE': '1', 23:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:03 INFO - 'NO_EM_RESTART': '1', 23:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:03 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:03 INFO - 'SHELL': '/bin/bash', 23:10:03 INFO - 'SHLVL': '1', 23:10:03 INFO - 'TERM': 'linux', 23:10:03 INFO - 'TMOUT': '86400', 23:10:03 INFO - 'USER': 'cltbld', 23:10:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:03 INFO - '_': '/tools/buildbot/bin/python'} 23:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:10:04 INFO - Running setup.py (path:/tmp/pip-Tu4VwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:10:04 INFO - Running setup.py (path:/tmp/pip-9Gn4w5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:10:04 INFO - Running setup.py (path:/tmp/pip-3Tz3_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:10:04 INFO - Running setup.py (path:/tmp/pip-__ekBe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:10:04 INFO - Running setup.py (path:/tmp/pip-YeMhVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:10:04 INFO - Running setup.py (path:/tmp/pip-ZZ_eIx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:10:04 INFO - Running setup.py (path:/tmp/pip-hpbetP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:10:04 INFO - Running setup.py (path:/tmp/pip-0EcLnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:10:04 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)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:10:04 INFO - Running setup.py (path:/tmp/pip-5UeusG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:10:04 INFO - Running setup.py (path:/tmp/pip-W5lDPG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:10:04 INFO - Running setup.py (path:/tmp/pip-B_W3NK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:10:04 INFO - Running setup.py (path:/tmp/pip-T9mh4S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 23:10:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:10:04 INFO - Running setup.py (path:/tmp/pip-WzMuLV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:10:05 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)) 23:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:10:05 INFO - Running setup.py (path:/tmp/pip-pDYSNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:10:05 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)) 23:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:10:05 INFO - Running setup.py (path:/tmp/pip-UnqObE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:10:05 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)) 23:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:10:05 INFO - Running setup.py (path:/tmp/pip-WKIWu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:10:05 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)) 23:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:10:05 INFO - Running setup.py (path:/tmp/pip-uJtT11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:10:05 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)) 23:10:05 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)) 23:10:05 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)) 23:10:05 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)) 23:10:05 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)) 23:10:05 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)) 23:10:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:07 INFO - Downloading blessings-1.5.1.tar.gz 23:10:07 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 23:10:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:07 INFO - Installing collected packages: blessings 23:10:07 INFO - Running setup.py install for blessings 23:10:07 INFO - Successfully installed blessings 23:10:07 INFO - Cleaning up... 23:10:07 INFO - Return code: 0 23:10:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:10:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:10:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:10:07 INFO - Reading from file tmpfile_stdout 23:10:07 INFO - Current package versions: 23:10:07 INFO - argparse == 1.2.1 23:10:07 INFO - blessings == 1.5.1 23:10:07 INFO - blobuploader == 1.2.4 23:10:07 INFO - docopt == 0.6.1 23:10:07 INFO - manifestparser == 1.1 23:10:07 INFO - mozInstall == 1.12 23:10:07 INFO - mozcrash == 0.16 23:10:07 INFO - mozdebug == 0.1 23:10:07 INFO - mozdevice == 0.48 23:10:07 INFO - mozfile == 1.2 23:10:07 INFO - mozhttpd == 0.7 23:10:07 INFO - mozinfo == 0.9 23:10:07 INFO - mozleak == 0.1 23:10:07 INFO - mozlog == 3.1 23:10:07 INFO - moznetwork == 0.27 23:10:07 INFO - mozprocess == 0.22 23:10:07 INFO - mozprofile == 0.28 23:10:07 INFO - mozrunner == 6.11 23:10:07 INFO - mozscreenshot == 0.1 23:10:07 INFO - mozsystemmonitor == 0.0 23:10:07 INFO - moztest == 0.7 23:10:07 INFO - mozversion == 1.4 23:10:07 INFO - psutil == 3.1.1 23:10:07 INFO - requests == 1.2.3 23:10:07 INFO - wsgiref == 0.1.2 23:10:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:10:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:10:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:10:07 INFO - Using env: {'DISPLAY': ':0', 23:10:07 INFO - 'HOME': '/home/cltbld', 23:10:07 INFO - 'LANG': 'en_US.UTF-8', 23:10:07 INFO - 'LANGUAGE': 'en_US:en', 23:10:07 INFO - 'LOGNAME': 'cltbld', 23:10:07 INFO - 'MAIL': '/var/mail/cltbld', 23:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:07 INFO - 'MOZ_NO_REMOTE': '1', 23:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:07 INFO - 'NO_EM_RESTART': '1', 23:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:07 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:07 INFO - 'SHELL': '/bin/bash', 23:10:07 INFO - 'SHLVL': '1', 23:10:07 INFO - 'TERM': 'linux', 23:10:07 INFO - 'TMOUT': '86400', 23:10:07 INFO - 'USER': 'cltbld', 23:10:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:07 INFO - '_': '/tools/buildbot/bin/python'} 23:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 23:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 23:10:07 INFO - Cleaning up... 23:10:07 INFO - Return code: 0 23:10:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:10:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:10:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:10:07 INFO - Using env: {'DISPLAY': ':0', 23:10:07 INFO - 'HOME': '/home/cltbld', 23:10:07 INFO - 'LANG': 'en_US.UTF-8', 23:10:07 INFO - 'LANGUAGE': 'en_US:en', 23:10:07 INFO - 'LOGNAME': 'cltbld', 23:10:07 INFO - 'MAIL': '/var/mail/cltbld', 23:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:07 INFO - 'MOZ_NO_REMOTE': '1', 23:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:07 INFO - 'NO_EM_RESTART': '1', 23:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:07 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:07 INFO - 'SHELL': '/bin/bash', 23:10:07 INFO - 'SHLVL': '1', 23:10:07 INFO - 'TERM': 'linux', 23:10:07 INFO - 'TMOUT': '86400', 23:10:07 INFO - 'USER': 'cltbld', 23:10:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:07 INFO - '_': '/tools/buildbot/bin/python'} 23:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:08 INFO - Downloading/unpacking jsonschema 23:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 23:10:09 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:10:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:10 INFO - warning: no files found matching '*.txt' 23:10:10 INFO - no previously-included directories found matching 'build' 23:10:10 INFO - no previously-included directories found matching 'dist' 23:10:10 INFO - no previously-included directories found matching '.git*' 23:10:10 INFO - Installing collected packages: jsonschema, functools32 23:10:10 INFO - Running setup.py install for functools32 23:10:10 INFO - warning: no files found matching '*.txt' 23:10:10 INFO - no previously-included directories found matching 'build' 23:10:10 INFO - no previously-included directories found matching 'dist' 23:10:10 INFO - no previously-included directories found matching '.git*' 23:10:10 INFO - Successfully installed jsonschema functools32 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:10:10 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')]} 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 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')]} 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f2809f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1703360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, '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': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', '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 23:10:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 23:10:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 23:10:10 INFO - Using env: {'DISPLAY': ':0', 23:10:10 INFO - 'HOME': '/home/cltbld', 23:10:10 INFO - 'LANG': 'en_US.UTF-8', 23:10:10 INFO - 'LANGUAGE': 'en_US:en', 23:10:10 INFO - 'LOGNAME': 'cltbld', 23:10:10 INFO - 'MAIL': '/var/mail/cltbld', 23:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:10 INFO - 'MOZ_NO_REMOTE': '1', 23:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:10 INFO - 'NO_EM_RESTART': '1', 23:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:10 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:10 INFO - 'SHELL': '/bin/bash', 23:10:10 INFO - 'SHLVL': '1', 23:10:10 INFO - 'TERM': 'linux', 23:10:10 INFO - 'TMOUT': '86400', 23:10:10 INFO - 'USER': 'cltbld', 23:10:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:10 INFO - '_': '/tools/buildbot/bin/python'} 23:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:10 INFO - Downloading/unpacking flake8 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 23:10:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 23:10:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 23:10:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:10:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:12 INFO - no previously-included directories found matching 'docs/_build' 23:10:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:12 INFO - Running setup.py install for pep8 23:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:13 INFO - no previously-included directories found matching 'docs/_build' 23:10:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:10:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:13 INFO - Cleaning up... 23:10:13 INFO - Return code: 0 23:10:13 INFO - Running post-action listener: _resource_record_post_action 23:10:13 INFO - Running post-action listener: _start_resource_monitoring 23:10:13 INFO - Starting resource monitoring. 23:10:13 INFO - ##### 23:10:13 INFO - ##### Running install step. 23:10:13 INFO - ##### 23:10:13 INFO - Running pre-action listener: _resource_record_pre_action 23:10:13 INFO - Running main action method: install 23:10:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:10:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:10:13 INFO - Reading from file tmpfile_stdout 23:10:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:10:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:10:13 INFO - Reading from file tmpfile_stdout 23:10:13 INFO - Output received: 23:10:13 INFO - Usage: mozinstall [options] installer 23:10:13 INFO - Options: 23:10:13 INFO - -h, --help show this help message and exit 23:10:13 INFO - -d DEST, --destination=DEST 23:10:13 INFO - Directory to install application into. [default: 23:10:13 INFO - "/builds/slave/test-pgo"] 23:10:13 INFO - --app=APP Application being installed. [default: firefox] 23:10:13 INFO - mkdir: /builds/slave/test-pgo/build/application 23:10:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 23:10:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 23:10:29 INFO - Reading from file tmpfile_stdout 23:10:29 INFO - Output received: 23:10:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:10:29 INFO - Running post-action listener: _resource_record_post_action 23:10:29 INFO - ##### 23:10:29 INFO - ##### Running run-tests step. 23:10:29 INFO - ##### 23:10:29 INFO - Running pre-action listener: _resource_record_pre_action 23:10:29 INFO - Running main action method: run_tests 23:10:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:10:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:10:29 INFO - Python 2.7.3 23:10:29 INFO - Return code: 0 23:10:29 INFO - grabbing minidump binary from tooltool 23:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1792540>, '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 0x1793440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17938f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:10:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 23:10:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:10:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:29 INFO - Return code: 0 23:10:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:10:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:10:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:10:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:10:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:10:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:10:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:10:30 INFO - Return code: 0 23:10:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:10:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 23:10:30 INFO - Using env: {'DISPLAY': ':0', 23:10:30 INFO - 'HOME': '/home/cltbld', 23:10:30 INFO - 'LANG': 'en_US.UTF-8', 23:10:30 INFO - 'LANGUAGE': 'en_US:en', 23:10:30 INFO - 'LOGNAME': 'cltbld', 23:10:30 INFO - 'MAIL': '/var/mail/cltbld', 23:10:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:10:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:30 INFO - 'MOZ_NO_REMOTE': '1', 23:10:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:30 INFO - 'NO_EM_RESTART': '1', 23:10:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:10:30 INFO - 'PWD': '/builds/slave/test-pgo', 23:10:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:10:30 INFO - 'SHELL': '/bin/bash', 23:10:30 INFO - 'SHLVL': '1', 23:10:30 INFO - 'TERM': 'linux', 23:10:30 INFO - 'TMOUT': '86400', 23:10:30 INFO - 'USER': 'cltbld', 23:10:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983', 23:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:30 INFO - '_': '/tools/buildbot/bin/python'} 23:10:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 23:10:30 INFO - mozversion application_buildid: 20160113203303 23:10:30 INFO - mozversion application_changeset: efdb75b49dc877bd0858989d24da43bf7ce394be 23:10:30 INFO - mozversion application_display_name: Nightly 23:10:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:30 INFO - mozversion application_name: Firefox 23:10:30 INFO - mozversion application_remotingname: firefox 23:10:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:10:30 INFO - mozversion application_vendor: Mozilla 23:10:30 INFO - mozversion application_version: 46.0a1 23:10:30 INFO - mozversion platform_buildid: 20160113203303 23:10:30 INFO - mozversion platform_changeset: efdb75b49dc877bd0858989d24da43bf7ce394be 23:10:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:10:30 INFO - mozversion platform_version: 46.0a1 23:10:30 INFO - using testdate: 1452755430 23:10:30 INFO - actual date: 1452755430 23:10:30 INFO - starting webserver on 'localhost:43954' 23:10:30 INFO - SUITE-START | Running 3 tests 23:10:30 INFO - TEST-START | dromaeo_css 23:10:30 INFO - operating with platform_type : linux_ 23:10:30 INFO - Initialising browser for dromaeo_css test... 23:10:30 INFO - TEST-INFO | started process 22696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQB0N3S/profile http://localhost:43954/getInfo.html) 23:10:34 INFO - PROCESS | 22696 | __metrics Screen width/height:1600/1200 23:10:34 INFO - PROCESS | 22696 | colorDepth:24 23:10:34 INFO - PROCESS | 22696 | Browser inner width/height: 1024/697 23:10:34 INFO - PROCESS | 22696 | __metrics 23:10:34 INFO - PROCESS | 22696 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:34 INFO - PROCESS | 22696 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:35 INFO - TEST-INFO | 22696: exit 0 23:10:35 INFO - Browser initialized. 23:10:35 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:35 INFO - TEST-INFO | started process 22791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQB0N3S/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:47 INFO - PROCESS | 22791 | RSS: Main: 149868544 23:10:47 INFO - PROCESS | 22791 | 23:11:38 INFO - PROCESS | 22791 | 1452755498949 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] 23:13:46 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43954/tests/dromaeo/cssquery-ext.html) 23:13:48 INFO - PROCESS | 22791 | RSS: Main: 269512704 23:13:48 INFO - PROCESS | 22791 | 23:16:50 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-ext.html (next: http://localhost:43954/tests/dromaeo/cssquery-jquery.html) 23:16:51 INFO - PROCESS | 22791 | RSS: Main: 232316928 23:16:51 INFO - PROCESS | 22791 | 23:19:53 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43954/tests/dromaeo/cssquery-mootools.html) 23:19:53 INFO - PROCESS | 22791 | RSS: Main: 242622464 23:19:53 INFO - PROCESS | 22791 | 23:22:55 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43954/tests/dromaeo/cssquery-prototype.html) 23:22:56 INFO - PROCESS | 22791 | RSS: Main: 212660224 23:22:56 INFO - PROCESS | 22791 | 23:25:58 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43954/tests/dromaeo/cssquery-yui.html) 23:25:59 INFO - PROCESS | 22791 | RSS: Main: 212303872 23:25:59 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | Cycle 1(1): loaded http://localhost:43954/tests/dromaeo/cssquery-yui.html (next: http://localhost:43954/tests/dromaeo/cssquery-dojo.html) 23:29:02 INFO - PROCESS | 22791 | RSS: Main: 296673280 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | __start_tp_report 23:29:02 INFO - PROCESS | 22791 | _x_x_mozilla_page_load 23:29:02 INFO - PROCESS | 22791 | _x_x_mozilla_page_load_details 23:29:02 INFO - PROCESS | 22791 | |i|pagename|runs| 23:29:02 INFO - PROCESS | 22791 | |0;dojo.html;3088.474959256926;3091.0881290019443;3118.3763247350535;3130.029690795852;3160.9051728448153;5079.56823669988;5097.3373461450055;5107.719075450848;5143.408508021578;5149.047426226141;5111.872203194913;5195.688258704471;5198.974005129979;5201.687898726079;5207.3490813648295;4646.907061858769;4661.953380466186;4678.695884767496;4730.432348118214;4738.170820106485;4811.615070794345;4816.229403295473;4830;4831.106245344622;4870.9269360959615;4613.469451013143;4681.74250416227;4723.976380118112;4768.499307572724;4800.927986080212;4724.622030237572;4724.811007559693;4728.787204575802;4740.597049250783;4763.3807605011125;4687.390639216914;4714.882127946795;4722.079194557063;4727.125481785846;4735.573798358164;4895.853124406238;4968.3292755477905;5059.2916991621205;5136.126858434075;5155.072087024371;5517.5585953123655;5534.08687566551;5536.307961504812;5549.139883318092;5552.666839989613;5480.095784195603;5564.582656300794;5568.220449137124;5575.080111781551;5576.052071147915;5103.2855400244;5156.1750119981;5168.250603662448;5175.611829112831;5189.844304670828;5681.488666020078;5683.204351390808;5684.6589204647025;5705.5435565154685;5706.001449746278;5359.356877174764;5492.752826122754;5495.890082198333;5505.146702261156;5511.118221084607;5437.673739575559;5553.333599967949;5614.214010038598;5614.747336369873;5674.290713660793;5429.755660995264;5432.538234250054;5433.402325744165;5443.129099344086;5457.372402173722;5383.111786555253;5423.457654234545;5433.483819037185;5450.8909821803345;5479.0959491683425;4264.744115353026;4309.332053531708;4312.935305970413;4338.978305108518;4373.606375426227;3791.829367678461;3792.962070379316;3795.658390744791;3827.6746476549247;3828.349180639298;4990.600751939909;5094;5126;5138.691678499302;5186.40356359016;5468.125099983983;5526.696031718294;5529.142982837667;5533.170024496358;5551.9722401387735;5100.464451232567;5149.639525233272;5171.974140129275;5172.482751724798;5172.533983966494;4676.088162808288;4728.38530990969;4729.935764452971;4743.0988112258565;4770.332153498513;5590.692511911884;5756.050251708505;5809.9419005809405;5811.418858114239;5866.648001119861;5504.119340905436;5520.751566179451;5524.447555244444;5524.861878453071;5533.861653458695;5694.402087780889;5713.8285851424525;5728.627639203439;5738.799142030009;5772.595918285848;5469.535089517435;5477.1510415885605;5479.0685583451705;5493.121100623881;5539.916901246565;5378.058839703114;5433.9184912225555;5441.483059109379;5473.945260547343;5476.315460567429;5193.37679478465;5274.973625132004;5299.655522391032;5327.09439395296;5384.946150538602;5509.173623956439;5513.641613295123;5514.393416724077;5516.668999860021;5523.6685798852195;5393.865153371197;5411.107167317348;5416.079266524779;5418.972905135449;5456.727163641723;5403.5136837684795;5425.83722488326;5430.456954304538;5484.122540393678;5511.559075274049;5411.567074633941;5413.864653383697;5419.945800541944;5434.864128396822;5444.428335024923 23:29:02 INFO - PROCESS | 22791 | |1;ext.html;538.9326334208224;542.4494138449475;556.9693666848322;576.5733357315588;580.1500801326057;28445.573316400245;28887.566686499693;36220;36376.45435318466;36381;38201.23597528048;38260;38444.42333365002;38561.22877542455;38571.80714096432;8596.097409771994;8744.213020828125;8779.34154938379;8810.471371717686;8824.426412283181;8579.571021448934;8662.393632445732;8679.349048821332;8712.172343627377;8736.082711315285;8725.825483490325;8779;8809.251213646849;8812.515311657857;8824.823503529926;8664.436811607256;8753.212210901049;8756.299496040301;8756.518391488466;8764.517951512697;8601.655933762642;8774.605142768527;8779.604917778715;8781.07798681142;8786.384953053288;38446;38839.22321553553;38881;38909.22181556353;38944.805275973726;3221.4201443740117;3227.935441291161;3423;3540.522029526007;3608.4948107265004;26333.868330658417;26461;26607.206243344557;27512.724872751216;27644.86177569099;3236.401265765841;3241.6434192238835;3271.460209065501;3297.4559197732347;3377.4427219508752;265104;265215;266111;267633;268156;52765;53774.46225537773;59720.92372148329;60355;61265.69367153136;55765.442345576834;55814.16278755822;55870;56074.71962640161;56137.438625614035;15337.693246135015;15503;15531.378744850079;15537.611559711098;15551.611209719847;10749.892501075046;11042.503087361089;11048.116150707923;11076.501557429774;11292.209545331747;19340.226390944204;19482;19551.31570395058;19552.706709399372;19582.216711331672;7942.126366099725;8125.878111828328;8189.836203275901;8234.505929644241;8258.545779982038;928.5125309212717;935.2284365398573;961.077365728894;1028.1928685981468;1068.1348108032364;27908.302292442444;28055.57916631252;28145.859270703517;28249.293767655563;28311;1021.6475316015963;1052.936823790575;1063.872335319751;1071.052118874786;1071.566015763617;15737.213139342986;16247;16293.59266018359;16388.180590970405;16563.91718041426;391761;397042;399148;401914;402803;54092;54532;54591;54611.726941365036;54770;1338.2505796753849;1348.1237195822794;1364.304204855511;1370.095736813718;1374.8556401577691;28136.577951331157;28223.294417639725;29042;29363.85318073396;29519.85240073786;44290.11419771651;44633.55366446294;44675.329870051326;44689.77655111704;44725.32912006388;297405;299223;299584;300096;300814;27562.862185688944;28113.71886281193;30966.22584435407;31643.20891977719;31751.364972699954;35772.64227357797;36617.63382366249;38762.224755505296;38924.41613375858;39253.60746392499;33310.66689333173;37583.2483350326;38035.42946855855;38334.80832595819;38614.613853861105;32611.836940816094;35144.47283290804;35419.645803541636;36430;36455;32125.357492849544;32378;32707.509387359685;33287.83356083204;33313.500297496044;29143.85428072846;30094.09717708472;31421;32587.185320366232;32746.672533274363;31262;31545.8422707885;31654.841725791222;31698.207544811565;32190.678093219703 23:29:02 INFO - PROCESS | 22791 | |2;jquery.html;355.63369729178953;355.89494619207346;357.67987651052306;358.15475477872235;359.15060881016393;13555.25446100464;14067.296635168252;15581.532554023383;16246.187690615467;17403.738943915836;14937.253137343143;15015.249237538133;16000.439984600542;16001.599960001005;16023.359065637389;4942.827001054964;5324.760385782649;5327.121025030885;5329.493698098694;5330.200469929503;3967.543732470774;4086.7956602169775;5213.035588416136;5780.71096445176;6005.459508644221;5710.086386178213;5899.941000590004;5909.290885093773;5943.762249510036;5954.70226488676;5927.170196172539;5970.611910225822;5983.910241346383;5987.042073268278;5994.2806863176265;5095.464976177522;5192.948070519285;5215.295935048758;5247.86880327991;5257.580453277632;19273.614527709367;19453.9027304864;19495.707564386546;19910.303139390053;19956.70064949027;2067.3281183615236;2110.3457928042203;2209.679596458521;2285.645724912641;2459.913903013386;12555.560555380518;12620.621381358482;12860.678483037906;12891.742165156738;12920.095593308472;1804.6751584714746;1821.4171465131162;1882.2565086790778;1903.790583035865;1905.7998910114516;51485.74257128728;52055.47944520544;52681.20978185292;53309;53528.73235633836;9250.028746981605;9395.671151509801;9616;9625.181859541877;9685.37045092081;12726.300053497147;12788.93605531985;12804.871951280367;12807.438512297578;12809.743805123846;6881.13985751781;7036.261192574808;7051.823704407431;7114.07517022794;7121.71513139479;6676.49926255523;6685.498587605949;6777.322267773282;6781.321867813179;6829.282925292773;4153.54311025787;4261.360795880642;4345.34819777036;4368.497622773421;4389.100234451929;1726.0851748573277;1756.6223261998732;1793.6323053773945;1812.637472505504;1829.1128802530761;461.3932678527725;837.1252041616525;905.2441211588398;970.3935040599625;971.1842052675645;9593.28050396223;10196.949015254877;10519.42143182117;10669.73325666849;11114.388708621103;441.0495382450824;447.21960179487;450.74758135444256;453.42641558428613;466.9719816811002;9199.862002069975;9817.165540928958;9826.16477599412;9843.114119729116;9928.35465694742;485310;488567;496491;514549;556425;71542.64228678824;72206;72829;73906;74185;1124.1456493065166;1150.7525881935424;1158.1834806461593;1158.9594364197212;1167.7489339791985;14029.298535073409;14156.063573702988;15128.425893208061;15182.848171518584;15286.464973725866;29587.704122959356;29887;30145.24636884008;30699.693003069682;31932;36251.63748362483;36380;36909.26181476302;36916.81541592275;37555.2488950214;3028.424599326121;3029.954550681786;5554.472325129106;7040.295970402919;7283.069986453488;10110.828126865339;11002;11257.662270131908;11365;11391.259568128045;9032.729018129467;9140.817183656156;9481.09929556691;9583.377080489747;9682.515874206121;6972.616506092214;8918.152775486318;9551.283653726137;9579.856302155613;9672;7966;9125.133112354315;9246.907530924605;9286.860697089684;9337.393069450736;7115.501914865909;7238.493305468777;7290.927090729025;7291.744788932362;7300.12398512182;7704.8459030820195;9498.430094194371;9585.712428627152;9666.709998700051;9769.169620582046 23:29:02 INFO - PROCESS | 22791 | |3;mootools.html;1306.7909134538477;1483.4511230844587;1492.5298530962743;1634.427950217424;1795.6229191869706;7212.170600380958;7389.187189409161;7738.9226107738905;7888.290053895148;7898.921010789904;7944.602769861513;7944.801379965504;8046.476978996361;8057.838843223147;8060.838783224332;1965.272849045855;2007.6988451732211;2302.827287953406;2323.4307594639336;2324.476992676651;2317.918872839451;2362.0905951208824;2363.1374548289837;2363.361892289081;2364.6925899633025;2250.3923940536047;2267.2178098555974;2298.2186056740707;2300.723913130427;2309.872956987365;2264.62633665445;2276.112316196685;2281.840271181018;2314.259436980167;2321.2455951815728;2265.830062745301;2277.9976810203457;2286.416963674269;2288.599495088353;2306.2965795432387;8029.919700802976;8072.475289106248;8072.515649061075;8073.394495412867;8148.633311500997;4874.122657921573;4990.65065445419;5023.748812559394;5025.8240961566535;5027.698338099689;3009.623797025372;3051.61854768154;3066.110827859918;3083.367909578531;3100.2869340051916;930.9627614895396;931.2643012020563;950.4534892436807;964.7057647417535;965.1603105298365;11574.189806713533;11611;11612.767744645143;11616.419179041015;11631.418429078596;4444.733316000986;4486.66350023743;4555.931661025087;4556.430446194226;4568.063546972862;9777.41335519871;9781.559829807677;9792.608295668237;9800.166985806143;9806.117449429443;4921.163402221631;4925.187344088257;4932.482089380564;4934.777934992934;4936.284238785428;4395.120975804852;4414.779261036935;4441.444819397575;4444.8444304449185;4456.554344565582;3510.297940411877;3546.8758593449106;3668.3580373434543;3707.758995665327;3719.814009299524;1145.9484323205477;1185.531714972581;1191.2257032928667;1194.856617205941;1200.0759415250209;1039.4698703661036;1060.3637817309707;1060.8939106089483;1162.7151347919814;1282.8332316798942;7016.403605693471;7020.262872398427;7065.82335441618;7073.575585464889;7077.150741911004;1088.8693356797235;1095.8301463273206;1096.1997741648481;1098.2970898624726;1100.1913593508764;5466.125419932791;5518.972405138029;5545.750441230154;5577.024020796344;5595.608307418523;9306.162445379949;9619.51902404877;9702.563384647709;9768.218542516724;10156.746081348025;9458.90541094594;9499.572519236652;9645.131938125602;9655.565499552396;9656.613735450503;7583.27958843909;7592.582407967615;7616.200298968639;7642.7325043623205;7650.19672934345;7433.628318584158;7451.2921272479025;7483.850322993619;7497;7521.7743467696055;8770.605322760364;8841.336899732418;8983.685571004984;9140.725778226664;9155.038720934472;9159.900811902615;9294.25645948336;9387.061293870558;9399.765005874908;9412.576434060347;7312.634368281671;7426.925730742623;7429.702811887464;7438.367738742051;7445.4043676506835;6947.861042779015;7119.786406407816;7489.70041198346;7691.692332306869;7692.92307076922;7227.843989705835;7323;7337.779866604011;7408;7453.068366454193;7027.61348125858;7170.96414517924;7194.4244460442;7207.819804504719;7410.258974102547;6772.695228714621;6805.251422343637;6855.245922948571;6896.069030680995;6921.342472465108;6181.783637572664;6404.615723056445;6406;6406.135171751754;6411.3909178627955;6453.483721302378;6490.870182596416;6521.445677117498;6535.215774107138;6537.901931471127 23:29:02 INFO - PROCESS | 22791 | |4;prototype.html;335.66936567481036;336.3777012526826;341.97948123112616;345.09412791422517;351.61322545200267;5663.461971112738;5787.392323806003;5861.941380586198;5879.735411906464;5899.734511946962;5598.076317407633;5746.913796293059;5762.711864406773;5784.913226301598;5794.420557944203;4542;4544.84093056743;4545.431821022372;4554.70394424363;4558.749268790215;4323.589259020404;4394.780260986954;4420.955790442086;4513.864584062483;4548.204064288753;4488.057507923324;4498.055408364231;4503.256962601167;4521.050579378318;4528.637708983273;4494.887627809315;4497.887552811173;4500.392447019643;4503.774811259424;4512.187806194884;3964.8017599120217;3964.8215830287704;3965.5836137205465;3978.1645854370618;3980.144268982154;5389.622726409153;5478.616496845182;5496.560275178016;5525.475079867447;5567.749451274703;5116.590672746209;5148.768305426265;5159.251908473288;5160.14857548504;5162.277281180638;5835.445632664932;6118.204633397674;6151.138840562325;6161.599496032743;6163.722632481549;4217.8523751668545;4227.661787057028;4324.8486302979245;4338.045629961403;4342.305231162999;6334.87330253397;6395.584287021329;6400.487960963112;6420.036994450823;6428.774992875227;4412.602865742035;4427.6236519896165;4429.557044295545;4433.711808732486;4441.156180325728;4333.978330108329;4468.553144685506;4482.618977386958;4483.215437298525;4508.030773383738;5161.354830646169;5171.663841850268;5171.922421163686;5179.2749015137915;5179.326687530673;6187.288461826857;6191.071339299141;6192.690365481708;6193.473554747897;6194.287656919422;1549.4809238905093;1584.1128967777852;1585.5005673212902;1585.5322679809483;1585.9207039647972;1063.8244689626124;1064.6539874540651;1067.3595842494597;1074.049466222399;1091.2361347057092;5875.148103525051;5875.20684707559;5880.617759845596;5881.147233651182;5886.23478947734;6353.078803573549;6359.650219237987;6361.840953976095;6363.5863668861375;6366.6180029198395;5846.883062338729;5863.149843272787;5868.061110222344;5871.442212989759;5871.882562348729;3297.3405318936307;3419.9658003420145;3424.195314101184;3424.6061702904485;3425.5889293284467;6591.901121483182;6599.307072757388;6610.2398224204835;6610.570312929741;6619.86760264792;6478.060681201294;6480.708368123445;6516.57642253252;6521.9673901630185;6528.738850446024;6457.096006559085;6580.539362244597;6690.598564086073;6705.564138330993;6707.1616047994;6131.754729810757;6301.96849015752;6398.424141827258;6420.582662126947;6430.713857228479;6178;6221.377862213742;6307.716152773044;6317.147185130132;6317.747290108344;6640.468762499085;6653.767118150841;6678.632675202911;6679;6682.465402767864;4279.636230920407;4406.140802543473;4485.192665320274;4493.460784705856;4494.707843990261;6270.435660790551;6312.14786003902;6363.872722545616;6366.331535188739;6372.617642941438;6163.1679723238585;6174.166487524307;6189.381061893775;6191.81424557264;6192.845178870564;6032;6162.07568864656;6166.105914642262;6167.537434692326;6171.444569988723;6117.357677443804;6136.846578835565;6140.754369825157;6144.446999770043;6148.44663980244;6260.280067792262;6276.968615156895;6285.057241413824;6285.277193122849;6287.30839607652;5925.01511993487;6087.908681369694;6121.0818377241985;6133.938660613337;6144.508439324933 23:29:02 INFO - PROCESS | 22791 | |5;yui.html;730.0254160695468;736.6574542837579;745.9477836551443;773.2422226218304;842.410312781053;13414.530491432803;13559.254241016752;13560.118592291494;13565.66085847853;13598.116122452033;11664.183507154503;11753.177277590572;11791.351475668835;11794.823077653842;11813.881861181386;665.3579295979379;678.9524733268673;794.2097612875168;803.3934379543437;808.8463191993532;789.6288744290174;794.0828343263511;795.1571334385541;795.5107608820563;795.8090058386003;691.1498856406623;844.1853611265128;846.7502086884384;846.9618867150962;847.0851480401183;694.694334492824;820.6471217376526;837.8910741603553;839.0895877972407;842.9747107586783;618.6350053468475;623.2085251730277;623.2552100240215;623.4731651754261;623.9001759718469;12102.455389507493;12138.271703697807;12158.51365945361;12165.330906800122;12194;12221.266723996589;12607.621771346874;12865.935670321682;12956.287404192766;13021.088523803337;10079.143272821819;10114.949425252827;10284.845727314096;10851.240413171081;10859.619913303075;3552.6980206682465;3646.3436581415335;3676;3721.702263818915;3728.3102626014274;49137.26294105591;49530.25704614434;49584.256236156485;49858;50257.24614130791;9260.953695231481;9576.329656924088;9644.228461723045;9689.951550242204;9767.218622510181;17072.061036643103;17078.914605426893;17086.40197593078;17095.572610684583;17107.657846842994;7196.46026548011;7221.89167162493;7250.564966101945;7516.24837516255;7604.8479030420185;4177.958220417757;4230.70385073042;4270.274053410928;4275.87172384829;4295.162443323585;3105.052958847528;3114.408262430131;3116.875324986975;3122.8438578071004;3129.4992801151707;559.046825163096;575.9654420734769;580.8025271407741;596.9761209551656;599.6641880546907;474.91688954432834;486.90505351456835;552.8473133516662;577.3216470646973;598.3328588623654;7387.519811212254;7390.002349682832;7483.326500614862;7688.769336919901;7702.383809295243;541.5613353183934;556.4463358957782;556.4991507643073;573.9024365857814;654.9377809108128;3418.1454636340914;3493.982530087333;3523.119220194951;3623.61951995042;3675.0996005978172;48829;49699.75150124299;50074.749626251636;51483.227751583756;52070.21894671583;47771.28343074787;49214;49389.75305123451;49600;49674.75162624164;43526.34710479345;43792.343114853305;43913.34129988053;44688.776556117664;45229;7286.307800758919;7298.160711518243;7902.802429939297;8045.839083218186;8266.338692904674;32294.83852580722;32382.514262286557;32609;33093.50359744654;34938.65061349354;43061.138777223656;43336.783316083216;44081.11837763291;44156.11687766291;44814.55185448104;10217.386956782617;10525.36847789135;10619.044286013986;10679.19906007037;11032.393218372745;11472.541098355972;11609.941950290533;11637.941810290895;11695.707607309545;11928.76142477163;10173;10558.788824223318;10680;10756.784864302826;10877.728056798644;10981.560737570728;11059.281146725438;11099.27854689475;11171;11178.385188814367;10323.380597164194;10775.191860610643;11128.332300062022;11363.147763917905;11482.885171148182;9224.677136300197;9253.953730231306;9389.765255868659;9690.75773105678;9902.257330700082;7710.8843367350655;8438.493690378597;8447.281981031681;8667.696630617898;8680.652773888974 23:29:02 INFO - PROCESS | 22791 | __end_tp_report 23:29:02 INFO - PROCESS | 22791 | __start_cc_report 23:29:02 INFO - PROCESS | 22791 | _x_x_mozilla_cycle_collect,991 23:29:02 INFO - PROCESS | 22791 | __end_cc_report 23:29:02 INFO - PROCESS | 22791 | __startTimestamp1452756542380__endTimestamp 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | ------- Summary: start ------- 23:29:02 INFO - PROCESS | 22791 | Number of tests: 6 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#0] dojo.html Cycles:165 Average:5142.95 Median:5384.95 stddev:562.42 (10.4%) stddev-sans-first:540.56 23:29:02 INFO - PROCESS | 22791 | Values: 3088.5 3091.1 3118.4 3130.0 3160.9 5079.6 5097.3 5107.7 5143.4 5149.0 5111.9 5195.7 5199.0 5201.7 5207.3 4646.9 4662.0 4678.7 4730.4 4738.2 4811.6 4816.2 4830.0 4831.1 4870.9 4613.5 4681.7 4724.0 4768.5 4800.9 4724.6 4724.8 4728.8 4740.6 4763.4 4687.4 4714.9 4722.1 4727.1 4735.6 4895.9 4968.3 5059.3 5136.1 5155.1 5517.6 5534.1 5536.3 5549.1 5552.7 5480.1 5564.6 5568.2 5575.1 5576.1 5103.3 5156.2 5168.3 5175.6 5189.8 5681.5 5683.2 5684.7 5705.5 5706.0 5359.4 5492.8 5495.9 5505.1 5511.1 5437.7 5553.3 5614.2 5614.7 5674.3 5429.8 5432.5 5433.4 5443.1 5457.4 5383.1 5423.5 5433.5 5450.9 5479.1 4264.7 4309.3 4312.9 4339.0 4373.6 3791.8 3793.0 3795.7 3827.7 3828.3 4990.6 5094.0 5126.0 5138.7 5186.4 5468.1 5526.7 5529.1 5533.2 5552.0 5100.5 5149.6 5172.0 5172.5 5172.5 4676.1 4728.4 4729.9 4743.1 4770.3 5590.7 5756.1 5809.9 5811.4 5866.6 5504.1 5520.8 5524.4 5524.9 5533.9 5694.4 5713.8 5728.6 5738.8 5772.6 5469.5 5477.2 5479.1 5493.1 5539.9 5378.1 5433.9 5441.5 5473.9 5476.3 5193.4 5275.0 5299.7 5327.1 5384.9 5509.2 5513.6 5514.4 5516.7 5523.7 5393.9 5411.1 5416.1 5419.0 5456.7 5403.5 5425.8 5430.5 5484.1 5511.6 5411.6 5413.9 5419.9 5434.9 5444.4 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#1] ext.html Cycles:180 Average:48113.36 Median:19480.08 stddev:85796.92 (440.4%) stddev-sans-first:85963.24 23:29:02 INFO - PROCESS | 22791 | Values: 538.9 542.4 557.0 576.6 580.2 28445.6 28887.6 36220.0 36376.5 36381.0 38201.2 38260.0 38444.4 38561.2 38571.8 8596.1 8744.2 8779.3 8810.5 8824.4 8579.6 8662.4 8679.3 8712.2 8736.1 8725.8 8779.0 8809.3 8812.5 8824.8 8664.4 8753.2 8756.3 8756.5 8764.5 8601.7 8774.6 8779.6 8781.1 8786.4 38446.0 38839.2 38881.0 38909.2 38944.8 3221.4 3227.9 3423.0 3540.5 3608.5 26333.9 26461.0 26607.2 27512.7 27644.9 3236.4 3241.6 3271.5 3297.5 3377.4 265104.0 265215.0 266111.0 267633.0 268156.0 52765.0 53774.5 59720.9 60355.0 61265.7 55765.4 55814.2 55870.0 56074.7 56137.4 15337.7 15503.0 15531.4 15537.6 15551.6 10749.9 11042.5 11048.1 11076.5 11292.2 19340.2 19482.0 19551.3 19552.7 19582.2 7942.1 8125.9 8189.8 8234.5 8258.5 928.5 935.2 961.1 1028.2 1068.1 27908.3 28055.6 28145.9 28249.3 28311.0 1021.6 1052.9 1063.9 1071.1 1071.6 15737.2 16247.0 16293.6 16388.2 16563.9 391761.0 397042.0 399148.0 401914.0 402803.0 54092.0 54532.0 54591.0 54611.7 54770.0 1338.3 1348.1 1364.3 1370.1 1374.9 28136.6 28223.3 29042.0 29363.9 29519.9 44290.1 44633.6 44675.3 44689.8 44725.3 297405.0 299223.0 299584.0 300096.0 300814.0 27562.9 28113.7 30966.2 31643.2 31751.4 35772.6 36617.6 38762.2 38924.4 39253.6 33310.7 37583.2 38035.4 38334.8 38614.6 32611.8 35144.5 35419.6 36430.0 36455.0 32125.4 32378.0 32707.5 33287.8 33313.5 29143.9 30094.1 31421.0 32587.2 32746.7 31262.0 31545.8 31654.8 31698.2 32190.7 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#2] jquery.html Cycles:180 Average:25992.22 Median:246754.91 stddev:83162.70 (33.7%) stddev-sans-first:83373.71 23:29:02 INFO - PROCESS | 22791 | Values: 355.6 355.9 357.7 358.2 359.2 13555.3 14067.3 15581.5 16246.2 17403.7 14937.3 15015.2 16000.4 16001.6 16023.4 4942.8 5324.8 5327.1 5329.5 5330.2 3967.5 4086.8 5213.0 5780.7 6005.5 5710.1 5899.9 5909.3 5943.8 5954.7 5927.2 5970.6 5983.9 5987.0 5994.3 5095.5 5192.9 5215.3 5247.9 5257.6 19273.6 19453.9 19495.7 19910.3 19956.7 2067.3 2110.3 2209.7 2285.6 2459.9 12555.6 12620.6 12860.7 12891.7 12920.1 1804.7 1821.4 1882.3 1903.8 1905.8 51485.7 52055.5 52681.2 53309.0 53528.7 9250.0 9395.7 9616.0 9625.2 9685.4 12726.3 12788.9 12804.9 12807.4 12809.7 6881.1 7036.3 7051.8 7114.1 7121.7 6676.5 6685.5 6777.3 6781.3 6829.3 4153.5 4261.4 4345.3 4368.5 4389.1 1726.1 1756.6 1793.6 1812.6 1829.1 461.4 837.1 905.2 970.4 971.2 9593.3 10196.9 10519.4 10669.7 11114.4 441.0 447.2 450.7 453.4 467.0 9199.9 9817.2 9826.2 9843.1 9928.4 485310.0 488567.0 496491.0 514549.0 556425.0 71542.6 72206.0 72829.0 73906.0 74185.0 1124.1 1150.8 1158.2 1159.0 1167.7 14029.3 14156.1 15128.4 15182.8 15286.5 29587.7 29887.0 30145.2 30699.7 31932.0 36251.6 36380.0 36909.3 36916.8 37555.2 3028.4 3030.0 5554.5 7040.3 7283.1 10110.8 11002.0 11257.7 11365.0 11391.3 9032.7 9140.8 9481.1 9583.4 9682.5 6972.6 8918.2 9551.3 9579.9 9672.0 7966.0 9125.1 9246.9 9286.9 9337.4 7115.5 7238.5 7290.9 7291.7 7300.1 7704.8 9498.4 9585.7 9666.7 9769.2 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#3] mootools.html Cycles:180 Average:5620.36 Median:6432.44 stddev:2988.55 (46.5%) stddev-sans-first:2979.34 23:29:02 INFO - PROCESS | 22791 | Values: 1306.8 1483.5 1492.5 1634.4 1795.6 7212.2 7389.2 7738.9 7888.3 7898.9 7944.6 7944.8 8046.5 8057.8 8060.8 1965.3 2007.7 2302.8 2323.4 2324.5 2317.9 2362.1 2363.1 2363.4 2364.7 2250.4 2267.2 2298.2 2300.7 2309.9 2264.6 2276.1 2281.8 2314.3 2321.2 2265.8 2278.0 2286.4 2288.6 2306.3 8029.9 8072.5 8072.5 8073.4 8148.6 4874.1 4990.7 5023.7 5025.8 5027.7 3009.6 3051.6 3066.1 3083.4 3100.3 931.0 931.3 950.5 964.7 965.2 11574.2 11611.0 11612.8 11616.4 11631.4 4444.7 4486.7 4555.9 4556.4 4568.1 9777.4 9781.6 9792.6 9800.2 9806.1 4921.2 4925.2 4932.5 4934.8 4936.3 4395.1 4414.8 4441.4 4444.8 4456.6 3510.3 3546.9 3668.4 3707.8 3719.8 1145.9 1185.5 1191.2 1194.9 1200.1 1039.5 1060.4 1060.9 1162.7 1282.8 7016.4 7020.3 7065.8 7073.6 7077.2 1088.9 1095.8 1096.2 1098.3 1100.2 5466.1 5519.0 5545.8 5577.0 5595.6 9306.2 9619.5 9702.6 9768.2 10156.7 9458.9 9499.6 9645.1 9655.6 9656.6 7583.3 7592.6 7616.2 7642.7 7650.2 7433.6 7451.3 7483.9 7497.0 7521.8 8770.6 8841.3 8983.7 9140.7 9155.0 9159.9 9294.3 9387.1 9399.8 9412.6 7312.6 7426.9 7429.7 7438.4 7445.4 6947.9 7119.8 7489.7 7691.7 7692.9 7227.8 7323.0 7337.8 7408.0 7453.1 7027.6 7171.0 7194.4 7207.8 7410.3 6772.7 6805.3 6855.2 6896.1 6921.3 6181.8 6404.6 6406.0 6406.1 6411.4 6453.5 6490.9 6521.4 6535.2 6537.9 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#4] prototype.html Cycles:180 Average:5174.58 Median:5865.61 stddev:1546.29 (26.4%) stddev-sans-first:1507.37 23:29:02 INFO - PROCESS | 22791 | Values: 335.7 336.4 342.0 345.1 351.6 5663.5 5787.4 5861.9 5879.7 5899.7 5598.1 5746.9 5762.7 5784.9 5794.4 4542.0 4544.8 4545.4 4554.7 4558.7 4323.6 4394.8 4421.0 4513.9 4548.2 4488.1 4498.1 4503.3 4521.1 4528.6 4494.9 4497.9 4500.4 4503.8 4512.2 3964.8 3964.8 3965.6 3978.2 3980.1 5389.6 5478.6 5496.6 5525.5 5567.7 5116.6 5148.8 5159.3 5160.1 5162.3 5835.4 6118.2 6151.1 6161.6 6163.7 4217.9 4227.7 4324.8 4338.0 4342.3 6334.9 6395.6 6400.5 6420.0 6428.8 4412.6 4427.6 4429.6 4433.7 4441.2 4334.0 4468.6 4482.6 4483.2 4508.0 5161.4 5171.7 5171.9 5179.3 5179.3 6187.3 6191.1 6192.7 6193.5 6194.3 1549.5 1584.1 1585.5 1585.5 1585.9 1063.8 1064.7 1067.4 1074.0 1091.2 5875.1 5875.2 5880.6 5881.1 5886.2 6353.1 6359.7 6361.8 6363.6 6366.6 5846.9 5863.1 5868.1 5871.4 5871.9 3297.3 3420.0 3424.2 3424.6 3425.6 6591.9 6599.3 6610.2 6610.6 6619.9 6478.1 6480.7 6516.6 6522.0 6528.7 6457.1 6580.5 6690.6 6705.6 6707.2 6131.8 6302.0 6398.4 6420.6 6430.7 6178.0 6221.4 6307.7 6317.1 6317.7 6640.5 6653.8 6678.6 6679.0 6682.5 4279.6 4406.1 4485.2 4493.5 4494.7 6270.4 6312.1 6363.9 6366.3 6372.6 6163.2 6174.2 6189.4 6191.8 6192.8 6032.0 6162.1 6166.1 6167.5 6171.4 6117.4 6136.8 6140.8 6144.4 6148.4 6260.3 6277.0 6285.1 6285.3 6287.3 5925.0 6087.9 6121.1 6133.9 6144.5 23:29:02 INFO - PROCESS | 22791 | 23:29:02 INFO - PROCESS | 22791 | [#5] yui.html Cycles:180 Average:13169.10 Median:24123.10 stddev:15209.79 (63.1%) stddev-sans-first:15223.78 23:29:02 INFO - PROCESS | 22791 | Values: 730.0 736.7 745.9 773.2 842.4 13414.5 13559.3 13560.1 13565.7 13598.1 11664.2 11753.2 11791.4 11794.8 11813.9 665.4 679.0 794.2 803.4 808.8 789.6 794.1 795.2 795.5 795.8 691.1 844.2 846.8 847.0 847.1 694.7 820.6 837.9 839.1 843.0 618.6 623.2 623.3 623.5 623.9 12102.5 12138.3 12158.5 12165.3 12194.0 12221.3 12607.6 12865.9 12956.3 13021.1 10079.1 10114.9 10284.8 10851.2 10859.6 3552.7 3646.3 3676.0 3721.7 3728.3 49137.3 49530.3 49584.3 49858.0 50257.2 9261.0 9576.3 9644.2 9690.0 9767.2 17072.1 17078.9 17086.4 17095.6 17107.7 7196.5 7221.9 7250.6 7516.2 7604.8 4178.0 4230.7 4270.3 4275.9 4295.2 3105.1 3114.4 3116.9 3122.8 3129.5 559.0 576.0 580.8 597.0 599.7 474.9 486.9 552.8 577.3 598.3 7387.5 7390.0 7483.3 7688.8 7702.4 541.6 556.4 556.5 573.9 654.9 3418.1 3494.0 3523.1 3623.6 3675.1 48829.0 49699.8 50074.7 51483.2 52070.2 47771.3 49214.0 49389.8 49600.0 49674.8 43526.3 43792.3 43913.3 44688.8 45229.0 7286.3 7298.2 7902.8 8045.8 8266.3 32294.8 32382.5 32609.0 33093.5 34938.7 43061.1 43336.8 44081.1 44156.1 44814.6 10217.4 10525.4 10619.0 10679.2 11032.4 11472.5 11609.9 11637.9 11695.7 11928.8 10173.0 10558.8 10680.0 10756.8 10877.7 10981.6 11059.3 11099.3 11171.0 11178.4 10323.4 10775.2 11128.3 11363.1 11482.9 9224.7 9254.0 9389.8 9690.8 9902.3 7710.9 8438.5 8447.3 8667.7 8680.7 23:29:02 INFO - PROCESS | 22791 | -------- Summary: end -------- 23:29:02 INFO - PROCESS | 22791 | 23:29:03 INFO - TEST-INFO | 22791: exit 0 23:29:03 INFO - TEST-OK | dromaeo_css | took 1112381ms 23:29:03 INFO - TEST-START | kraken 23:29:03 INFO - operating with platform_type : linux_ 23:29:03 INFO - Initialising browser for kraken test... 23:29:03 INFO - TEST-INFO | started process 22985 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5LXn3X/profile http://localhost:43954/getInfo.html) 23:29:07 INFO - PROCESS | 22985 | __metrics Screen width/height:1600/1200 23:29:07 INFO - PROCESS | 22985 | colorDepth:24 23:29:07 INFO - PROCESS | 22985 | Browser inner width/height: 1024/697 23:29:07 INFO - PROCESS | 22985 | __metrics 23:29:07 INFO - PROCESS | 22985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:29:07 INFO - PROCESS | 22985 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:29:08 INFO - TEST-INFO | 22985: exit 0 23:29:08 INFO - Browser initialized. 23:29:08 INFO - Running cycle 1/1 for kraken test... 23:29:08 INFO - TEST-INFO | started process 23065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5LXn3X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:19 INFO - PROCESS | 23065 | RSS: Main: 149938176 23:29:19 INFO - PROCESS | 23065 | 23:29:22 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43954/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:22 INFO - PROCESS | 23065 | RSS: Main: 188448768 23:29:22 INFO - PROCESS | 23065 | 23:29:25 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43954/tests/kraken/driver.html?testName=audio-dft) 23:29:26 INFO - PROCESS | 23065 | RSS: Main: 177377280 23:29:26 INFO - PROCESS | 23065 | 23:29:28 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43954/tests/kraken/driver.html?testName=audio-fft) 23:29:29 INFO - PROCESS | 23065 | RSS: Main: 161804288 23:29:29 INFO - PROCESS | 23065 | 23:29:31 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43954/tests/kraken/driver.html?testName=audio-oscillator) 23:29:32 INFO - PROCESS | 23065 | RSS: Main: 163917824 23:29:32 INFO - PROCESS | 23065 | 23:29:34 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43954/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:34 INFO - PROCESS | 23065 | RSS: Main: 165732352 23:29:34 INFO - PROCESS | 23065 | 23:29:37 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43954/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:38 INFO - PROCESS | 23065 | RSS: Main: 166600704 23:29:38 INFO - PROCESS | 23065 | 23:29:41 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43954/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:42 INFO - PROCESS | 23065 | RSS: Main: 167591936 23:29:42 INFO - PROCESS | 23065 | 23:29:45 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43954/tests/kraken/driver.html?testName=json-parse-financial) 23:29:45 INFO - PROCESS | 23065 | RSS: Main: 165801984 23:29:45 INFO - PROCESS | 23065 | 23:29:47 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43954/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:47 INFO - PROCESS | 23065 | RSS: Main: 178384896 23:29:47 INFO - PROCESS | 23065 | 23:29:49 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:50 INFO - PROCESS | 23065 | RSS: Main: 176234496 23:29:50 INFO - PROCESS | 23065 | 23:29:52 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:52 INFO - PROCESS | 23065 | RSS: Main: 180695040 23:29:52 INFO - PROCESS | 23065 | 23:29:55 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:55 INFO - PROCESS | 23065 | RSS: Main: 189399040 23:29:55 INFO - PROCESS | 23065 | 23:29:58 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:58 INFO - PROCESS | 23065 | RSS: Main: 190070784 23:29:58 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | Cycle 1(1): loaded http://localhost:43954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43954/tests/kraken/driver.html?testName=ai-astar) 23:30:00 INFO - PROCESS | 23065 | RSS: Main: 247422976 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | __start_tp_report 23:30:00 INFO - PROCESS | 23065 | _x_x_mozilla_page_load 23:30:00 INFO - PROCESS | 23065 | _x_x_mozilla_page_load_details 23:30:00 INFO - PROCESS | 23065 | |i|pagename|runs| 23:30:00 INFO - PROCESS | 23065 | |0;ai-astar;110;110;109;109;112;112;99;109;111;109 23:30:00 INFO - PROCESS | 23065 | |1;audio-beat-detection;151;123;147;161;128;155;149;124;167;124 23:30:00 INFO - PROCESS | 23065 | |2;audio-dft;160;161;161;165;162;162;162;163;162;163 23:30:00 INFO - PROCESS | 23065 | |3;audio-fft;71;72;97;97;74;76;72;112;97;71 23:30:00 INFO - PROCESS | 23065 | |4;audio-oscillator;95;96;144;96;97;96;140;97;96;137 23:30:00 INFO - PROCESS | 23065 | |5;imaging-gaussian-blur;110;110;110;109;109;109;109;109;109;109 23:30:00 INFO - PROCESS | 23065 | |6;imaging-darkroom;147;145;146;145;145;146;145;145;146;145 23:30:00 INFO - PROCESS | 23065 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 23:30:00 INFO - PROCESS | 23065 | |8;json-parse-financial;56;55;55;56;54;56;57;65;53;53 23:30:00 INFO - PROCESS | 23065 | |9;json-stringify-tinderbox;66;67;67;67;68;68;67;67;67;67 23:30:00 INFO - PROCESS | 23065 | |10;stanford-crypto-aes;82;80;84;89;91;83;83;85;82;82 23:30:00 INFO - PROCESS | 23065 | |11;stanford-crypto-ccm;113;116;114;122;119;129;123;123;116;123 23:30:00 INFO - PROCESS | 23065 | |12;stanford-crypto-pbkdf2;156;140;149;153;154;144;149;149;147;148 23:30:00 INFO - PROCESS | 23065 | |13;stanford-crypto-sha256-iterative;70;70;67;68;67;65;66;67;65;69 23:30:00 INFO - PROCESS | 23065 | __end_tp_report 23:30:00 INFO - PROCESS | 23065 | __start_cc_report 23:30:00 INFO - PROCESS | 23065 | _x_x_mozilla_cycle_collect,959 23:30:00 INFO - PROCESS | 23065 | __end_cc_report 23:30:00 INFO - PROCESS | 23065 | __startTimestamp1452756600800__endTimestamp 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | ------- Summary: start ------- 23:30:00 INFO - PROCESS | 23065 | Number of tests: 14 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.71 (3.4%) stddev-sans-first:3.92 23:30:00 INFO - PROCESS | 23065 | Values: 110.0 110.0 109.0 109.0 112.0 112.0 99.0 109.0 111.0 109.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.00 stddev:16.69 (11.1%) stddev-sans-first:17.44 23:30:00 INFO - PROCESS | 23065 | Values: 151.0 123.0 147.0 161.0 128.0 155.0 149.0 124.0 167.0 124.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.22 23:30:00 INFO - PROCESS | 23065 | Values: 160.0 161.0 161.0 165.0 162.0 162.0 162.0 163.0 162.0 163.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#3] audio-fft Cycles:10 Average:83.90 Median:75.00 stddev:15.21 (20.3%) stddev-sans-first:15.39 23:30:00 INFO - PROCESS | 23065 | Values: 71.0 72.0 97.0 97.0 74.0 76.0 72.0 112.0 97.0 71.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:96.00 stddev:21.42 (22.3%) stddev-sans-first:22.07 23:30:00 INFO - PROCESS | 23065 | Values: 95.0 96.0 144.0 96.0 97.0 96.0 140.0 97.0 96.0 137.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 23:30:00 INFO - PROCESS | 23065 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 23:30:00 INFO - PROCESS | 23065 | Values: 147.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:30:00 INFO - PROCESS | 23065 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:3.43 (6.1%) stddev-sans-first:3.64 23:30:00 INFO - PROCESS | 23065 | Values: 56.0 55.0 55.0 56.0 54.0 56.0 57.0 65.0 53.0 53.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 23:30:00 INFO - PROCESS | 23065 | Values: 66.0 67.0 67.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.41 (4.1%) stddev-sans-first:3.54 23:30:00 INFO - PROCESS | 23065 | Values: 82.0 80.0 84.0 89.0 91.0 83.0 83.0 85.0 82.0 82.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#11] stanford-crypto-ccm Cycles:10 Average:119.80 Median:122.50 stddev:5.05 (4.1%) stddev-sans-first:4.72 23:30:00 INFO - PROCESS | 23065 | Values: 113.0 116.0 114.0 122.0 119.0 129.0 123.0 123.0 116.0 123.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:149.00 stddev:4.72 (3.2%) stddev-sans-first:4.26 23:30:00 INFO - PROCESS | 23065 | Values: 156.0 140.0 149.0 153.0 154.0 144.0 149.0 149.0 147.0 148.0 23:30:00 INFO - PROCESS | 23065 | 23:30:00 INFO - PROCESS | 23065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.84 (2.7%) stddev-sans-first:1.69 23:30:00 INFO - PROCESS | 23065 | Values: 70.0 70.0 67.0 68.0 67.0 65.0 66.0 67.0 65.0 69.0 23:30:00 INFO - PROCESS | 23065 | -------- Summary: end -------- 23:30:00 INFO - PROCESS | 23065 | 23:30:01 INFO - TEST-INFO | 23065: exit 0 23:30:01 INFO - TEST-OK | kraken | took 58678ms 23:30:01 INFO - TEST-START | v8_7 23:30:01 INFO - operating with platform_type : linux_ 23:30:01 INFO - Initialising browser for v8_7 test... 23:30:01 INFO - TEST-INFO | started process 23314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplZ1jFc/profile http://localhost:43954/getInfo.html) 23:30:05 INFO - PROCESS | 23314 | __metrics Screen width/height:1600/1200 23:30:05 INFO - PROCESS | 23314 | colorDepth:24 23:30:05 INFO - PROCESS | 23314 | Browser inner width/height: 1024/697 23:30:05 INFO - PROCESS | 23314 | __metrics 23:30:05 INFO - PROCESS | 23314 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:30:05 INFO - PROCESS | 23314 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:06 INFO - TEST-INFO | 23314: exit 0 23:30:06 INFO - Browser initialized. 23:30:06 INFO - Running cycle 1/1 for v8_7 test... 23:30:06 INFO - TEST-INFO | started process 23401 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplZ1jFc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:18 INFO - PROCESS | 23401 | RSS: Main: 149327872 23:30:18 INFO - PROCESS | 23401 | 23:30:40 INFO - PROCESS | 23401 | Cycle 1(1): loaded http://localhost:43954/tests/v8_7/run.html (next: http://localhost:43954/tests/v8_7/run.html) 23:30:41 INFO - PROCESS | 23401 | RSS: Main: 522633216 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | __start_tp_report 23:30:41 INFO - PROCESS | 23401 | _x_x_mozilla_page_load 23:30:41 INFO - PROCESS | 23401 | _x_x_mozilla_page_load_details 23:30:41 INFO - PROCESS | 23401 | |i|pagename|runs| 23:30:41 INFO - PROCESS | 23401 | |0;Richards;169.43409013893594 23:30:41 INFO - PROCESS | 23401 | |1;DeltaBlue;190.43991620643686 23:30:41 INFO - PROCESS | 23401 | |2;Encrypt;279.79854504756577 23:30:41 INFO - PROCESS | 23401 | |3;Decrypt;5186.5284974093265 23:30:41 INFO - PROCESS | 23401 | |4;RayTrace;1097.694840834248 23:30:41 INFO - PROCESS | 23401 | |5;Earley;788.1889763779527 23:30:41 INFO - PROCESS | 23401 | |6;Boyer;12537.5 23:30:41 INFO - PROCESS | 23401 | |7;RegExp;42583.333333333336 23:30:41 INFO - PROCESS | 23401 | |8;Splay;552.4282560706401 23:30:41 INFO - PROCESS | 23401 | |9;NavierStokes;4830.917874396136 23:30:41 INFO - PROCESS | 23401 | __end_tp_report 23:30:41 INFO - PROCESS | 23401 | __startTimestamp1452756641125__endTimestamp 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | ------- Summary: start ------- 23:30:41 INFO - PROCESS | 23401 | Number of tests: 10 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#0] Richards Cycles:1 Average:169.43 Median:169.43 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 169.4 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#1] DeltaBlue Cycles:1 Average:190.44 Median:190.44 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 190.4 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 279.8 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 5186.5 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#4] RayTrace Cycles:1 Average:1097.69 Median:1097.69 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 1097.7 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#5] Earley Cycles:1 Average:788.19 Median:788.19 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 788.2 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 12537.5 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#7] RegExp Cycles:1 Average:42583.33 Median:42583.33 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 42583.3 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#8] Splay Cycles:1 Average:552.43 Median:552.43 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 552.4 23:30:41 INFO - PROCESS | 23401 | 23:30:41 INFO - PROCESS | 23401 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:30:41 INFO - PROCESS | 23401 | Values: 4830.9 23:30:41 INFO - PROCESS | 23401 | -------- Summary: end -------- 23:30:41 INFO - PROCESS | 23401 | 23:30:42 INFO - TEST-INFO | 23401: exit 0 23:30:42 INFO - TEST-OK | v8_7 | took 40270ms 23:30:42 INFO - SUITE-END | took 1211s 23:30:42 INFO - Completed test suite (00:20:11) 23:30:42 INFO - Working with test: dromaeo_css 23:30:42 INFO - Generating results file: dromaeo_css 23:30:42 INFO - Working with test: kraken 23:30:42 INFO - Generating results file: kraken 23:30:42 INFO - javascript benchmark 23:30:42 INFO - Working with test: v8_7 23:30:42 INFO - Generating results file: v8_7 23:30:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:30:42 INFO - process_Request line: dromaeo_css 6720.23 graph.html#tests=[[72,201,35]] 23:30:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:42 INFO - process_Request line: kraken 1501.40 graph.html#tests=[[232,201,35]] 23:30:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:30:42 INFO - process_Request line: v8_7 20137.46 graph.html#tests=[[230,201,35]] 23:30:42 INFO - RETURN: dromaeo_css: 6720.23 23:30:42 INFO - RETURN: kraken: 1501.40 23:30:42 INFO - RETURN: v8_7: 20137.46 23:30:42 INFO - javascript benchmark 23:30:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3088.474959256926, 3091.0881290019443, 3118.3763247350535, 3130.029690795852, 3160.9051728448153, 5079.56823669988, 5097.3373461450055, 5107.719075450848, 5143.408508021578, 5149.047426226141, 5111.872203194913, 5195.688258704471, 5198.974005129979, 5201.687898726079, 5207.3490813648295, 4646.907061858769, 4661.953380466186, 4678.695884767496, 4730.432348118214, 4738.170820106485, 4811.615070794345, 4816.229403295473, 4830.0, 4831.106245344622, 4870.9269360959615, 4613.469451013143, 4681.74250416227, 4723.976380118112, 4768.499307572724, 4800.927986080212, 4724.622030237572, 4724.811007559693, 4728.787204575802, 4740.597049250783, 4763.3807605011125, 4687.390639216914, 4714.882127946795, 4722.079194557063, 4727.125481785846, 4735.573798358164, 4895.853124406238, 4968.3292755477905, 5059.2916991621205, 5136.126858434075, 5155.072087024371, 5517.5585953123655, 5534.08687566551, 5536.307961504812, 5549.139883318092, 5552.666839989613, 5480.095784195603, 5564.582656300794, 5568.220449137124, 5575.080111781551, 5576.052071147915, 5103.2855400244, 5156.1750119981, 5168.250603662448, 5175.611829112831, 5189.844304670828, 5681.488666020078, 5683.204351390808, 5684.6589204647025, 5705.5435565154685, 5706.001449746278, 5359.356877174764, 5492.752826122754, 5495.890082198333, 5505.146702261156, 5511.118221084607, 5437.673739575559, 5553.333599967949, 5614.214010038598, 5614.747336369873, 5674.290713660793, 5429.755660995264, 5432.538234250054, 5433.402325744165, 5443.129099344086, 5457.372402173722, 5383.111786555253, 5423.457654234545, 5433.483819037185, 5450.8909821803345, 5479.0959491683425, 4264.744115353026, 4309.332053531708, 4312.935305970413, 4338.978305108518, 4373.606375426227, 3791.829367678461, 3792.962070379316, 3795.658390744791, 3827.6746476549247, 3828.349180639298, 4990.600751939909, 5094.0, 5126.0, 5138.691678499302, 5186.40356359016, 5468.125099983983, 5526.696031718294, 5529.142982837667, 5533.170024496358, 5551.9722401387735, 5100.464451232567, 5149.639525233272, 5171.974140129275, 5172.482751724798, 5172.533983966494, 4676.088162808288, 4728.38530990969, 4729.935764452971, 4743.0988112258565, 4770.332153498513, 5590.692511911884, 5756.050251708505, 5809.9419005809405, 5811.418858114239, 5866.648001119861, 5504.119340905436, 5520.751566179451, 5524.447555244444, 5524.861878453071, 5533.861653458695, 5694.402087780889, 5713.8285851424525, 5728.627639203439, 5738.799142030009, 5772.595918285848, 5469.535089517435, 5477.1510415885605, 5479.0685583451705, 5493.121100623881, 5539.916901246565, 5378.058839703114, 5433.9184912225555, 5441.483059109379, 5473.945260547343, 5476.315460567429, 5193.37679478465, 5274.973625132004, 5299.655522391032, 5327.09439395296, 5384.946150538602, 5509.173623956439, 5513.641613295123, 5514.393416724077, 5516.668999860021, 5523.6685798852195, 5393.865153371197, 5411.107167317348, 5416.079266524779, 5418.972905135449, 5456.727163641723, 5403.5136837684795, 5425.83722488326, 5430.456954304538, 5484.122540393678, 5511.559075274049, 5411.567074633941, 5413.864653383697, 5419.945800541944, 5434.864128396822, 5444.428335024923], "unit": "score", "name": "dojo.html", "value": 5107.028840595304}, {"lowerIsBetter": false, "replicates": [538.9326334208224, 542.4494138449475, 556.9693666848322, 576.5733357315588, 580.1500801326057, 28445.573316400245, 28887.566686499693, 36220.0, 36376.45435318466, 36381.0, 38201.23597528048, 38260.0, 38444.42333365002, 38561.22877542455, 38571.80714096432, 8596.097409771994, 8744.213020828125, 8779.34154938379, 8810.471371717686, 8824.426412283181, 8579.571021448934, 8662.393632445732, 8679.349048821332, 8712.172343627377, 8736.082711315285, 8725.825483490325, 8779.0, 8809.251213646849, 8812.515311657857, 8824.823503529926, 8664.436811607256, 8753.212210901049, 8756.299496040301, 8756.518391488466, 8764.517951512697, 8601.655933762642, 8774.605142768527, 8779.604917778715, 8781.07798681142, 8786.384953053288, 38446.0, 38839.22321553553, 38881.0, 38909.22181556353, 38944.805275973726, 3221.4201443740117, 3227.935441291161, 3423.0, 3540.522029526007, 3608.4948107265004, 26333.868330658417, 26461.0, 26607.206243344557, 27512.724872751216, 27644.86177569099, 3236.401265765841, 3241.6434192238835, 3271.460209065501, 3297.4559197732347, 3377.4427219508752, 265104.0, 265215.0, 266111.0, 267633.0, 268156.0, 52765.0, 53774.46225537773, 59720.92372148329, 60355.0, 61265.69367153136, 55765.442345576834, 55814.16278755822, 55870.0, 56074.71962640161, 56137.438625614035, 15337.693246135015, 15503.0, 15531.378744850079, 15537.611559711098, 15551.611209719847, 10749.892501075046, 11042.503087361089, 11048.116150707923, 11076.501557429774, 11292.209545331747, 19340.226390944204, 19482.0, 19551.31570395058, 19552.706709399372, 19582.216711331672, 7942.126366099725, 8125.878111828328, 8189.836203275901, 8234.505929644241, 8258.545779982038, 928.5125309212717, 935.2284365398573, 961.077365728894, 1028.1928685981468, 1068.1348108032364, 27908.302292442444, 28055.57916631252, 28145.859270703517, 28249.293767655563, 28311.0, 1021.6475316015963, 1052.936823790575, 1063.872335319751, 1071.052118874786, 1071.566015763617, 15737.213139342986, 16247.0, 16293.59266018359, 16388.180590970405, 16563.91718041426, 391761.0, 397042.0, 399148.0, 401914.0, 402803.0, 54092.0, 54532.0, 54591.0, 54611.726941365036, 54770.0, 1338.2505796753849, 1348.1237195822794, 1364.304204855511, 1370.095736813718, 1374.8556401577691, 28136.577951331157, 28223.294417639725, 29042.0, 29363.85318073396, 29519.85240073786, 44290.11419771651, 44633.55366446294, 44675.329870051326, 44689.77655111704, 44725.32912006388, 297405.0, 299223.0, 299584.0, 300096.0, 300814.0, 27562.862185688944, 28113.71886281193, 30966.22584435407, 31643.20891977719, 31751.364972699954, 35772.64227357797, 36617.63382366249, 38762.224755505296, 38924.41613375858, 39253.60746392499, 33310.66689333173, 37583.2483350326, 38035.42946855855, 38334.80832595819, 38614.613853861105, 32611.836940816094, 35144.47283290804, 35419.645803541636, 36430.0, 36455.0, 32125.357492849544, 32378.0, 32707.509387359685, 33287.83356083204, 33313.500297496044, 29143.85428072846, 30094.09717708472, 31421.0, 32587.185320366232, 32746.672533274363, 31262.0, 31545.8422707885, 31654.841725791222, 31698.207544811565, 32190.678093219703], "unit": "score", "name": "ext.html", "value": 18260.10907420533}, {"lowerIsBetter": false, "replicates": [355.63369729178953, 355.89494619207346, 357.67987651052306, 358.15475477872235, 359.15060881016393, 13555.25446100464, 14067.296635168252, 15581.532554023383, 16246.187690615467, 17403.738943915836, 14937.253137343143, 15015.249237538133, 16000.439984600542, 16001.599960001005, 16023.359065637389, 4942.827001054964, 5324.760385782649, 5327.121025030885, 5329.493698098694, 5330.200469929503, 3967.543732470774, 4086.7956602169775, 5213.035588416136, 5780.71096445176, 6005.459508644221, 5710.086386178213, 5899.941000590004, 5909.290885093773, 5943.762249510036, 5954.70226488676, 5927.170196172539, 5970.611910225822, 5983.910241346383, 5987.042073268278, 5994.2806863176265, 5095.464976177522, 5192.948070519285, 5215.295935048758, 5247.86880327991, 5257.580453277632, 19273.614527709367, 19453.9027304864, 19495.707564386546, 19910.303139390053, 19956.70064949027, 2067.3281183615236, 2110.3457928042203, 2209.679596458521, 2285.645724912641, 2459.913903013386, 12555.560555380518, 12620.621381358482, 12860.678483037906, 12891.742165156738, 12920.095593308472, 1804.6751584714746, 1821.4171465131162, 1882.2565086790778, 1903.790583035865, 1905.7998910114516, 51485.74257128728, 52055.47944520544, 52681.20978185292, 53309.0, 53528.73235633836, 9250.028746981605, 9395.671151509801, 9616.0, 9625.181859541877, 9685.37045092081, 12726.300053497147, 12788.93605531985, 12804.871951280367, 12807.438512297578, 12809.743805123846, 6881.13985751781, 7036.261192574808, 7051.823704407431, 7114.07517022794, 7121.71513139479, 6676.49926255523, 6685.498587605949, 6777.322267773282, 6781.321867813179, 6829.282925292773, 4153.54311025787, 4261.360795880642, 4345.34819777036, 4368.497622773421, 4389.100234451929, 1726.0851748573277, 1756.6223261998732, 1793.6323053773945, 1812.637472505504, 1829.1128802530761, 461.3932678527725, 837.1252041616525, 905.2441211588398, 970.3935040599625, 971.1842052675645, 9593.28050396223, 10196.949015254877, 10519.42143182117, 10669.73325666849, 11114.388708621103, 441.0495382450824, 447.21960179487, 450.74758135444256, 453.42641558428613, 466.9719816811002, 9199.862002069975, 9817.165540928958, 9826.16477599412, 9843.114119729116, 9928.35465694742, 485310.0, 488567.0, 496491.0, 514549.0, 556425.0, 71542.64228678824, 72206.0, 72829.0, 73906.0, 74185.0, 1124.1456493065166, 1150.7525881935424, 1158.1834806461593, 1158.9594364197212, 1167.7489339791985, 14029.298535073409, 14156.063573702988, 15128.425893208061, 15182.848171518584, 15286.464973725866, 29587.704122959356, 29887.0, 30145.24636884008, 30699.693003069682, 31932.0, 36251.63748362483, 36380.0, 36909.26181476302, 36916.81541592275, 37555.2488950214, 3028.424599326121, 3029.954550681786, 5554.472325129106, 7040.295970402919, 7283.069986453488, 10110.828126865339, 11002.0, 11257.662270131908, 11365.0, 11391.259568128045, 9032.729018129467, 9140.817183656156, 9481.09929556691, 9583.377080489747, 9682.515874206121, 6972.616506092214, 8918.152775486318, 9551.283653726137, 9579.856302155613, 9672.0, 7966.0, 9125.133112354315, 9246.907530924605, 9286.860697089684, 9337.393069450736, 7115.501914865909, 7238.493305468777, 7290.927090729025, 7291.744788932362, 7300.12398512182, 7704.8459030820195, 9498.430094194371, 9585.712428627152, 9666.709998700051, 9769.169620582046], "unit": "score", "name": "jquery.html", "value": 7689.407113395298}, {"lowerIsBetter": false, "replicates": [1306.7909134538477, 1483.4511230844587, 1492.5298530962743, 1634.427950217424, 1795.6229191869706, 7212.170600380958, 7389.187189409161, 7738.9226107738905, 7888.290053895148, 7898.921010789904, 7944.602769861513, 7944.801379965504, 8046.476978996361, 8057.838843223147, 8060.838783224332, 1965.272849045855, 2007.6988451732211, 2302.827287953406, 2323.4307594639336, 2324.476992676651, 2317.918872839451, 2362.0905951208824, 2363.1374548289837, 2363.361892289081, 2364.6925899633025, 2250.3923940536047, 2267.2178098555974, 2298.2186056740707, 2300.723913130427, 2309.872956987365, 2264.62633665445, 2276.112316196685, 2281.840271181018, 2314.259436980167, 2321.2455951815728, 2265.830062745301, 2277.9976810203457, 2286.416963674269, 2288.599495088353, 2306.2965795432387, 8029.919700802976, 8072.475289106248, 8072.515649061075, 8073.394495412867, 8148.633311500997, 4874.122657921573, 4990.65065445419, 5023.748812559394, 5025.8240961566535, 5027.698338099689, 3009.623797025372, 3051.61854768154, 3066.110827859918, 3083.367909578531, 3100.2869340051916, 930.9627614895396, 931.2643012020563, 950.4534892436807, 964.7057647417535, 965.1603105298365, 11574.189806713533, 11611.0, 11612.767744645143, 11616.419179041015, 11631.418429078596, 4444.733316000986, 4486.66350023743, 4555.931661025087, 4556.430446194226, 4568.063546972862, 9777.41335519871, 9781.559829807677, 9792.608295668237, 9800.166985806143, 9806.117449429443, 4921.163402221631, 4925.187344088257, 4932.482089380564, 4934.777934992934, 4936.284238785428, 4395.120975804852, 4414.779261036935, 4441.444819397575, 4444.8444304449185, 4456.554344565582, 3510.297940411877, 3546.8758593449106, 3668.3580373434543, 3707.758995665327, 3719.814009299524, 1145.9484323205477, 1185.531714972581, 1191.2257032928667, 1194.856617205941, 1200.0759415250209, 1039.4698703661036, 1060.3637817309707, 1060.8939106089483, 1162.7151347919814, 1282.8332316798942, 7016.403605693471, 7020.262872398427, 7065.82335441618, 7073.575585464889, 7077.150741911004, 1088.8693356797235, 1095.8301463273206, 1096.1997741648481, 1098.2970898624726, 1100.1913593508764, 5466.125419932791, 5518.972405138029, 5545.750441230154, 5577.024020796344, 5595.608307418523, 9306.162445379949, 9619.51902404877, 9702.563384647709, 9768.218542516724, 10156.746081348025, 9458.90541094594, 9499.572519236652, 9645.131938125602, 9655.565499552396, 9656.613735450503, 7583.27958843909, 7592.582407967615, 7616.200298968639, 7642.7325043623205, 7650.19672934345, 7433.628318584158, 7451.2921272479025, 7483.850322993619, 7497.0, 7521.7743467696055, 8770.605322760364, 8841.336899732418, 8983.685571004984, 9140.725778226664, 9155.038720934472, 9159.900811902615, 9294.25645948336, 9387.061293870558, 9399.765005874908, 9412.576434060347, 7312.634368281671, 7426.925730742623, 7429.702811887464, 7438.367738742051, 7445.4043676506835, 6947.861042779015, 7119.786406407816, 7489.70041198346, 7691.692332306869, 7692.92307076922, 7227.843989705835, 7323.0, 7337.779866604011, 7408.0, 7453.068366454193, 7027.61348125858, 7170.96414517924, 7194.4244460442, 7207.819804504719, 7410.258974102547, 6772.695228714621, 6805.251422343637, 6855.245922948571, 6896.069030680995, 6921.342472465108, 6181.783637572664, 6404.615723056445, 6406.0, 6406.135171751754, 6411.3909178627955, 6453.483721302378, 6490.870182596416, 6521.445677117498, 6535.215774107138, 6537.901931471127], "unit": "score", "name": "mootools.html", "value": 4570.891065274096}, {"lowerIsBetter": false, "replicates": [335.66936567481036, 336.3777012526826, 341.97948123112616, 345.09412791422517, 351.61322545200267, 5663.461971112738, 5787.392323806003, 5861.941380586198, 5879.735411906464, 5899.734511946962, 5598.076317407633, 5746.913796293059, 5762.711864406773, 5784.913226301598, 5794.420557944203, 4542.0, 4544.84093056743, 4545.431821022372, 4554.70394424363, 4558.749268790215, 4323.589259020404, 4394.780260986954, 4420.955790442086, 4513.864584062483, 4548.204064288753, 4488.057507923324, 4498.055408364231, 4503.256962601167, 4521.050579378318, 4528.637708983273, 4494.887627809315, 4497.887552811173, 4500.392447019643, 4503.774811259424, 4512.187806194884, 3964.8017599120217, 3964.8215830287704, 3965.5836137205465, 3978.1645854370618, 3980.144268982154, 5389.622726409153, 5478.616496845182, 5496.560275178016, 5525.475079867447, 5567.749451274703, 5116.590672746209, 5148.768305426265, 5159.251908473288, 5160.14857548504, 5162.277281180638, 5835.445632664932, 6118.204633397674, 6151.138840562325, 6161.599496032743, 6163.722632481549, 4217.8523751668545, 4227.661787057028, 4324.8486302979245, 4338.045629961403, 4342.305231162999, 6334.87330253397, 6395.584287021329, 6400.487960963112, 6420.036994450823, 6428.774992875227, 4412.602865742035, 4427.6236519896165, 4429.557044295545, 4433.711808732486, 4441.156180325728, 4333.978330108329, 4468.553144685506, 4482.618977386958, 4483.215437298525, 4508.030773383738, 5161.354830646169, 5171.663841850268, 5171.922421163686, 5179.2749015137915, 5179.326687530673, 6187.288461826857, 6191.071339299141, 6192.690365481708, 6193.473554747897, 6194.287656919422, 1549.4809238905093, 1584.1128967777852, 1585.5005673212902, 1585.5322679809483, 1585.9207039647972, 1063.8244689626124, 1064.6539874540651, 1067.3595842494597, 1074.049466222399, 1091.2361347057092, 5875.148103525051, 5875.20684707559, 5880.617759845596, 5881.147233651182, 5886.23478947734, 6353.078803573549, 6359.650219237987, 6361.840953976095, 6363.5863668861375, 6366.6180029198395, 5846.883062338729, 5863.149843272787, 5868.061110222344, 5871.442212989759, 5871.882562348729, 3297.3405318936307, 3419.9658003420145, 3424.195314101184, 3424.6061702904485, 3425.5889293284467, 6591.901121483182, 6599.307072757388, 6610.2398224204835, 6610.570312929741, 6619.86760264792, 6478.060681201294, 6480.708368123445, 6516.57642253252, 6521.9673901630185, 6528.738850446024, 6457.096006559085, 6580.539362244597, 6690.598564086073, 6705.564138330993, 6707.1616047994, 6131.754729810757, 6301.96849015752, 6398.424141827258, 6420.582662126947, 6430.713857228479, 6178.0, 6221.377862213742, 6307.716152773044, 6317.147185130132, 6317.747290108344, 6640.468762499085, 6653.767118150841, 6678.632675202911, 6679.0, 6682.465402767864, 4279.636230920407, 4406.140802543473, 4485.192665320274, 4493.460784705856, 4494.707843990261, 6270.435660790551, 6312.14786003902, 6363.872722545616, 6366.331535188739, 6372.617642941438, 6163.1679723238585, 6174.166487524307, 6189.381061893775, 6191.81424557264, 6192.845178870564, 6032.0, 6162.07568864656, 6166.105914642262, 6167.537434692326, 6171.444569988723, 6117.357677443804, 6136.846578835565, 6140.754369825157, 6144.446999770043, 6148.44663980244, 6260.280067792262, 6276.968615156895, 6285.057241413824, 6285.277193122849, 6287.30839607652, 5925.01511993487, 6087.908681369694, 6121.0818377241985, 6133.938660613337, 6144.508439324933], "unit": "score", "name": "prototype.html", "value": 4677.807191191421}, {"lowerIsBetter": false, "replicates": [730.0254160695468, 736.6574542837579, 745.9477836551443, 773.2422226218304, 842.410312781053, 13414.530491432803, 13559.254241016752, 13560.118592291494, 13565.66085847853, 13598.116122452033, 11664.183507154503, 11753.177277590572, 11791.351475668835, 11794.823077653842, 11813.881861181386, 665.3579295979379, 678.9524733268673, 794.2097612875168, 803.3934379543437, 808.8463191993532, 789.6288744290174, 794.0828343263511, 795.1571334385541, 795.5107608820563, 795.8090058386003, 691.1498856406623, 844.1853611265128, 846.7502086884384, 846.9618867150962, 847.0851480401183, 694.694334492824, 820.6471217376526, 837.8910741603553, 839.0895877972407, 842.9747107586783, 618.6350053468475, 623.2085251730277, 623.2552100240215, 623.4731651754261, 623.9001759718469, 12102.455389507493, 12138.271703697807, 12158.51365945361, 12165.330906800122, 12194.0, 12221.266723996589, 12607.621771346874, 12865.935670321682, 12956.287404192766, 13021.088523803337, 10079.143272821819, 10114.949425252827, 10284.845727314096, 10851.240413171081, 10859.619913303075, 3552.6980206682465, 3646.3436581415335, 3676.0, 3721.702263818915, 3728.3102626014274, 49137.26294105591, 49530.25704614434, 49584.256236156485, 49858.0, 50257.24614130791, 9260.953695231481, 9576.329656924088, 9644.228461723045, 9689.951550242204, 9767.218622510181, 17072.061036643103, 17078.914605426893, 17086.40197593078, 17095.572610684583, 17107.657846842994, 7196.46026548011, 7221.89167162493, 7250.564966101945, 7516.24837516255, 7604.8479030420185, 4177.958220417757, 4230.70385073042, 4270.274053410928, 4275.87172384829, 4295.162443323585, 3105.052958847528, 3114.408262430131, 3116.875324986975, 3122.8438578071004, 3129.4992801151707, 559.046825163096, 575.9654420734769, 580.8025271407741, 596.9761209551656, 599.6641880546907, 474.91688954432834, 486.90505351456835, 552.8473133516662, 577.3216470646973, 598.3328588623654, 7387.519811212254, 7390.002349682832, 7483.326500614862, 7688.769336919901, 7702.383809295243, 541.5613353183934, 556.4463358957782, 556.4991507643073, 573.9024365857814, 654.9377809108128, 3418.1454636340914, 3493.982530087333, 3523.119220194951, 3623.61951995042, 3675.0996005978172, 48829.0, 49699.75150124299, 50074.749626251636, 51483.227751583756, 52070.21894671583, 47771.28343074787, 49214.0, 49389.75305123451, 49600.0, 49674.75162624164, 43526.34710479345, 43792.343114853305, 43913.34129988053, 44688.776556117664, 45229.0, 7286.307800758919, 7298.160711518243, 7902.802429939297, 8045.839083218186, 8266.338692904674, 32294.83852580722, 32382.514262286557, 32609.0, 33093.50359744654, 34938.65061349354, 43061.138777223656, 43336.783316083216, 44081.11837763291, 44156.11687766291, 44814.55185448104, 10217.386956782617, 10525.36847789135, 10619.044286013986, 10679.19906007037, 11032.393218372745, 11472.541098355972, 11609.941950290533, 11637.941810290895, 11695.707607309545, 11928.76142477163, 10173.0, 10558.788824223318, 10680.0, 10756.784864302826, 10877.728056798644, 10981.560737570728, 11059.281146725438, 11099.27854689475, 11171.0, 11178.385188814367, 10323.380597164194, 10775.191860610643, 11128.332300062022, 11363.147763917905, 11482.885171148182, 9224.677136300197, 9253.953730231306, 9389.765255868659, 9690.75773105678, 9902.257330700082, 7710.8843367350655, 8438.493690378597, 8447.281981031681, 8667.696630617898, 8680.652773888974], "unit": "score", "name": "yui.html", "value": 6007.005824412533}], "name": "dromaeo_css", "value": 6720.22650956679}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 112.0, 112.0, 99.0, 109.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 147.0, 161.0, 128.0, 155.0, 149.0, 124.0, 167.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 165.0, 162.0, 162.0, 162.0, 163.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 97.0, 97.0, 74.0, 76.0, 72.0, 112.0, 97.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 144.0, 96.0, 97.0, 96.0, 140.0, 97.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 56.0, 54.0, 56.0, 57.0, 65.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 84.0, 89.0, 91.0, 83.0, 83.0, 85.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [113.0, 116.0, 114.0, 122.0, 119.0, 129.0, 123.0, 123.0, 116.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.8}, {"lowerIsBetter": true, "replicates": [156.0, 140.0, 149.0, 153.0, 154.0, 144.0, 149.0, 149.0, 147.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 67.0, 68.0, 67.0, 65.0, 66.0, 67.0, 65.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1501.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.43409013893594], "unit": "score", "name": "Richards", "value": 208.35240399999998}, {"lowerIsBetter": false, "replicates": [190.43991620643686], "unit": "score", "name": "DeltaBlue", "value": 347.1856180000001}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1097.694840834248], "unit": "score", "name": "RayTrace", "value": 674.1299790000003}, {"lowerIsBetter": false, "replicates": [788.1889763779527], "unit": "score", "name": "Earley", "value": 845.5624475524476}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [42583.333333333336], "unit": "score", "name": "RegExp", "value": 21.392994129158513}, {"lowerIsBetter": false, "replicates": [552.4282560706401], "unit": "score", "name": "Splay", "value": 147.51417782217783}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20137.455704169653}]} 23:30:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20137.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1501.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6720.23"}}} 23:30:42 INFO - Return code: 0 23:30:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:30:42 INFO - # TBPL SUCCESS # 23:30:42 INFO - Running post-action listener: _resource_record_post_action 23:30:42 INFO - Running post-run listener: _resource_record_post_run 23:30:43 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 317517824; Read time: 156; Write time: 210168 23:30:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13955072; Read time: 0; Write time: 2896 23:30:43 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 303562752; Read time: 156; Write time: 207272 23:30:43 INFO - Running post-run listener: _upload_blobber_files 23:30:43 INFO - Blob upload gear active. 23:30:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:30:43 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 23:30:43 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:30:43 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:30:43 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:44 INFO - (blobuploader) - INFO - Done attempting. 23:30:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:45 INFO - (blobuploader) - INFO - Done attempting. 23:30:45 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:45 INFO - Return code: 0 23:30:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:30:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b5d70bb74f6271968ab9d55d41a001f8e95b3dc3f0c383db1f29c9194c7174492b95b0a0ddf4d6f13f6140d1e23cc3ebf213c44e875afad02a350846218ca512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9e016602368e50619729e4f13e7fafd3837f55327c863bfd8f8e06e2e8d19620b9cd35cae0df21aa57efea4d353939e4b06f7173669ea3d80270b66eab5b030c"} 23:30:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:30:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:30:45 INFO - Contents: 23:30:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b5d70bb74f6271968ab9d55d41a001f8e95b3dc3f0c383db1f29c9194c7174492b95b0a0ddf4d6f13f6140d1e23cc3ebf213c44e875afad02a350846218ca512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9e016602368e50619729e4f13e7fafd3837f55327c863bfd8f8e06e2e8d19620b9cd35cae0df21aa57efea4d353939e4b06f7173669ea3d80270b66eab5b030c"} 23:30:45 INFO - Copying logs to upload dir... 23:30:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1279.700460 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-13 23:30:45.217857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 23:30:45.221582) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b5d70bb74f6271968ab9d55d41a001f8e95b3dc3f0c383db1f29c9194c7174492b95b0a0ddf4d6f13f6140d1e23cc3ebf213c44e875afad02a350846218ca512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9e016602368e50619729e4f13e7fafd3837f55327c863bfd8f8e06e2e8d19620b9cd35cae0df21aa57efea4d353939e4b06f7173669ea3d80270b66eab5b030c"} build_url:https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/edHWs4EfRLieLqvfblQ7-w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/b5d70bb74f6271968ab9d55d41a001f8e95b3dc3f0c383db1f29c9194c7174492b95b0a0ddf4d6f13f6140d1e23cc3ebf213c44e875afad02a350846218ca512", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/9e016602368e50619729e4f13e7fafd3837f55327c863bfd8f8e06e2e8d19620b9cd35cae0df21aa57efea4d353939e4b06f7173669ea3d80270b66eab5b030c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 23:30:45.246756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:30:45.247169) ========= 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=41bf3e9aed84707956354da8000001c5-1452755255.65860-283008983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 23:30:45.330193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 23:30:45.330546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 23:30:45.330871) ========= ========= Total master_lag: 0.23 =========